May 15 23:30:06.887912 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 15 23:30:06.887935 kernel: Linux version 6.6.90-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Thu May 15 22:10:19 -00 2025 May 15 23:30:06.887945 kernel: KASLR enabled May 15 23:30:06.887951 kernel: efi: EFI v2.7 by EDK II May 15 23:30:06.887956 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbae018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40218 May 15 23:30:06.887962 kernel: random: crng init done May 15 23:30:06.887969 kernel: secureboot: Secure boot disabled May 15 23:30:06.887975 kernel: ACPI: Early table checksum verification disabled May 15 23:30:06.887981 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) May 15 23:30:06.887988 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) May 15 23:30:06.887994 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888000 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888006 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888012 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888020 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888027 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888034 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888040 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888046 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 15 23:30:06.888052 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 15 23:30:06.888058 kernel: NUMA: Failed to initialise from firmware May 15 23:30:06.888064 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 15 23:30:06.888070 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] May 15 23:30:06.888077 kernel: Zone ranges: May 15 23:30:06.888083 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 15 23:30:06.888091 kernel: DMA32 empty May 15 23:30:06.888097 kernel: Normal empty May 15 23:30:06.888103 kernel: Movable zone start for each node May 15 23:30:06.888109 kernel: Early memory node ranges May 15 23:30:06.888115 kernel: node 0: [mem 0x0000000040000000-0x00000000d967ffff] May 15 23:30:06.888122 kernel: node 0: [mem 0x00000000d9680000-0x00000000d968ffff] May 15 23:30:06.888128 kernel: node 0: [mem 0x00000000d9690000-0x00000000d976ffff] May 15 23:30:06.888134 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] May 15 23:30:06.888140 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] May 15 23:30:06.888146 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] May 15 23:30:06.888152 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] May 15 23:30:06.888158 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] May 15 23:30:06.888166 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] May 15 23:30:06.888172 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 15 23:30:06.888178 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 15 23:30:06.888187 kernel: psci: probing for conduit method from ACPI. May 15 23:30:06.888194 kernel: psci: PSCIv1.1 detected in firmware. May 15 23:30:06.888201 kernel: psci: Using standard PSCI v0.2 function IDs May 15 23:30:06.888209 kernel: psci: Trusted OS migration not required May 15 23:30:06.888215 kernel: psci: SMC Calling Convention v1.1 May 15 23:30:06.888222 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 15 23:30:06.888229 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 May 15 23:30:06.888235 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 May 15 23:30:06.888242 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 15 23:30:06.888248 kernel: Detected PIPT I-cache on CPU0 May 15 23:30:06.888255 kernel: CPU features: detected: GIC system register CPU interface May 15 23:30:06.888261 kernel: CPU features: detected: Hardware dirty bit management May 15 23:30:06.888268 kernel: CPU features: detected: Spectre-v4 May 15 23:30:06.888276 kernel: CPU features: detected: Spectre-BHB May 15 23:30:06.888282 kernel: CPU features: kernel page table isolation forced ON by KASLR May 15 23:30:06.888289 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 15 23:30:06.888295 kernel: CPU features: detected: ARM erratum 1418040 May 15 23:30:06.888302 kernel: CPU features: detected: SSBS not fully self-synchronizing May 15 23:30:06.888308 kernel: alternatives: applying boot alternatives May 15 23:30:06.888316 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=5842e6d9a9272dc71039ff31db7df13c5a397d9a9917b662574c24d437910f6a May 15 23:30:06.888323 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 15 23:30:06.888329 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 15 23:30:06.888336 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 15 23:30:06.888343 kernel: Fallback order for Node 0: 0 May 15 23:30:06.888351 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 May 15 23:30:06.888357 kernel: Policy zone: DMA May 15 23:30:06.888364 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 15 23:30:06.888370 kernel: software IO TLB: area num 4. May 15 23:30:06.888377 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) May 15 23:30:06.888388 kernel: Memory: 2387348K/2572288K available (10368K kernel code, 2186K rwdata, 8100K rodata, 38464K init, 897K bss, 184940K reserved, 0K cma-reserved) May 15 23:30:06.888398 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 15 23:30:06.888405 kernel: rcu: Preemptible hierarchical RCU implementation. May 15 23:30:06.888412 kernel: rcu: RCU event tracing is enabled. May 15 23:30:06.888419 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 15 23:30:06.888425 kernel: Trampoline variant of Tasks RCU enabled. May 15 23:30:06.888432 kernel: Tracing variant of Tasks RCU enabled. May 15 23:30:06.888441 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 15 23:30:06.888447 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 15 23:30:06.888465 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 15 23:30:06.888472 kernel: GICv3: 256 SPIs implemented May 15 23:30:06.888478 kernel: GICv3: 0 Extended SPIs implemented May 15 23:30:06.888485 kernel: Root IRQ handler: gic_handle_irq May 15 23:30:06.888491 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI May 15 23:30:06.888498 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 15 23:30:06.888505 kernel: ITS [mem 0x08080000-0x0809ffff] May 15 23:30:06.888511 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) May 15 23:30:06.888518 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) May 15 23:30:06.888527 kernel: GICv3: using LPI property table @0x00000000400f0000 May 15 23:30:06.888534 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 May 15 23:30:06.888541 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 15 23:30:06.888547 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 23:30:06.888554 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 15 23:30:06.888560 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 15 23:30:06.888567 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 15 23:30:06.888574 kernel: arm-pv: using stolen time PV May 15 23:30:06.888581 kernel: Console: colour dummy device 80x25 May 15 23:30:06.888587 kernel: ACPI: Core revision 20230628 May 15 23:30:06.888599 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 15 23:30:06.888608 kernel: pid_max: default: 32768 minimum: 301 May 15 23:30:06.888615 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 15 23:30:06.888621 kernel: landlock: Up and running. May 15 23:30:06.888628 kernel: SELinux: Initializing. May 15 23:30:06.888635 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 15 23:30:06.888641 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 15 23:30:06.888648 kernel: ACPI PPTT: PPTT table found, but unable to locate core 3 (3) May 15 23:30:06.888655 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 15 23:30:06.888662 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 15 23:30:06.888671 kernel: rcu: Hierarchical SRCU implementation. May 15 23:30:06.888678 kernel: rcu: Max phase no-delay instances is 400. May 15 23:30:06.888684 kernel: Platform MSI: ITS@0x8080000 domain created May 15 23:30:06.888691 kernel: PCI/MSI: ITS@0x8080000 domain created May 15 23:30:06.888697 kernel: Remapping and enabling EFI services. May 15 23:30:06.888704 kernel: smp: Bringing up secondary CPUs ... May 15 23:30:06.888711 kernel: Detected PIPT I-cache on CPU1 May 15 23:30:06.888717 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 15 23:30:06.888724 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 May 15 23:30:06.888732 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 23:30:06.888739 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 15 23:30:06.888751 kernel: Detected PIPT I-cache on CPU2 May 15 23:30:06.888759 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 15 23:30:06.888766 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 May 15 23:30:06.888774 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 23:30:06.888781 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 15 23:30:06.888788 kernel: Detected PIPT I-cache on CPU3 May 15 23:30:06.888795 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 15 23:30:06.888802 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 May 15 23:30:06.888810 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 23:30:06.888817 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 15 23:30:06.888824 kernel: smp: Brought up 1 node, 4 CPUs May 15 23:30:06.888831 kernel: SMP: Total of 4 processors activated. May 15 23:30:06.888838 kernel: CPU features: detected: 32-bit EL0 Support May 15 23:30:06.888845 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 15 23:30:06.888853 kernel: CPU features: detected: Common not Private translations May 15 23:30:06.888861 kernel: CPU features: detected: CRC32 instructions May 15 23:30:06.888868 kernel: CPU features: detected: Enhanced Virtualization Traps May 15 23:30:06.888875 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 15 23:30:06.888882 kernel: CPU features: detected: LSE atomic instructions May 15 23:30:06.888889 kernel: CPU features: detected: Privileged Access Never May 15 23:30:06.888896 kernel: CPU features: detected: RAS Extension Support May 15 23:30:06.888903 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 15 23:30:06.888910 kernel: CPU: All CPU(s) started at EL1 May 15 23:30:06.888917 kernel: alternatives: applying system-wide alternatives May 15 23:30:06.888926 kernel: devtmpfs: initialized May 15 23:30:06.888934 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 15 23:30:06.888941 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 15 23:30:06.888948 kernel: pinctrl core: initialized pinctrl subsystem May 15 23:30:06.888955 kernel: SMBIOS 3.0.0 present. May 15 23:30:06.888962 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 May 15 23:30:06.888969 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 15 23:30:06.888976 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 15 23:30:06.888983 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 15 23:30:06.888991 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 15 23:30:06.888999 kernel: audit: initializing netlink subsys (disabled) May 15 23:30:06.889006 kernel: audit: type=2000 audit(0.018:1): state=initialized audit_enabled=0 res=1 May 15 23:30:06.889013 kernel: thermal_sys: Registered thermal governor 'step_wise' May 15 23:30:06.889020 kernel: cpuidle: using governor menu May 15 23:30:06.889027 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 15 23:30:06.889034 kernel: ASID allocator initialised with 32768 entries May 15 23:30:06.889042 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 15 23:30:06.889049 kernel: Serial: AMBA PL011 UART driver May 15 23:30:06.889057 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL May 15 23:30:06.889064 kernel: Modules: 0 pages in range for non-PLT usage May 15 23:30:06.889071 kernel: Modules: 509232 pages in range for PLT usage May 15 23:30:06.889078 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 15 23:30:06.889086 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 15 23:30:06.889093 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 15 23:30:06.889100 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 15 23:30:06.889107 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 15 23:30:06.889114 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 15 23:30:06.889122 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 15 23:30:06.889130 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 15 23:30:06.889137 kernel: ACPI: Added _OSI(Module Device) May 15 23:30:06.889144 kernel: ACPI: Added _OSI(Processor Device) May 15 23:30:06.889151 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 15 23:30:06.889159 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 15 23:30:06.889166 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 15 23:30:06.889173 kernel: ACPI: Interpreter enabled May 15 23:30:06.889180 kernel: ACPI: Using GIC for interrupt routing May 15 23:30:06.889186 kernel: ACPI: MCFG table detected, 1 entries May 15 23:30:06.889195 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 15 23:30:06.889202 kernel: printk: console [ttyAMA0] enabled May 15 23:30:06.889209 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 15 23:30:06.891789 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 15 23:30:06.891878 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 15 23:30:06.891944 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 15 23:30:06.892007 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 15 23:30:06.892076 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 15 23:30:06.892085 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 15 23:30:06.892092 kernel: PCI host bridge to bus 0000:00 May 15 23:30:06.892161 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 15 23:30:06.892220 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 15 23:30:06.892278 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 15 23:30:06.892335 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 15 23:30:06.892416 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 May 15 23:30:06.892504 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 May 15 23:30:06.892572 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] May 15 23:30:06.892647 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] May 15 23:30:06.892720 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] May 15 23:30:06.892792 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] May 15 23:30:06.892871 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] May 15 23:30:06.892941 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] May 15 23:30:06.893026 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 15 23:30:06.893088 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 15 23:30:06.893157 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 15 23:30:06.893166 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 15 23:30:06.893173 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 15 23:30:06.893181 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 15 23:30:06.893191 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 15 23:30:06.893198 kernel: iommu: Default domain type: Translated May 15 23:30:06.893205 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 15 23:30:06.893212 kernel: efivars: Registered efivars operations May 15 23:30:06.893219 kernel: vgaarb: loaded May 15 23:30:06.893226 kernel: clocksource: Switched to clocksource arch_sys_counter May 15 23:30:06.893233 kernel: VFS: Disk quotas dquot_6.6.0 May 15 23:30:06.893240 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 15 23:30:06.893247 kernel: pnp: PnP ACPI init May 15 23:30:06.893326 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 15 23:30:06.893336 kernel: pnp: PnP ACPI: found 1 devices May 15 23:30:06.893343 kernel: NET: Registered PF_INET protocol family May 15 23:30:06.893350 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 15 23:30:06.893357 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 15 23:30:06.893364 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 15 23:30:06.893371 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 15 23:30:06.893378 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 15 23:30:06.893388 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 15 23:30:06.893395 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 15 23:30:06.893402 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 15 23:30:06.893409 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 15 23:30:06.893416 kernel: PCI: CLS 0 bytes, default 64 May 15 23:30:06.893423 kernel: kvm [1]: HYP mode not available May 15 23:30:06.893430 kernel: Initialise system trusted keyrings May 15 23:30:06.893437 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 15 23:30:06.893444 kernel: Key type asymmetric registered May 15 23:30:06.893451 kernel: Asymmetric key parser 'x509' registered May 15 23:30:06.893468 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 15 23:30:06.893475 kernel: io scheduler mq-deadline registered May 15 23:30:06.893482 kernel: io scheduler kyber registered May 15 23:30:06.893490 kernel: io scheduler bfq registered May 15 23:30:06.893497 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 15 23:30:06.893504 kernel: ACPI: button: Power Button [PWRB] May 15 23:30:06.893511 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 15 23:30:06.893581 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 15 23:30:06.893595 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 15 23:30:06.893606 kernel: thunder_xcv, ver 1.0 May 15 23:30:06.893613 kernel: thunder_bgx, ver 1.0 May 15 23:30:06.893620 kernel: nicpf, ver 1.0 May 15 23:30:06.893627 kernel: nicvf, ver 1.0 May 15 23:30:06.893705 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 15 23:30:06.893767 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-15T23:30:06 UTC (1747351806) May 15 23:30:06.893777 kernel: hid: raw HID events driver (C) Jiri Kosina May 15 23:30:06.893784 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available May 15 23:30:06.893793 kernel: watchdog: Delayed init of the lockup detector failed: -19 May 15 23:30:06.893800 kernel: watchdog: Hard watchdog permanently disabled May 15 23:30:06.893807 kernel: NET: Registered PF_INET6 protocol family May 15 23:30:06.893814 kernel: Segment Routing with IPv6 May 15 23:30:06.893821 kernel: In-situ OAM (IOAM) with IPv6 May 15 23:30:06.893828 kernel: NET: Registered PF_PACKET protocol family May 15 23:30:06.893835 kernel: Key type dns_resolver registered May 15 23:30:06.893841 kernel: registered taskstats version 1 May 15 23:30:06.893848 kernel: Loading compiled-in X.509 certificates May 15 23:30:06.893857 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.90-flatcar: 06f4063ae17661ba03d0a772a07398655eacda2e' May 15 23:30:06.893864 kernel: Key type .fscrypt registered May 15 23:30:06.893871 kernel: Key type fscrypt-provisioning registered May 15 23:30:06.893878 kernel: ima: No TPM chip found, activating TPM-bypass! May 15 23:30:06.893885 kernel: ima: Allocated hash algorithm: sha1 May 15 23:30:06.893891 kernel: ima: No architecture policies found May 15 23:30:06.893898 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 15 23:30:06.893905 kernel: clk: Disabling unused clocks May 15 23:30:06.893914 kernel: Freeing unused kernel memory: 38464K May 15 23:30:06.893920 kernel: Run /init as init process May 15 23:30:06.893927 kernel: with arguments: May 15 23:30:06.893934 kernel: /init May 15 23:30:06.893941 kernel: with environment: May 15 23:30:06.893947 kernel: HOME=/ May 15 23:30:06.893955 kernel: TERM=linux May 15 23:30:06.893961 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 15 23:30:06.893969 systemd[1]: Successfully made /usr/ read-only. May 15 23:30:06.893980 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 15 23:30:06.893989 systemd[1]: Detected virtualization kvm. May 15 23:30:06.893996 systemd[1]: Detected architecture arm64. May 15 23:30:06.894003 systemd[1]: Running in initrd. May 15 23:30:06.894010 systemd[1]: No hostname configured, using default hostname. May 15 23:30:06.894018 systemd[1]: Hostname set to . May 15 23:30:06.894025 systemd[1]: Initializing machine ID from VM UUID. May 15 23:30:06.894033 systemd[1]: Queued start job for default target initrd.target. May 15 23:30:06.894042 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 15 23:30:06.894049 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 15 23:30:06.894057 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 15 23:30:06.894065 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 15 23:30:06.894073 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 15 23:30:06.894081 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 15 23:30:06.894092 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 15 23:30:06.894099 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 15 23:30:06.894107 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 15 23:30:06.894115 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 15 23:30:06.894122 systemd[1]: Reached target paths.target - Path Units. May 15 23:30:06.894130 systemd[1]: Reached target slices.target - Slice Units. May 15 23:30:06.894137 systemd[1]: Reached target swap.target - Swaps. May 15 23:30:06.894145 systemd[1]: Reached target timers.target - Timer Units. May 15 23:30:06.894152 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 15 23:30:06.894162 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 15 23:30:06.894169 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 15 23:30:06.894177 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 15 23:30:06.894185 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 15 23:30:06.894192 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 15 23:30:06.894200 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 15 23:30:06.894207 systemd[1]: Reached target sockets.target - Socket Units. May 15 23:30:06.894215 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 15 23:30:06.894224 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 15 23:30:06.894231 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 15 23:30:06.894239 systemd[1]: Starting systemd-fsck-usr.service... May 15 23:30:06.894246 systemd[1]: Starting systemd-journald.service - Journal Service... May 15 23:30:06.894254 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 15 23:30:06.894262 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 15 23:30:06.894269 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 15 23:30:06.894277 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 15 23:30:06.894287 systemd[1]: Finished systemd-fsck-usr.service. May 15 23:30:06.894295 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 15 23:30:06.894303 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 15 23:30:06.894328 systemd-journald[236]: Collecting audit messages is disabled. May 15 23:30:06.894349 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 15 23:30:06.894357 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 15 23:30:06.894365 systemd-journald[236]: Journal started May 15 23:30:06.894385 systemd-journald[236]: Runtime Journal (/run/log/journal/9c994d767b57420fa55f9ccb25039683) is 5.9M, max 47.3M, 41.4M free. May 15 23:30:06.881861 systemd-modules-load[237]: Inserted module 'overlay' May 15 23:30:06.896354 systemd[1]: Started systemd-journald.service - Journal Service. May 15 23:30:06.896374 kernel: Bridge firewalling registered May 15 23:30:06.895774 systemd-modules-load[237]: Inserted module 'br_netfilter' May 15 23:30:06.905818 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 15 23:30:06.906825 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 15 23:30:06.911066 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 15 23:30:06.913680 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 15 23:30:06.919301 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 15 23:30:06.924265 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 15 23:30:06.926421 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 15 23:30:06.927654 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 15 23:30:06.928728 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 15 23:30:06.935010 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 15 23:30:06.938380 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 15 23:30:06.945654 dracut-cmdline[272]: dracut-dracut-053 May 15 23:30:06.948833 dracut-cmdline[272]: 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=5842e6d9a9272dc71039ff31db7df13c5a397d9a9917b662574c24d437910f6a May 15 23:30:06.975003 systemd-resolved[284]: Positive Trust Anchors: May 15 23:30:06.975022 systemd-resolved[284]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 15 23:30:06.975053 systemd-resolved[284]: 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 May 15 23:30:06.979918 systemd-resolved[284]: Defaulting to hostname 'linux'. May 15 23:30:06.980918 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 15 23:30:06.982637 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 15 23:30:07.026484 kernel: SCSI subsystem initialized May 15 23:30:07.030471 kernel: Loading iSCSI transport class v2.0-870. May 15 23:30:07.038485 kernel: iscsi: registered transport (tcp) May 15 23:30:07.052749 kernel: iscsi: registered transport (qla4xxx) May 15 23:30:07.052763 kernel: QLogic iSCSI HBA Driver May 15 23:30:07.094904 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 15 23:30:07.097375 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 15 23:30:07.125478 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 15 23:30:07.125536 kernel: device-mapper: uevent: version 1.0.3 May 15 23:30:07.125547 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 15 23:30:07.173486 kernel: raid6: neonx8 gen() 15543 MB/s May 15 23:30:07.190467 kernel: raid6: neonx4 gen() 15810 MB/s May 15 23:30:07.207486 kernel: raid6: neonx2 gen() 13198 MB/s May 15 23:30:07.224475 kernel: raid6: neonx1 gen() 10530 MB/s May 15 23:30:07.241478 kernel: raid6: int64x8 gen() 6793 MB/s May 15 23:30:07.258465 kernel: raid6: int64x4 gen() 7347 MB/s May 15 23:30:07.275472 kernel: raid6: int64x2 gen() 6111 MB/s May 15 23:30:07.292472 kernel: raid6: int64x1 gen() 5056 MB/s May 15 23:30:07.292501 kernel: raid6: using algorithm neonx4 gen() 15810 MB/s May 15 23:30:07.309509 kernel: raid6: .... xor() 12398 MB/s, rmw enabled May 15 23:30:07.309561 kernel: raid6: using neon recovery algorithm May 15 23:30:07.314476 kernel: xor: measuring software checksum speed May 15 23:30:07.314508 kernel: 8regs : 21630 MB/sec May 15 23:30:07.315483 kernel: 32regs : 19879 MB/sec May 15 23:30:07.315495 kernel: arm64_neon : 27832 MB/sec May 15 23:30:07.315504 kernel: xor: using function: arm64_neon (27832 MB/sec) May 15 23:30:07.365490 kernel: Btrfs loaded, zoned=no, fsverity=no May 15 23:30:07.376151 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 15 23:30:07.378829 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 15 23:30:07.408804 systemd-udevd[462]: Using default interface naming scheme 'v255'. May 15 23:30:07.412775 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 15 23:30:07.415583 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 15 23:30:07.440234 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation May 15 23:30:07.466971 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 15 23:30:07.469315 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 15 23:30:07.521170 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 15 23:30:07.523331 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 15 23:30:07.546809 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 15 23:30:07.548247 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 15 23:30:07.549891 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 15 23:30:07.552034 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 15 23:30:07.554852 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 15 23:30:07.575930 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues May 15 23:30:07.576117 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 15 23:30:07.581465 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 15 23:30:07.583017 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 15 23:30:07.589074 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 15 23:30:07.589198 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 15 23:30:07.594859 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 15 23:30:07.595984 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 15 23:30:07.596136 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 15 23:30:07.600343 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 15 23:30:07.609245 kernel: BTRFS: device fsid 44e3c267-913e-4e36-8a01-ed9d3f105561 devid 1 transid 40 /dev/vda3 scanned by (udev-worker) (518) May 15 23:30:07.603567 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 15 23:30:07.614483 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (508) May 15 23:30:07.635652 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 15 23:30:07.636998 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 15 23:30:07.645918 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 15 23:30:07.653123 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 15 23:30:07.655127 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 15 23:30:07.662474 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 15 23:30:07.664522 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 15 23:30:07.666133 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 15 23:30:07.684490 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 15 23:30:07.694616 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 15 23:30:08.700495 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 15 23:30:08.701163 disk-uuid[553]: The operation has completed successfully. May 15 23:30:08.727919 systemd[1]: disk-uuid.service: Deactivated successfully. May 15 23:30:08.728023 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 15 23:30:08.752852 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 15 23:30:08.767490 sh[574]: Success May 15 23:30:08.779526 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 15 23:30:08.807638 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 15 23:30:08.810227 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 15 23:30:08.827161 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 15 23:30:08.832720 kernel: BTRFS info (device dm-0): first mount of filesystem 44e3c267-913e-4e36-8a01-ed9d3f105561 May 15 23:30:08.832762 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 15 23:30:08.833550 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 15 23:30:08.833567 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 15 23:30:08.834557 kernel: BTRFS info (device dm-0): using free space tree May 15 23:30:08.837883 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 15 23:30:08.839238 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 15 23:30:08.840026 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 15 23:30:08.842232 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 15 23:30:08.869522 kernel: BTRFS info (device vda6): first mount of filesystem 17843e2b-3b85-462c-ad3f-d3e62fd4c5a5 May 15 23:30:08.869573 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 15 23:30:08.869584 kernel: BTRFS info (device vda6): using free space tree May 15 23:30:08.872492 kernel: BTRFS info (device vda6): auto enabling async discard May 15 23:30:08.876487 kernel: BTRFS info (device vda6): last unmount of filesystem 17843e2b-3b85-462c-ad3f-d3e62fd4c5a5 May 15 23:30:08.880389 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 15 23:30:08.882275 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 15 23:30:08.955847 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 15 23:30:08.960846 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 15 23:30:08.986140 ignition[665]: Ignition 2.20.0 May 15 23:30:08.986151 ignition[665]: Stage: fetch-offline May 15 23:30:08.986192 ignition[665]: no configs at "/usr/lib/ignition/base.d" May 15 23:30:08.986201 ignition[665]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 23:30:08.986363 ignition[665]: parsed url from cmdline: "" May 15 23:30:08.986367 ignition[665]: no config URL provided May 15 23:30:08.986372 ignition[665]: reading system config file "/usr/lib/ignition/user.ign" May 15 23:30:08.986380 ignition[665]: no config at "/usr/lib/ignition/user.ign" May 15 23:30:08.986408 ignition[665]: op(1): [started] loading QEMU firmware config module May 15 23:30:08.986412 ignition[665]: op(1): executing: "modprobe" "qemu_fw_cfg" May 15 23:30:08.996354 ignition[665]: op(1): [finished] loading QEMU firmware config module May 15 23:30:08.999398 ignition[665]: parsing config with SHA512: da099fba3cf6302073c4d4906c388b8389d554199f0e1d06b5c366c995729bf7e9f2819d7f6ec144f342ab7fbcc33499167cd17658cc41b820dc7963f87b35a2 May 15 23:30:09.004600 unknown[665]: fetched base config from "system" May 15 23:30:09.004611 unknown[665]: fetched user config from "qemu" May 15 23:30:09.004778 ignition[665]: fetch-offline: fetch-offline passed May 15 23:30:09.005783 systemd-networkd[762]: lo: Link UP May 15 23:30:09.004855 ignition[665]: Ignition finished successfully May 15 23:30:09.005787 systemd-networkd[762]: lo: Gained carrier May 15 23:30:09.006620 systemd-networkd[762]: Enumeration completed May 15 23:30:09.006800 systemd[1]: Started systemd-networkd.service - Network Configuration. May 15 23:30:09.008107 systemd[1]: Reached target network.target - Network. May 15 23:30:09.008725 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 15 23:30:09.008728 systemd-networkd[762]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 15 23:30:09.009417 systemd-networkd[762]: eth0: Link UP May 15 23:30:09.009420 systemd-networkd[762]: eth0: Gained carrier May 15 23:30:09.009427 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 15 23:30:09.009622 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 15 23:30:09.010787 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 15 23:30:09.011587 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 15 23:30:09.021513 systemd-networkd[762]: eth0: DHCPv4 address 10.0.0.63/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 15 23:30:09.038042 ignition[770]: Ignition 2.20.0 May 15 23:30:09.038885 ignition[770]: Stage: kargs May 15 23:30:09.039063 ignition[770]: no configs at "/usr/lib/ignition/base.d" May 15 23:30:09.039074 ignition[770]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 23:30:09.041568 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 15 23:30:09.039703 ignition[770]: kargs: kargs passed May 15 23:30:09.039751 ignition[770]: Ignition finished successfully May 15 23:30:09.043325 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 15 23:30:09.065967 ignition[780]: Ignition 2.20.0 May 15 23:30:09.065978 ignition[780]: Stage: disks May 15 23:30:09.066141 ignition[780]: no configs at "/usr/lib/ignition/base.d" May 15 23:30:09.066150 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 23:30:09.068133 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 15 23:30:09.066747 ignition[780]: disks: disks passed May 15 23:30:09.066796 ignition[780]: Ignition finished successfully May 15 23:30:09.071262 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 15 23:30:09.073149 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 15 23:30:09.074867 systemd[1]: Reached target local-fs.target - Local File Systems. May 15 23:30:09.075562 systemd[1]: Reached target sysinit.target - System Initialization. May 15 23:30:09.076296 systemd[1]: Reached target basic.target - Basic System. May 15 23:30:09.078733 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 15 23:30:09.100695 systemd-fsck[791]: ROOT: clean, 14/553520 files, 52654/553472 blocks May 15 23:30:09.104725 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 15 23:30:09.106653 systemd[1]: Mounting sysroot.mount - /sysroot... May 15 23:30:09.164487 kernel: EXT4-fs (vda9): mounted filesystem 4099475e-0c33-48d1-8a7f-66c442027985 r/w with ordered data mode. Quota mode: none. May 15 23:30:09.164693 systemd[1]: Mounted sysroot.mount - /sysroot. May 15 23:30:09.165782 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 15 23:30:09.168641 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 15 23:30:09.170170 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 15 23:30:09.171000 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 15 23:30:09.171042 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 15 23:30:09.171069 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 15 23:30:09.185413 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 15 23:30:09.188434 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 15 23:30:09.190355 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (799) May 15 23:30:09.193134 kernel: BTRFS info (device vda6): first mount of filesystem 17843e2b-3b85-462c-ad3f-d3e62fd4c5a5 May 15 23:30:09.193155 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 15 23:30:09.193165 kernel: BTRFS info (device vda6): using free space tree May 15 23:30:09.195468 kernel: BTRFS info (device vda6): auto enabling async discard May 15 23:30:09.208595 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 15 23:30:09.244471 initrd-setup-root[823]: cut: /sysroot/etc/passwd: No such file or directory May 15 23:30:09.248734 initrd-setup-root[830]: cut: /sysroot/etc/group: No such file or directory May 15 23:30:09.252620 initrd-setup-root[837]: cut: /sysroot/etc/shadow: No such file or directory May 15 23:30:09.255418 initrd-setup-root[844]: cut: /sysroot/etc/gshadow: No such file or directory May 15 23:30:09.325206 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 15 23:30:09.327665 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 15 23:30:09.329106 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 15 23:30:09.347480 kernel: BTRFS info (device vda6): last unmount of filesystem 17843e2b-3b85-462c-ad3f-d3e62fd4c5a5 May 15 23:30:09.364686 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 15 23:30:09.375003 ignition[912]: INFO : Ignition 2.20.0 May 15 23:30:09.375003 ignition[912]: INFO : Stage: mount May 15 23:30:09.376325 ignition[912]: INFO : no configs at "/usr/lib/ignition/base.d" May 15 23:30:09.376325 ignition[912]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 23:30:09.376325 ignition[912]: INFO : mount: mount passed May 15 23:30:09.376325 ignition[912]: INFO : Ignition finished successfully May 15 23:30:09.378995 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 15 23:30:09.380723 systemd[1]: Starting ignition-files.service - Ignition (files)... May 15 23:30:09.980683 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 15 23:30:09.982099 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 15 23:30:10.005170 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (926) May 15 23:30:10.005213 kernel: BTRFS info (device vda6): first mount of filesystem 17843e2b-3b85-462c-ad3f-d3e62fd4c5a5 May 15 23:30:10.005225 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 15 23:30:10.006486 kernel: BTRFS info (device vda6): using free space tree May 15 23:30:10.008467 kernel: BTRFS info (device vda6): auto enabling async discard May 15 23:30:10.009477 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 15 23:30:10.036621 ignition[943]: INFO : Ignition 2.20.0 May 15 23:30:10.036621 ignition[943]: INFO : Stage: files May 15 23:30:10.038311 ignition[943]: INFO : no configs at "/usr/lib/ignition/base.d" May 15 23:30:10.038311 ignition[943]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 23:30:10.038311 ignition[943]: DEBUG : files: compiled without relabeling support, skipping May 15 23:30:10.038311 ignition[943]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 15 23:30:10.038311 ignition[943]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 15 23:30:10.045673 ignition[943]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 15 23:30:10.045673 ignition[943]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 15 23:30:10.045673 ignition[943]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 15 23:30:10.045673 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 15 23:30:10.045673 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 15 23:30:10.045673 ignition[943]: INFO : files: op(4): [started] processing unit "docker.service" May 15 23:30:10.045673 ignition[943]: INFO : files: op(4): [finished] processing unit "docker.service" May 15 23:30:10.045673 ignition[943]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" May 15 23:30:10.045673 ignition[943]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 15 23:30:10.045673 ignition[943]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 15 23:30:10.045673 ignition[943]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" May 15 23:30:10.045673 ignition[943]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" May 15 23:30:10.040564 unknown[943]: wrote ssh authorized keys file for user: core May 15 23:30:10.065414 ignition[943]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" May 15 23:30:10.065414 ignition[943]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 15 23:30:10.065414 ignition[943]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" May 15 23:30:10.065414 ignition[943]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" May 15 23:30:10.065414 ignition[943]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" May 15 23:30:10.065414 ignition[943]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 15 23:30:10.065414 ignition[943]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 15 23:30:10.065414 ignition[943]: INFO : files: files passed May 15 23:30:10.065414 ignition[943]: INFO : Ignition finished successfully May 15 23:30:10.065117 systemd[1]: Finished ignition-files.service - Ignition (files). May 15 23:30:10.067069 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 15 23:30:10.068578 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 15 23:30:10.078342 systemd[1]: ignition-quench.service: Deactivated successfully. May 15 23:30:10.078433 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 15 23:30:10.081205 initrd-setup-root-after-ignition[971]: grep: /sysroot/oem/oem-release: No such file or directory May 15 23:30:10.082279 initrd-setup-root-after-ignition[974]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 15 23:30:10.082279 initrd-setup-root-after-ignition[974]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 15 23:30:10.084584 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 15 23:30:10.084821 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 15 23:30:10.086652 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 15 23:30:10.088853 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 15 23:30:10.117308 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 15 23:30:10.117434 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 15 23:30:10.119162 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 15 23:30:10.120551 systemd[1]: Reached target initrd.target - Initrd Default Target. May 15 23:30:10.121871 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 15 23:30:10.122661 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 15 23:30:10.137233 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 15 23:30:10.139431 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 15 23:30:10.159422 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 15 23:30:10.160362 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 15 23:30:10.161925 systemd[1]: Stopped target timers.target - Timer Units. May 15 23:30:10.163196 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 15 23:30:10.163324 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 15 23:30:10.165165 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 15 23:30:10.166827 systemd[1]: Stopped target basic.target - Basic System. May 15 23:30:10.168051 systemd-networkd[762]: eth0: Gained IPv6LL May 15 23:30:10.168215 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 15 23:30:10.169483 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 15 23:30:10.171653 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 15 23:30:10.172725 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 15 23:30:10.174177 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 15 23:30:10.175679 systemd[1]: Stopped target sysinit.target - System Initialization. May 15 23:30:10.176981 systemd[1]: Stopped target local-fs.target - Local File Systems. May 15 23:30:10.178529 systemd[1]: Stopped target swap.target - Swaps. May 15 23:30:10.179664 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 15 23:30:10.179814 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 15 23:30:10.181484 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 15 23:30:10.182878 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 15 23:30:10.184272 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 15 23:30:10.184407 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 15 23:30:10.185777 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 15 23:30:10.185913 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 15 23:30:10.187845 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 15 23:30:10.187970 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 15 23:30:10.189707 systemd[1]: Stopped target paths.target - Path Units. May 15 23:30:10.190970 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 15 23:30:10.191091 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 15 23:30:10.192600 systemd[1]: Stopped target slices.target - Slice Units. May 15 23:30:10.193900 systemd[1]: Stopped target sockets.target - Socket Units. May 15 23:30:10.195232 systemd[1]: iscsid.socket: Deactivated successfully. May 15 23:30:10.195325 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 15 23:30:10.196387 systemd[1]: iscsiuio.socket: Deactivated successfully. May 15 23:30:10.196487 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 15 23:30:10.197774 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 15 23:30:10.197890 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 15 23:30:10.199632 systemd[1]: ignition-files.service: Deactivated successfully. May 15 23:30:10.199740 systemd[1]: Stopped ignition-files.service - Ignition (files). May 15 23:30:10.201855 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 15 23:30:10.202730 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 15 23:30:10.202854 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 15 23:30:10.205079 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 15 23:30:10.206066 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 15 23:30:10.206181 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 15 23:30:10.207660 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 15 23:30:10.207782 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 15 23:30:10.214210 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 15 23:30:10.215532 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 15 23:30:10.221834 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 15 23:30:10.224518 ignition[998]: INFO : Ignition 2.20.0 May 15 23:30:10.224518 ignition[998]: INFO : Stage: umount May 15 23:30:10.226982 ignition[998]: INFO : no configs at "/usr/lib/ignition/base.d" May 15 23:30:10.226982 ignition[998]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 23:30:10.226982 ignition[998]: INFO : umount: umount passed May 15 23:30:10.226982 ignition[998]: INFO : Ignition finished successfully May 15 23:30:10.225385 systemd[1]: sysroot-boot.service: Deactivated successfully. May 15 23:30:10.225521 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 15 23:30:10.226731 systemd[1]: ignition-mount.service: Deactivated successfully. May 15 23:30:10.226810 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 15 23:30:10.228259 systemd[1]: Stopped target network.target - Network. May 15 23:30:10.229122 systemd[1]: ignition-disks.service: Deactivated successfully. May 15 23:30:10.229194 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 15 23:30:10.230663 systemd[1]: ignition-kargs.service: Deactivated successfully. May 15 23:30:10.230704 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 15 23:30:10.232382 systemd[1]: ignition-setup.service: Deactivated successfully. May 15 23:30:10.232419 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 15 23:30:10.233807 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 15 23:30:10.233848 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 15 23:30:10.235228 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 15 23:30:10.235271 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 15 23:30:10.236773 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 15 23:30:10.238018 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 15 23:30:10.242195 systemd[1]: systemd-resolved.service: Deactivated successfully. May 15 23:30:10.242304 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 15 23:30:10.245858 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 15 23:30:10.246107 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 15 23:30:10.246150 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 15 23:30:10.248899 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. May 15 23:30:10.253862 systemd[1]: systemd-networkd.service: Deactivated successfully. May 15 23:30:10.253990 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 15 23:30:10.256732 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 15 23:30:10.256765 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 15 23:30:10.259072 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 15 23:30:10.259995 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 15 23:30:10.260057 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 15 23:30:10.261646 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 15 23:30:10.261688 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 15 23:30:10.263905 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 15 23:30:10.263945 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 15 23:30:10.265579 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 15 23:30:10.279669 systemd[1]: systemd-udevd.service: Deactivated successfully. May 15 23:30:10.279811 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 15 23:30:10.281862 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 15 23:30:10.281899 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 15 23:30:10.283248 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 15 23:30:10.283279 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 15 23:30:10.284607 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 15 23:30:10.284657 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 15 23:30:10.286581 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 15 23:30:10.286636 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 15 23:30:10.288658 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 15 23:30:10.288704 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 15 23:30:10.291555 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 15 23:30:10.292883 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 15 23:30:10.292942 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 15 23:30:10.295305 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 15 23:30:10.295372 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 15 23:30:10.304660 systemd[1]: network-cleanup.service: Deactivated successfully. May 15 23:30:10.304762 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 15 23:30:10.309861 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 15 23:30:10.309961 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 15 23:30:10.311701 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 15 23:30:10.314627 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 15 23:30:10.335583 systemd[1]: Switching root. May 15 23:30:10.369533 systemd-journald[236]: Journal stopped May 15 23:30:11.057552 systemd-journald[236]: Received SIGTERM from PID 1 (systemd). May 15 23:30:11.057619 kernel: SELinux: policy capability network_peer_controls=1 May 15 23:30:11.057633 kernel: SELinux: policy capability open_perms=1 May 15 23:30:11.057647 kernel: SELinux: policy capability extended_socket_class=1 May 15 23:30:11.057656 kernel: SELinux: policy capability always_check_network=0 May 15 23:30:11.057665 kernel: SELinux: policy capability cgroup_seclabel=1 May 15 23:30:11.057678 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 15 23:30:11.057691 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 15 23:30:11.057701 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 15 23:30:11.057710 kernel: audit: type=1403 audit(1747351810.434:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 15 23:30:11.057720 systemd[1]: Successfully loaded SELinux policy in 31.863ms. May 15 23:30:11.057737 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.810ms. May 15 23:30:11.057748 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 15 23:30:11.057760 systemd[1]: Detected virtualization kvm. May 15 23:30:11.057770 systemd[1]: Detected architecture arm64. May 15 23:30:11.057783 systemd[1]: Detected first boot. May 15 23:30:11.057793 systemd[1]: Initializing machine ID from VM UUID. May 15 23:30:11.057803 zram_generator::config[1045]: No configuration found. May 15 23:30:11.057814 kernel: NET: Registered PF_VSOCK protocol family May 15 23:30:11.057824 systemd[1]: Populated /etc with preset unit settings. May 15 23:30:11.057835 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 15 23:30:11.057846 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 15 23:30:11.057856 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 15 23:30:11.057868 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 15 23:30:11.057879 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 15 23:30:11.057890 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 15 23:30:11.057900 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 15 23:30:11.057910 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 15 23:30:11.057923 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 15 23:30:11.057934 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 15 23:30:11.057945 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 15 23:30:11.057955 systemd[1]: Created slice user.slice - User and Session Slice. May 15 23:30:11.057965 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 15 23:30:11.057975 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 15 23:30:11.057986 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 15 23:30:11.057996 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 15 23:30:11.058006 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 15 23:30:11.058018 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 15 23:30:11.058028 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... May 15 23:30:11.058038 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 15 23:30:11.058049 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 15 23:30:11.058059 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 15 23:30:11.058069 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 15 23:30:11.058079 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 15 23:30:11.058089 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 15 23:30:11.058100 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 15 23:30:11.058110 systemd[1]: Reached target slices.target - Slice Units. May 15 23:30:11.058120 systemd[1]: Reached target swap.target - Swaps. May 15 23:30:11.058130 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 15 23:30:11.058140 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 15 23:30:11.058150 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 15 23:30:11.058160 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 15 23:30:11.058173 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 15 23:30:11.058183 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 15 23:30:11.058195 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 15 23:30:11.058205 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 15 23:30:11.058215 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 15 23:30:11.058225 systemd[1]: Mounting media.mount - External Media Directory... May 15 23:30:11.058235 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 15 23:30:11.058245 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 15 23:30:11.058255 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 15 23:30:11.058265 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). May 15 23:30:11.058276 systemd[1]: Reached target machines.target - Containers. May 15 23:30:11.058287 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 15 23:30:11.058297 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 15 23:30:11.058307 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 15 23:30:11.058317 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 15 23:30:11.058327 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 15 23:30:11.058337 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 15 23:30:11.058351 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 15 23:30:11.058362 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 15 23:30:11.058373 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 15 23:30:11.058383 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 15 23:30:11.058400 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 15 23:30:11.058410 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 15 23:30:11.058420 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 15 23:30:11.058430 systemd[1]: Stopped systemd-fsck-usr.service. May 15 23:30:11.058440 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 15 23:30:11.058450 systemd[1]: Starting systemd-journald.service - Journal Service... May 15 23:30:11.058494 kernel: fuse: init (API version 7.39) May 15 23:30:11.058505 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 15 23:30:11.058516 kernel: ACPI: bus type drm_connector registered May 15 23:30:11.058524 kernel: loop: module loaded May 15 23:30:11.058534 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 15 23:30:11.058544 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 15 23:30:11.058554 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 15 23:30:11.058563 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 15 23:30:11.058573 systemd[1]: verity-setup.service: Deactivated successfully. May 15 23:30:11.058585 systemd[1]: Stopped verity-setup.service. May 15 23:30:11.058601 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 15 23:30:11.058612 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 15 23:30:11.058622 systemd[1]: Mounted media.mount - External Media Directory. May 15 23:30:11.058631 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 15 23:30:11.058643 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 15 23:30:11.058655 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 15 23:30:11.058665 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 15 23:30:11.058698 systemd-journald[1113]: Collecting audit messages is disabled. May 15 23:30:11.058723 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 15 23:30:11.058733 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 15 23:30:11.058744 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 15 23:30:11.058754 systemd-journald[1113]: Journal started May 15 23:30:11.058778 systemd-journald[1113]: Runtime Journal (/run/log/journal/9c994d767b57420fa55f9ccb25039683) is 5.9M, max 47.3M, 41.4M free. May 15 23:30:10.851357 systemd[1]: Queued start job for default target multi-user.target. May 15 23:30:10.868415 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 15 23:30:10.868790 systemd[1]: systemd-journald.service: Deactivated successfully. May 15 23:30:11.060888 systemd[1]: Started systemd-journald.service - Journal Service. May 15 23:30:11.062222 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 23:30:11.062445 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 15 23:30:11.063603 systemd[1]: modprobe@drm.service: Deactivated successfully. May 15 23:30:11.063774 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 15 23:30:11.064924 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 23:30:11.065094 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 15 23:30:11.066384 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 15 23:30:11.066576 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 15 23:30:11.067681 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 23:30:11.067855 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 15 23:30:11.069058 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 15 23:30:11.070207 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 15 23:30:11.071608 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 15 23:30:11.072788 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 15 23:30:11.085059 systemd[1]: Reached target network-pre.target - Preparation for Network. May 15 23:30:11.087264 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 15 23:30:11.089256 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 15 23:30:11.090230 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 15 23:30:11.090262 systemd[1]: Reached target local-fs.target - Local File Systems. May 15 23:30:11.091949 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 15 23:30:11.097412 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 15 23:30:11.099426 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 15 23:30:11.100305 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 15 23:30:11.101542 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 15 23:30:11.103325 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 15 23:30:11.104328 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 15 23:30:11.107629 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 15 23:30:11.108815 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 15 23:30:11.111097 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 15 23:30:11.112988 systemd-journald[1113]: Time spent on flushing to /var/log/journal/9c994d767b57420fa55f9ccb25039683 is 14.029ms for 835 entries. May 15 23:30:11.112988 systemd-journald[1113]: System Journal (/var/log/journal/9c994d767b57420fa55f9ccb25039683) is 8M, max 195.6M, 187.6M free. May 15 23:30:11.138142 systemd-journald[1113]: Received client request to flush runtime journal. May 15 23:30:11.113316 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 15 23:30:11.116927 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 15 23:30:11.122367 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 15 23:30:11.124112 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 15 23:30:11.125602 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 15 23:30:11.127405 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 15 23:30:11.131218 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 15 23:30:11.136628 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 15 23:30:11.140071 kernel: loop0: detected capacity change from 0 to 103832 May 15 23:30:11.141649 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 15 23:30:11.145720 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 15 23:30:11.149802 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 15 23:30:11.159517 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 15 23:30:11.164517 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 15 23:30:11.166175 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 15 23:30:11.174039 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 15 23:30:11.186827 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 15 23:30:11.192079 udevadm[1172]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. May 15 23:30:11.205553 kernel: loop1: detected capacity change from 0 to 126448 May 15 23:30:11.208436 systemd-tmpfiles[1182]: ACLs are not supported, ignoring. May 15 23:30:11.208467 systemd-tmpfiles[1182]: ACLs are not supported, ignoring. May 15 23:30:11.214121 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 15 23:30:11.236491 kernel: loop2: detected capacity change from 0 to 103832 May 15 23:30:11.241485 kernel: loop3: detected capacity change from 0 to 126448 May 15 23:30:11.245293 (sd-merge)[1188]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 15 23:30:11.245762 (sd-merge)[1188]: Merged extensions into '/usr'. May 15 23:30:11.250888 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 15 23:30:11.253385 systemd[1]: Starting ensure-sysext.service... May 15 23:30:11.257669 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 15 23:30:11.276974 systemd[1]: Reload requested from client PID 1190 ('systemctl') (unit ensure-sysext.service)... May 15 23:30:11.276990 systemd[1]: Reloading... May 15 23:30:11.292047 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 15 23:30:11.292441 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 15 23:30:11.293640 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 15 23:30:11.294123 systemd-tmpfiles[1191]: ACLs are not supported, ignoring. May 15 23:30:11.294214 systemd-tmpfiles[1191]: ACLs are not supported, ignoring. May 15 23:30:11.297895 systemd-tmpfiles[1191]: Detected autofs mount point /boot during canonicalization of boot. May 15 23:30:11.297908 systemd-tmpfiles[1191]: Skipping /boot May 15 23:30:11.309661 systemd-tmpfiles[1191]: Detected autofs mount point /boot during canonicalization of boot. May 15 23:30:11.309675 systemd-tmpfiles[1191]: Skipping /boot May 15 23:30:11.347489 zram_generator::config[1221]: No configuration found. May 15 23:30:11.431034 ldconfig[1157]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 15 23:30:11.439562 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. May 15 23:30:11.489370 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 15 23:30:11.489752 systemd[1]: Reloading finished in 212 ms. May 15 23:30:11.506800 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 15 23:30:11.522812 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 15 23:30:11.532807 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 15 23:30:11.535227 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 15 23:30:11.544912 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 15 23:30:11.550726 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 15 23:30:11.556023 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 15 23:30:11.559807 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 15 23:30:11.561147 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 15 23:30:11.568125 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 15 23:30:11.572303 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 15 23:30:11.573360 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 15 23:30:11.573508 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 15 23:30:11.587265 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 15 23:30:11.590915 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 23:30:11.591109 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 15 23:30:11.592787 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 23:30:11.592944 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 15 23:30:11.594443 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 15 23:30:11.596052 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 23:30:11.596266 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 15 23:30:11.609225 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 15 23:30:11.612308 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 15 23:30:11.616153 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 15 23:30:11.633878 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 15 23:30:11.636335 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 15 23:30:11.638333 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 15 23:30:11.638392 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 15 23:30:11.643738 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 15 23:30:11.645402 systemd[1]: Finished ensure-sysext.service. May 15 23:30:11.646945 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 15 23:30:11.648401 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 23:30:11.648643 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 15 23:30:11.649981 systemd[1]: modprobe@drm.service: Deactivated successfully. May 15 23:30:11.650150 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 15 23:30:11.651773 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 23:30:11.651944 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 15 23:30:11.652805 augenrules[1294]: No rules May 15 23:30:11.653385 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 23:30:11.653565 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 15 23:30:11.658578 systemd[1]: audit-rules.service: Deactivated successfully. May 15 23:30:11.658824 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 15 23:30:11.662724 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 15 23:30:11.662801 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 15 23:30:11.665138 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 15 23:30:11.666136 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). May 15 23:30:11.678156 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 15 23:30:11.757958 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 15 23:30:11.759186 systemd[1]: Reached target time-set.target - System Time Set. May 15 23:30:11.770298 systemd-resolved[1261]: Positive Trust Anchors: May 15 23:30:11.773673 systemd-resolved[1261]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 15 23:30:11.773710 systemd-resolved[1261]: 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 May 15 23:30:11.780641 systemd-resolved[1261]: Defaulting to hostname 'linux'. May 15 23:30:11.782203 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 15 23:30:11.783348 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 15 23:30:11.791961 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 15 23:30:11.795169 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 15 23:30:11.797492 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 15 23:30:11.820949 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 15 23:30:11.833694 systemd-udevd[1315]: Using default interface naming scheme 'v255'. May 15 23:30:11.854562 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 15 23:30:11.857694 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 15 23:30:11.899692 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. May 15 23:30:11.919524 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1320) May 15 23:30:11.959111 systemd-networkd[1325]: lo: Link UP May 15 23:30:11.959118 systemd-networkd[1325]: lo: Gained carrier May 15 23:30:11.959997 systemd-networkd[1325]: Enumeration completed May 15 23:30:11.960723 systemd-networkd[1325]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 15 23:30:11.960730 systemd-networkd[1325]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 15 23:30:11.961194 systemd-networkd[1325]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 15 23:30:11.961219 systemd-networkd[1325]: eth0: Link UP May 15 23:30:11.961222 systemd-networkd[1325]: eth0: Gained carrier May 15 23:30:11.961229 systemd-networkd[1325]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 15 23:30:11.963290 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 15 23:30:11.964713 systemd[1]: Started systemd-networkd.service - Network Configuration. May 15 23:30:11.966660 systemd[1]: Reached target network.target - Network. May 15 23:30:11.968759 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 15 23:30:11.971645 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 15 23:30:11.973451 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 15 23:30:11.983559 systemd-networkd[1325]: eth0: DHCPv4 address 10.0.0.63/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 15 23:30:11.987651 systemd-timesyncd[1306]: Network configuration changed, trying to establish connection. May 15 23:30:11.539291 systemd-resolved[1261]: Clock change detected. Flushing caches. May 15 23:30:11.554084 systemd-journald[1113]: Time jumped backwards, rotating. May 15 23:30:11.539317 systemd-timesyncd[1306]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 15 23:30:11.539362 systemd-timesyncd[1306]: Initial clock synchronization to Thu 2025-05-15 23:30:11.539223 UTC. May 15 23:30:11.551074 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 15 23:30:11.554962 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 15 23:30:11.561092 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 15 23:30:11.574113 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 15 23:30:11.578632 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 15 23:30:11.600367 lvm[1358]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 15 23:30:11.618448 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 15 23:30:11.635899 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 15 23:30:11.637130 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 15 23:30:11.638057 systemd[1]: Reached target sysinit.target - System Initialization. May 15 23:30:11.638930 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 15 23:30:11.639856 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 15 23:30:11.640955 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 15 23:30:11.641885 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 15 23:30:11.642807 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 15 23:30:11.643693 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 15 23:30:11.643727 systemd[1]: Reached target paths.target - Path Units. May 15 23:30:11.644362 systemd[1]: Reached target timers.target - Timer Units. May 15 23:30:11.646446 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 15 23:30:11.648845 systemd[1]: Starting docker.socket - Docker Socket for the API... May 15 23:30:11.651996 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 15 23:30:11.653174 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 15 23:30:11.654145 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 15 23:30:11.657245 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 15 23:30:11.658640 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 15 23:30:11.660908 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 15 23:30:11.662426 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 15 23:30:11.663325 systemd[1]: Reached target sockets.target - Socket Units. May 15 23:30:11.664081 systemd[1]: Reached target basic.target - Basic System. May 15 23:30:11.664915 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 15 23:30:11.664949 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 15 23:30:11.666080 systemd[1]: Starting containerd.service - containerd container runtime... May 15 23:30:11.668170 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 15 23:30:11.669118 lvm[1366]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 15 23:30:11.672530 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 15 23:30:11.674563 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 15 23:30:11.675551 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). May 15 23:30:11.678783 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 15 23:30:11.681506 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 15 23:30:11.685663 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 15 23:30:11.688934 jq[1369]: false May 15 23:30:11.692244 systemd[1]: Starting systemd-logind.service - User Login Management... May 15 23:30:11.694060 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 15 23:30:11.694819 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 15 23:30:11.696816 systemd[1]: Starting update-engine.service - Update Engine... May 15 23:30:11.698984 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 15 23:30:11.702887 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 15 23:30:11.704812 extend-filesystems[1370]: Found loop2 May 15 23:30:11.704812 extend-filesystems[1370]: Found loop3 May 15 23:30:11.711835 extend-filesystems[1370]: Found vda May 15 23:30:11.711835 extend-filesystems[1370]: Found vda1 May 15 23:30:11.711835 extend-filesystems[1370]: Found vda2 May 15 23:30:11.711835 extend-filesystems[1370]: Found vda3 May 15 23:30:11.711835 extend-filesystems[1370]: Found usr May 15 23:30:11.711835 extend-filesystems[1370]: Found vda4 May 15 23:30:11.711835 extend-filesystems[1370]: Found vda6 May 15 23:30:11.711835 extend-filesystems[1370]: Found vda7 May 15 23:30:11.711835 extend-filesystems[1370]: Found vda9 May 15 23:30:11.711835 extend-filesystems[1370]: Checking size of /dev/vda9 May 15 23:30:11.706183 dbus-daemon[1368]: [system] SELinux support is enabled May 15 23:30:11.707793 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 15 23:30:11.726152 extend-filesystems[1370]: Old size kept for /dev/vda9 May 15 23:30:11.720725 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 15 23:30:11.720912 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 15 23:30:11.734558 jq[1380]: true May 15 23:30:11.721175 systemd[1]: extend-filesystems.service: Deactivated successfully. May 15 23:30:11.721330 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 15 23:30:11.734552 systemd[1]: motdgen.service: Deactivated successfully. May 15 23:30:11.735484 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 15 23:30:11.736676 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 15 23:30:11.736859 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 15 23:30:11.752088 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1327) May 15 23:30:11.762743 update_engine[1378]: I20250515 23:30:11.762599 1378 main.cc:92] Flatcar Update Engine starting May 15 23:30:11.765482 systemd-logind[1375]: Watching system buttons on /dev/input/event0 (Power Button) May 15 23:30:11.765684 systemd-logind[1375]: New seat seat0. May 15 23:30:11.768015 jq[1391]: true May 15 23:30:11.769061 systemd[1]: Started systemd-logind.service - User Login Management. May 15 23:30:11.775649 update_engine[1378]: I20250515 23:30:11.775468 1378 update_check_scheduler.cc:74] Next update check in 2m0s May 15 23:30:11.786711 (ntainerd)[1400]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 15 23:30:11.794509 systemd[1]: Started update-engine.service - Update Engine. May 15 23:30:11.796340 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). May 15 23:30:11.796531 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 15 23:30:11.798562 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). May 15 23:30:11.798671 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 15 23:30:11.802830 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 15 23:30:11.824634 bash[1417]: Updated "/home/core/.ssh/authorized_keys" May 15 23:30:11.826131 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 15 23:30:11.827970 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 15 23:30:11.865123 locksmithd[1418]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 15 23:30:12.018779 containerd[1400]: time="2025-05-15T23:30:12Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 15 23:30:12.021367 containerd[1400]: time="2025-05-15T23:30:12.021318826Z" level=info msg="starting containerd" revision=88aa2f531d6c2922003cc7929e51daf1c14caa0a version=v2.0.1 May 15 23:30:12.030702 containerd[1400]: time="2025-05-15T23:30:12.030650266Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.84µs" May 15 23:30:12.030702 containerd[1400]: time="2025-05-15T23:30:12.030694466Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 15 23:30:12.030780 containerd[1400]: time="2025-05-15T23:30:12.030716266Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 15 23:30:12.030918 containerd[1400]: time="2025-05-15T23:30:12.030892826Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 15 23:30:12.030965 containerd[1400]: time="2025-05-15T23:30:12.030918146Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 15 23:30:12.030965 containerd[1400]: time="2025-05-15T23:30:12.030946826Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 15 23:30:12.031012 containerd[1400]: time="2025-05-15T23:30:12.030997146Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 15 23:30:12.031031 containerd[1400]: time="2025-05-15T23:30:12.031011466Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 15 23:30:12.031343 containerd[1400]: time="2025-05-15T23:30:12.031311346Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 15 23:30:12.031343 containerd[1400]: time="2025-05-15T23:30:12.031335786Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 15 23:30:12.031405 containerd[1400]: time="2025-05-15T23:30:12.031347066Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 15 23:30:12.031405 containerd[1400]: time="2025-05-15T23:30:12.031356226Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 15 23:30:12.031469 containerd[1400]: time="2025-05-15T23:30:12.031450626Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 15 23:30:12.031689 containerd[1400]: time="2025-05-15T23:30:12.031662706Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 15 23:30:12.031716 containerd[1400]: time="2025-05-15T23:30:12.031701946Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 15 23:30:12.031735 containerd[1400]: time="2025-05-15T23:30:12.031715866Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 15 23:30:12.031758 containerd[1400]: time="2025-05-15T23:30:12.031747346Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 15 23:30:12.032077 containerd[1400]: time="2025-05-15T23:30:12.032043026Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 15 23:30:12.032168 containerd[1400]: time="2025-05-15T23:30:12.032153026Z" level=info msg="metadata content store policy set" policy=shared May 15 23:30:12.036918 containerd[1400]: time="2025-05-15T23:30:12.036877986Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 15 23:30:12.036956 containerd[1400]: time="2025-05-15T23:30:12.036941786Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 15 23:30:12.036975 containerd[1400]: time="2025-05-15T23:30:12.036958426Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 15 23:30:12.036991 containerd[1400]: time="2025-05-15T23:30:12.036976466Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 15 23:30:12.037022 containerd[1400]: time="2025-05-15T23:30:12.036990386Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 15 23:30:12.037022 containerd[1400]: time="2025-05-15T23:30:12.037003386Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 15 23:30:12.037022 containerd[1400]: time="2025-05-15T23:30:12.037015906Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 15 23:30:12.037071 containerd[1400]: time="2025-05-15T23:30:12.037029186Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 15 23:30:12.037071 containerd[1400]: time="2025-05-15T23:30:12.037046506Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 15 23:30:12.037071 containerd[1400]: time="2025-05-15T23:30:12.037057026Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 15 23:30:12.037071 containerd[1400]: time="2025-05-15T23:30:12.037066746Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 15 23:30:12.037134 containerd[1400]: time="2025-05-15T23:30:12.037077826Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 15 23:30:12.037258 containerd[1400]: time="2025-05-15T23:30:12.037230426Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 15 23:30:12.037286 containerd[1400]: time="2025-05-15T23:30:12.037261146Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 15 23:30:12.037286 containerd[1400]: time="2025-05-15T23:30:12.037276146Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 15 23:30:12.037318 containerd[1400]: time="2025-05-15T23:30:12.037287026Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 15 23:30:12.037318 containerd[1400]: time="2025-05-15T23:30:12.037298746Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 15 23:30:12.037318 containerd[1400]: time="2025-05-15T23:30:12.037310026Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 15 23:30:12.037365 containerd[1400]: time="2025-05-15T23:30:12.037321346Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 15 23:30:12.037365 containerd[1400]: time="2025-05-15T23:30:12.037331866Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 15 23:30:12.037365 containerd[1400]: time="2025-05-15T23:30:12.037342386Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 15 23:30:12.037365 containerd[1400]: time="2025-05-15T23:30:12.037353906Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 15 23:30:12.037365 containerd[1400]: time="2025-05-15T23:30:12.037364306Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 15 23:30:12.037688 containerd[1400]: time="2025-05-15T23:30:12.037662826Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 15 23:30:12.037688 containerd[1400]: time="2025-05-15T23:30:12.037685346Z" level=info msg="Start snapshots syncer" May 15 23:30:12.037728 containerd[1400]: time="2025-05-15T23:30:12.037707746Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 15 23:30:12.037968 containerd[1400]: time="2025-05-15T23:30:12.037929146Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 15 23:30:12.038100 containerd[1400]: time="2025-05-15T23:30:12.037985906Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 15 23:30:12.038100 containerd[1400]: time="2025-05-15T23:30:12.038051986Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 15 23:30:12.038183 containerd[1400]: time="2025-05-15T23:30:12.038162066Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 15 23:30:12.038203 containerd[1400]: time="2025-05-15T23:30:12.038190466Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 15 23:30:12.038220 containerd[1400]: time="2025-05-15T23:30:12.038202106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 15 23:30:12.038247 containerd[1400]: time="2025-05-15T23:30:12.038219906Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 15 23:30:12.038247 containerd[1400]: time="2025-05-15T23:30:12.038233786Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 15 23:30:12.038247 containerd[1400]: time="2025-05-15T23:30:12.038244586Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 15 23:30:12.038298 containerd[1400]: time="2025-05-15T23:30:12.038259546Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 15 23:30:12.038298 containerd[1400]: time="2025-05-15T23:30:12.038283906Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 15 23:30:12.038298 containerd[1400]: time="2025-05-15T23:30:12.038295346Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 15 23:30:12.038347 containerd[1400]: time="2025-05-15T23:30:12.038306226Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 15 23:30:12.038347 containerd[1400]: time="2025-05-15T23:30:12.038338506Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 15 23:30:12.038379 containerd[1400]: time="2025-05-15T23:30:12.038354266Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 15 23:30:12.038379 containerd[1400]: time="2025-05-15T23:30:12.038363546Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 15 23:30:12.038379 containerd[1400]: time="2025-05-15T23:30:12.038372626Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 15 23:30:12.038460 containerd[1400]: time="2025-05-15T23:30:12.038380666Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 15 23:30:12.038460 containerd[1400]: time="2025-05-15T23:30:12.038414826Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 15 23:30:12.038460 containerd[1400]: time="2025-05-15T23:30:12.038452986Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 15 23:30:12.038549 containerd[1400]: time="2025-05-15T23:30:12.038535986Z" level=info msg="runtime interface created" May 15 23:30:12.038549 containerd[1400]: time="2025-05-15T23:30:12.038545986Z" level=info msg="created NRI interface" May 15 23:30:12.038584 containerd[1400]: time="2025-05-15T23:30:12.038556186Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 15 23:30:12.038584 containerd[1400]: time="2025-05-15T23:30:12.038568706Z" level=info msg="Connect containerd service" May 15 23:30:12.038647 containerd[1400]: time="2025-05-15T23:30:12.038596346Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 15 23:30:12.040521 containerd[1400]: time="2025-05-15T23:30:12.040315106Z" 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" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146795386Z" level=info msg="Start subscribing containerd event" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146852146Z" level=info msg="Start recovering state" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146866546Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146920306Z" level=info msg=serving... address=/run/containerd/containerd.sock May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146953026Z" level=info msg="Start event monitor" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146968146Z" level=info msg="Start cni network conf syncer for default" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146977906Z" level=info msg="Start streaming server" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146986146Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146993026Z" level=info msg="runtime interface starting up..." May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.146998626Z" level=info msg="starting plugins..." May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.147010866Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 15 23:30:12.147437 containerd[1400]: time="2025-05-15T23:30:12.147139906Z" level=info msg="containerd successfully booted in 0.128726s" May 15 23:30:12.147285 systemd[1]: Started containerd.service - containerd container runtime. May 15 23:30:12.820048 sshd_keygen[1386]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 15 23:30:12.842003 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 15 23:30:12.844810 systemd[1]: Starting issuegen.service - Generate /run/issue... May 15 23:30:12.864408 systemd[1]: issuegen.service: Deactivated successfully. May 15 23:30:12.864648 systemd[1]: Finished issuegen.service - Generate /run/issue. May 15 23:30:12.868008 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 15 23:30:12.893321 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 15 23:30:12.896129 systemd[1]: Started getty@tty1.service - Getty on tty1. May 15 23:30:12.898578 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. May 15 23:30:12.899750 systemd[1]: Reached target getty.target - Login Prompts. May 15 23:30:13.173551 systemd-networkd[1325]: eth0: Gained IPv6LL May 15 23:30:13.176758 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 15 23:30:13.178216 systemd[1]: Reached target network-online.target - Network is Online. May 15 23:30:13.180611 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 15 23:30:13.182622 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 15 23:30:13.207270 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 15 23:30:13.208692 systemd[1]: coreos-metadata.service: Deactivated successfully. May 15 23:30:13.208964 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 15 23:30:13.213898 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 15 23:30:13.214184 systemd[1]: Reached target multi-user.target - Multi-User System. May 15 23:30:13.222281 systemd[1]: Startup finished in 555ms (kernel) + 3.739s (initrd) + 3.273s (userspace) = 7.567s. May 15 23:30:19.165421 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 15 23:30:19.168331 systemd[1]: Started sshd@0-10.0.0.63:22-10.0.0.1:55412.service - OpenSSH per-connection server daemon (10.0.0.1:55412). May 15 23:30:19.278914 sshd[1483]: Accepted publickey for core from 10.0.0.1 port 55412 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:19.280777 sshd-session[1483]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:19.287347 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 15 23:30:19.291868 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 15 23:30:19.298542 systemd-logind[1375]: New session 1 of user core. May 15 23:30:19.322418 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 15 23:30:19.330981 systemd[1]: Starting user@500.service - User Manager for UID 500... May 15 23:30:19.348631 (systemd)[1487]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 15 23:30:19.351327 systemd-logind[1375]: New session c1 of user core. May 15 23:30:19.467430 systemd[1487]: Queued start job for default target default.target. May 15 23:30:19.476422 systemd[1487]: Created slice app.slice - User Application Slice. May 15 23:30:19.476456 systemd[1487]: Reached target paths.target - Paths. May 15 23:30:19.476497 systemd[1487]: Reached target timers.target - Timers. May 15 23:30:19.477818 systemd[1487]: Starting dbus.socket - D-Bus User Message Bus Socket... May 15 23:30:19.487565 systemd[1487]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 15 23:30:19.487639 systemd[1487]: Reached target sockets.target - Sockets. May 15 23:30:19.487681 systemd[1487]: Reached target basic.target - Basic System. May 15 23:30:19.487708 systemd[1487]: Reached target default.target - Main User Target. May 15 23:30:19.487736 systemd[1487]: Startup finished in 128ms. May 15 23:30:19.487921 systemd[1]: Started user@500.service - User Manager for UID 500. May 15 23:30:19.489279 systemd[1]: Started session-1.scope - Session 1 of User core. May 15 23:30:19.549308 systemd[1]: Started sshd@1-10.0.0.63:22-10.0.0.1:55420.service - OpenSSH per-connection server daemon (10.0.0.1:55420). May 15 23:30:19.600193 sshd[1498]: Accepted publickey for core from 10.0.0.1 port 55420 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:19.601616 sshd-session[1498]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:19.606053 systemd-logind[1375]: New session 2 of user core. May 15 23:30:19.616624 systemd[1]: Started session-2.scope - Session 2 of User core. May 15 23:30:19.668092 sshd[1500]: Connection closed by 10.0.0.1 port 55420 May 15 23:30:19.667962 sshd-session[1498]: pam_unix(sshd:session): session closed for user core May 15 23:30:19.683528 systemd[1]: sshd@1-10.0.0.63:22-10.0.0.1:55420.service: Deactivated successfully. May 15 23:30:19.688951 systemd[1]: session-2.scope: Deactivated successfully. May 15 23:30:19.689755 systemd-logind[1375]: Session 2 logged out. Waiting for processes to exit. May 15 23:30:19.696650 systemd[1]: Started sshd@2-10.0.0.63:22-10.0.0.1:55428.service - OpenSSH per-connection server daemon (10.0.0.1:55428). May 15 23:30:19.697719 systemd-logind[1375]: Removed session 2. May 15 23:30:19.756078 sshd[1505]: Accepted publickey for core from 10.0.0.1 port 55428 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:19.757736 sshd-session[1505]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:19.764106 systemd-logind[1375]: New session 3 of user core. May 15 23:30:19.771545 systemd[1]: Started session-3.scope - Session 3 of User core. May 15 23:30:19.820172 sshd[1509]: Connection closed by 10.0.0.1 port 55428 May 15 23:30:19.820650 sshd-session[1505]: pam_unix(sshd:session): session closed for user core May 15 23:30:19.832247 systemd[1]: sshd@2-10.0.0.63:22-10.0.0.1:55428.service: Deactivated successfully. May 15 23:30:19.833924 systemd[1]: session-3.scope: Deactivated successfully. May 15 23:30:19.835938 systemd-logind[1375]: Session 3 logged out. Waiting for processes to exit. May 15 23:30:19.837792 systemd[1]: Started sshd@3-10.0.0.63:22-10.0.0.1:55432.service - OpenSSH per-connection server daemon (10.0.0.1:55432). May 15 23:30:19.838561 systemd-logind[1375]: Removed session 3. May 15 23:30:19.901675 sshd[1514]: Accepted publickey for core from 10.0.0.1 port 55432 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:19.903061 sshd-session[1514]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:19.907626 systemd-logind[1375]: New session 4 of user core. May 15 23:30:19.919555 systemd[1]: Started session-4.scope - Session 4 of User core. May 15 23:30:19.971999 sshd[1517]: Connection closed by 10.0.0.1 port 55432 May 15 23:30:19.973307 sshd-session[1514]: pam_unix(sshd:session): session closed for user core May 15 23:30:19.991367 systemd[1]: sshd@3-10.0.0.63:22-10.0.0.1:55432.service: Deactivated successfully. May 15 23:30:19.995938 systemd[1]: session-4.scope: Deactivated successfully. May 15 23:30:19.998266 systemd-logind[1375]: Session 4 logged out. Waiting for processes to exit. May 15 23:30:20.001449 systemd[1]: Started sshd@4-10.0.0.63:22-10.0.0.1:55434.service - OpenSSH per-connection server daemon (10.0.0.1:55434). May 15 23:30:20.002446 systemd-logind[1375]: Removed session 4. May 15 23:30:20.061863 sshd[1522]: Accepted publickey for core from 10.0.0.1 port 55434 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:20.063189 sshd-session[1522]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:20.067072 systemd-logind[1375]: New session 5 of user core. May 15 23:30:20.080548 systemd[1]: Started session-5.scope - Session 5 of User core. May 15 23:30:20.148870 sudo[1526]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 15 23:30:20.149133 sudo[1526]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 15 23:30:20.163251 sudo[1526]: pam_unix(sudo:session): session closed for user root May 15 23:30:20.164695 sshd[1525]: Connection closed by 10.0.0.1 port 55434 May 15 23:30:20.165287 sshd-session[1522]: pam_unix(sshd:session): session closed for user core May 15 23:30:20.174617 systemd[1]: sshd@4-10.0.0.63:22-10.0.0.1:55434.service: Deactivated successfully. May 15 23:30:20.176472 systemd[1]: session-5.scope: Deactivated successfully. May 15 23:30:20.177228 systemd-logind[1375]: Session 5 logged out. Waiting for processes to exit. May 15 23:30:20.179626 systemd[1]: Started sshd@5-10.0.0.63:22-10.0.0.1:55450.service - OpenSSH per-connection server daemon (10.0.0.1:55450). May 15 23:30:20.180554 systemd-logind[1375]: Removed session 5. May 15 23:30:20.234590 sshd[1531]: Accepted publickey for core from 10.0.0.1 port 55450 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:20.235900 sshd-session[1531]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:20.240216 systemd-logind[1375]: New session 6 of user core. May 15 23:30:20.246540 systemd[1]: Started session-6.scope - Session 6 of User core. May 15 23:30:20.297541 sudo[1536]: 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 May 15 23:30:20.297827 sudo[1536]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 15 23:30:20.300819 sudo[1536]: pam_unix(sudo:session): session closed for user root May 15 23:30:20.305254 sudo[1535]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 15 23:30:20.305563 sudo[1535]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 15 23:30:20.313193 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 15 23:30:20.352680 augenrules[1558]: No rules May 15 23:30:20.353905 systemd[1]: audit-rules.service: Deactivated successfully. May 15 23:30:20.354136 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 15 23:30:20.357479 sudo[1535]: pam_unix(sudo:session): session closed for user root May 15 23:30:20.358727 sshd[1534]: Connection closed by 10.0.0.1 port 55450 May 15 23:30:20.359686 sshd-session[1531]: pam_unix(sshd:session): session closed for user core May 15 23:30:20.369491 systemd[1]: sshd@5-10.0.0.63:22-10.0.0.1:55450.service: Deactivated successfully. May 15 23:30:20.370942 systemd[1]: session-6.scope: Deactivated successfully. May 15 23:30:20.372600 systemd-logind[1375]: Session 6 logged out. Waiting for processes to exit. May 15 23:30:20.374091 systemd[1]: Started sshd@6-10.0.0.63:22-10.0.0.1:55452.service - OpenSSH per-connection server daemon (10.0.0.1:55452). May 15 23:30:20.374938 systemd-logind[1375]: Removed session 6. May 15 23:30:20.437718 sshd[1566]: Accepted publickey for core from 10.0.0.1 port 55452 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:20.438778 sshd-session[1566]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:20.443007 systemd-logind[1375]: New session 7 of user core. May 15 23:30:20.450592 systemd[1]: Started session-7.scope - Session 7 of User core. May 15 23:30:20.505548 systemd[1]: Starting docker.service - Docker Application Container Engine... May 15 23:30:20.517785 (dockerd)[1571]: 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 May 15 23:30:20.783634 dockerd[1571]: time="2025-05-15T23:30:20.783493466Z" level=info msg="Starting up" May 15 23:30:20.785472 dockerd[1571]: time="2025-05-15T23:30:20.785440746Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 15 23:30:20.827698 dockerd[1571]: time="2025-05-15T23:30:20.827637426Z" level=info msg="Loading containers: start." May 15 23:30:20.982430 kernel: Initializing XFRM netlink socket May 15 23:30:21.047263 systemd-networkd[1325]: docker0: Link UP May 15 23:30:21.098657 dockerd[1571]: time="2025-05-15T23:30:21.098606946Z" level=info msg="Loading containers: done." May 15 23:30:21.117498 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2058690468-merged.mount: Deactivated successfully. May 15 23:30:21.120310 dockerd[1571]: time="2025-05-15T23:30:21.120253066Z" 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 May 15 23:30:21.120423 dockerd[1571]: time="2025-05-15T23:30:21.120348586Z" level=info msg="Docker daemon" commit=c710b88579fcb5e0d53f96dcae976d79323b9166 containerd-snapshotter=false storage-driver=overlay2 version=27.4.1 May 15 23:30:21.120647 dockerd[1571]: time="2025-05-15T23:30:21.120623666Z" level=info msg="Daemon has completed initialization" May 15 23:30:21.151547 dockerd[1571]: time="2025-05-15T23:30:21.150499186Z" level=info msg="API listen on /run/docker.sock" May 15 23:30:21.151838 systemd[1]: Started docker.service - Docker Application Container Engine. May 15 23:30:21.159105 sshd[1569]: Connection closed by 10.0.0.1 port 55452 May 15 23:30:21.157987 sshd-session[1566]: pam_unix(sshd:session): session closed for user core May 15 23:30:21.175587 systemd[1]: sshd@6-10.0.0.63:22-10.0.0.1:55452.service: Deactivated successfully. May 15 23:30:21.177897 systemd[1]: session-7.scope: Deactivated successfully. May 15 23:30:21.180304 systemd-logind[1375]: Session 7 logged out. Waiting for processes to exit. May 15 23:30:21.180694 systemd[1]: Started sshd@7-10.0.0.63:22-10.0.0.1:55458.service - OpenSSH per-connection server daemon (10.0.0.1:55458). May 15 23:30:21.182010 systemd-logind[1375]: Removed session 7. May 15 23:30:21.233330 sshd[1773]: Accepted publickey for core from 10.0.0.1 port 55458 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:21.234709 sshd-session[1773]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:21.238969 systemd-logind[1375]: New session 8 of user core. May 15 23:30:21.249558 systemd[1]: Started session-8.scope - Session 8 of User core. May 15 23:30:22.589054 systemd[1]: var-lib-docker-overlay2-e8ef2cbd26666a2f8640cc176f924df145c54c9bad6fb0af7ef33750a4e8ddb7\x2dinit-merged.mount: Deactivated successfully. May 15 23:30:22.628553 kernel: docker0: port 1(vethde26f49) entered blocking state May 15 23:30:22.628703 kernel: docker0: port 1(vethde26f49) entered disabled state May 15 23:30:22.628727 kernel: vethde26f49: entered allmulticast mode May 15 23:30:22.628748 kernel: vethde26f49: entered promiscuous mode May 15 23:30:22.631133 systemd-networkd[1325]: vethde26f49: Link UP May 15 23:30:22.669314 containerd[1400]: time="2025-05-15T23:30:22.669198466Z" level=info msg="connecting to shim 94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed" address="unix:///run/containerd/s/765a42c5a7d5c7b56c7d9a865f4932e0c8531f996f222276da8e9690bacbcab3" namespace=moby protocol=ttrpc version=3 May 15 23:30:22.694609 systemd[1]: Started docker-94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed.scope - libcontainer container 94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed. May 15 23:30:22.753425 kernel: eth0: renamed from vetha487deb May 15 23:30:22.760441 kernel: docker0: port 1(vethde26f49) entered blocking state May 15 23:30:22.760549 kernel: docker0: port 1(vethde26f49) entered forwarding state May 15 23:30:22.760585 systemd-networkd[1325]: vethde26f49: Gained carrier May 15 23:30:22.760841 systemd-networkd[1325]: docker0: Gained carrier May 15 23:30:22.764416 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 15 23:30:22.793781 sshd[1776]: Connection closed by 10.0.0.1 port 55458 May 15 23:30:22.794373 sshd-session[1773]: pam_unix(sshd:session): session closed for user core May 15 23:30:22.809909 systemd[1]: sshd@7-10.0.0.63:22-10.0.0.1:55458.service: Deactivated successfully. May 15 23:30:22.811816 systemd[1]: session-8.scope: Deactivated successfully. May 15 23:30:22.812963 systemd-logind[1375]: Session 8 logged out. Waiting for processes to exit. May 15 23:30:22.814798 systemd[1]: Started sshd@8-10.0.0.63:22-10.0.0.1:57748.service - OpenSSH per-connection server daemon (10.0.0.1:57748). May 15 23:30:22.817836 systemd-logind[1375]: Removed session 8. May 15 23:30:22.872723 sshd[1857]: Accepted publickey for core from 10.0.0.1 port 57748 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:22.873990 sshd-session[1857]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:22.878652 systemd-logind[1375]: New session 9 of user core. May 15 23:30:22.896595 systemd[1]: Started session-9.scope - Session 9 of User core. May 15 23:30:22.952094 sshd[1860]: Connection closed by 10.0.0.1 port 57748 May 15 23:30:22.952663 sshd-session[1857]: pam_unix(sshd:session): session closed for user core May 15 23:30:22.967723 systemd[1]: sshd@8-10.0.0.63:22-10.0.0.1:57748.service: Deactivated successfully. May 15 23:30:22.969446 systemd[1]: session-9.scope: Deactivated successfully. May 15 23:30:22.970822 systemd-logind[1375]: Session 9 logged out. Waiting for processes to exit. May 15 23:30:22.972159 systemd[1]: Started sshd@9-10.0.0.63:22-10.0.0.1:57760.service - OpenSSH per-connection server daemon (10.0.0.1:57760). May 15 23:30:22.972928 systemd-logind[1375]: Removed session 9. May 15 23:30:23.030570 sshd[1865]: Accepted publickey for core from 10.0.0.1 port 57760 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:23.031928 sshd-session[1865]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:23.035984 systemd-logind[1375]: New session 10 of user core. May 15 23:30:23.043595 systemd[1]: Started session-10.scope - Session 10 of User core. May 15 23:30:23.099088 sudo[1869]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1400 May 15 23:30:23.099625 sudo[1869]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 15 23:30:23.107344 sudo[1869]: pam_unix(sudo:session): session closed for user root May 15 23:30:23.108340 containerd[1400]: time="2025-05-15T23:30:23.107511906Z" level=info msg="Stop CRI service" May 15 23:30:23.108430 dockerd[1571]: time="2025-05-15T23:30:23.107938586Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 15 23:30:23.108430 dockerd[1571]: time="2025-05-15T23:30:23.107975506Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 15 23:30:23.108430 dockerd[1571]: time="2025-05-15T23:30:23.107977146Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 15 23:30:23.108430 dockerd[1571]: time="2025-05-15T23:30:23.108064026Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 15 23:30:23.113050 systemd[1]: containerd.service: Deactivated successfully. May 15 23:30:23.113968 sshd[1868]: Connection closed by 10.0.0.1 port 57760 May 15 23:30:23.113154 systemd[1]: containerd.service: Unit process 1807 (containerd-shim) remains running after unit stopped. May 15 23:30:23.113432 systemd[1]: containerd.service: Consumed 439ms CPU time, 158.8M memory peak. May 15 23:30:23.114427 sshd-session[1865]: pam_unix(sshd:session): session closed for user core May 15 23:30:23.127785 systemd[1]: sshd@9-10.0.0.63:22-10.0.0.1:57760.service: Deactivated successfully. May 15 23:30:23.130314 systemd[1]: session-10.scope: Deactivated successfully. May 15 23:30:23.131449 systemd-logind[1375]: Session 10 logged out. Waiting for processes to exit. May 15 23:30:23.134002 systemd-logind[1375]: Removed session 10. May 15 23:30:23.137076 systemd[1]: Started sshd@10-10.0.0.63:22-10.0.0.1:57776.service - OpenSSH per-connection server daemon (10.0.0.1:57776). May 15 23:30:23.203009 sshd[1876]: Accepted publickey for core from 10.0.0.1 port 57776 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:23.204408 sshd-session[1876]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:23.209613 systemd-logind[1375]: New session 11 of user core. May 15 23:30:23.222648 systemd[1]: Started session-11.scope - Session 11 of User core. May 15 23:30:23.280537 sshd[1878]: Connection closed by 10.0.0.1 port 57776 May 15 23:30:23.280879 sshd-session[1876]: pam_unix(sshd:session): session closed for user core May 15 23:30:23.284527 systemd[1]: sshd@10-10.0.0.63:22-10.0.0.1:57776.service: Deactivated successfully. May 15 23:30:23.286806 systemd[1]: session-11.scope: Deactivated successfully. May 15 23:30:23.287665 systemd-logind[1375]: Session 11 logged out. Waiting for processes to exit. May 15 23:30:23.289632 systemd-logind[1375]: Removed session 11. May 15 23:30:24.437966 systemd-networkd[1325]: vethde26f49: Gained IPv6LL May 15 23:30:24.757605 systemd-networkd[1325]: docker0: Gained IPv6LL May 15 23:30:28.149810 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. May 15 23:30:28.150245 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 15 23:30:28.150976 dockerd[1571]: time="2025-05-15T23:30:28.150725346Z" level=info msg="Processing signal 'terminated'" May 15 23:30:29.303708 systemd[1]: Started sshd@11-10.0.0.63:22-10.0.0.1:57788.service - OpenSSH per-connection server daemon (10.0.0.1:57788). May 15 23:30:29.349248 sshd[1884]: Accepted publickey for core from 10.0.0.1 port 57788 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:29.350320 sshd-session[1884]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:29.355098 systemd-logind[1375]: New session 12 of user core. May 15 23:30:29.364622 systemd[1]: Started session-12.scope - Session 12 of User core. May 15 23:30:29.417965 sshd[1886]: Connection closed by 10.0.0.1 port 57788 May 15 23:30:29.418241 sshd-session[1884]: pam_unix(sshd:session): session closed for user core May 15 23:30:29.420779 systemd[1]: sshd@11-10.0.0.63:22-10.0.0.1:57788.service: Deactivated successfully. May 15 23:30:29.422188 systemd[1]: session-12.scope: Deactivated successfully. May 15 23:30:29.425075 systemd-logind[1375]: Session 12 logged out. Waiting for processes to exit. May 15 23:30:29.426028 systemd-logind[1375]: Removed session 12. May 15 23:30:30.152669 dockerd[1571]: time="2025-05-15T23:30:30.152605106Z" level=error msg="Error sending stop (signal 15) to container" container=94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed error="Cannot kill container 94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" May 15 23:30:30.152669 dockerd[1571]: time="2025-05-15T23:30:30.152658506Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed May 15 23:30:35.431009 systemd[1]: Started sshd@12-10.0.0.63:22-10.0.0.1:35714.service - OpenSSH per-connection server daemon (10.0.0.1:35714). May 15 23:30:35.477840 sshd[1892]: Accepted publickey for core from 10.0.0.1 port 35714 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:35.479135 sshd-session[1892]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:35.485745 systemd-logind[1375]: New session 13 of user core. May 15 23:30:35.495581 systemd[1]: Started session-13.scope - Session 13 of User core. May 15 23:30:35.553928 sshd[1894]: Connection closed by 10.0.0.1 port 35714 May 15 23:30:35.554366 sshd-session[1892]: pam_unix(sshd:session): session closed for user core May 15 23:30:35.557994 systemd[1]: sshd@12-10.0.0.63:22-10.0.0.1:35714.service: Deactivated successfully. May 15 23:30:35.559705 systemd[1]: session-13.scope: Deactivated successfully. May 15 23:30:35.561553 systemd-logind[1375]: Session 13 logged out. Waiting for processes to exit. May 15 23:30:35.562447 systemd-logind[1375]: Removed session 13. May 15 23:30:40.153800 dockerd[1571]: time="2025-05-15T23:30:40.153688706Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed error="context deadline exceeded" May 15 23:30:40.154409 systemd[1]: docker-94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed.scope: Deactivated successfully. May 15 23:30:41.567880 systemd[1]: Started sshd@13-10.0.0.63:22-10.0.0.1:35728.service - OpenSSH per-connection server daemon (10.0.0.1:35728). May 15 23:30:41.616542 sshd[1900]: Accepted publickey for core from 10.0.0.1 port 35728 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:41.617829 sshd-session[1900]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:41.621842 systemd-logind[1375]: New session 14 of user core. May 15 23:30:41.628548 systemd[1]: Started session-14.scope - Session 14 of User core. May 15 23:30:41.682157 sshd[1902]: Connection closed by 10.0.0.1 port 35728 May 15 23:30:41.682492 sshd-session[1900]: pam_unix(sshd:session): session closed for user core May 15 23:30:41.685890 systemd[1]: sshd@13-10.0.0.63:22-10.0.0.1:35728.service: Deactivated successfully. May 15 23:30:41.687519 systemd[1]: session-14.scope: Deactivated successfully. May 15 23:30:41.688211 systemd-logind[1375]: Session 14 logged out. Waiting for processes to exit. May 15 23:30:41.688963 systemd-logind[1375]: Removed session 14. May 15 23:30:43.152256 dockerd[1571]: time="2025-05-15T23:30:43.152181986Z" level=error msg="Force shutdown daemon" May 15 23:30:43.152728 dockerd[1571]: time="2025-05-15T23:30:43.152335866Z" level=info msg="Daemon shutdown complete" May 15 23:30:43.155930 systemd[1]: docker.service: Deactivated successfully. May 15 23:30:43.156233 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 15 23:30:43.156297 systemd[1]: docker.service: Consumed 815ms CPU time, 124M memory peak. May 15 23:30:43.156707 systemd[1]: docker.socket: Deactivated successfully. May 15 23:30:43.156960 systemd[1]: Closed docker.socket - Docker Socket for the API. May 15 23:30:43.157000 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 15 23:30:43.158568 systemd[1]: Starting docker.socket - Docker Socket for the API... May 15 23:30:43.158745 systemd[1]: containerd.service: Found left-over process 1807 (containerd-shim) in control group while starting unit. Ignoring. May 15 23:30:43.158755 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 15 23:30:43.164959 systemd[1]: Starting containerd.service - containerd container runtime... May 15 23:30:43.165458 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 15 23:30:43.180527 systemd[1]: containerd.service: Found left-over process 1807 (containerd-shim) in control group while starting unit. Ignoring. May 15 23:30:43.180538 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 15 23:30:43.184836 (ntainerd)[1913]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 15 23:30:43.201286 containerd[1913]: time="2025-05-15T23:30:43Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 15 23:30:43.201792 containerd[1913]: time="2025-05-15T23:30:43.201758186Z" level=info msg="starting containerd" revision=88aa2f531d6c2922003cc7929e51daf1c14caa0a version=v2.0.1 May 15 23:30:43.209674 containerd[1913]: time="2025-05-15T23:30:43.209629106Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="6.64µs" May 15 23:30:43.209674 containerd[1913]: time="2025-05-15T23:30:43.209666506Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 15 23:30:43.209760 containerd[1913]: time="2025-05-15T23:30:43.209685746Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 15 23:30:43.209760 containerd[1913]: time="2025-05-15T23:30:43.209726106Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 15 23:30:43.209760 containerd[1913]: time="2025-05-15T23:30:43.209738706Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 15 23:30:43.209967 containerd[1913]: time="2025-05-15T23:30:43.209936186Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 15 23:30:43.209994 containerd[1913]: time="2025-05-15T23:30:43.209969746Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 15 23:30:43.209994 containerd[1913]: time="2025-05-15T23:30:43.209980306Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 15 23:30:43.210215 containerd[1913]: time="2025-05-15T23:30:43.210186746Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 15 23:30:43.210215 containerd[1913]: time="2025-05-15T23:30:43.210207106Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 15 23:30:43.210254 containerd[1913]: time="2025-05-15T23:30:43.210218426Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 15 23:30:43.210254 containerd[1913]: time="2025-05-15T23:30:43.210227346Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 15 23:30:43.210254 containerd[1913]: time="2025-05-15T23:30:43.210251306Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 15 23:30:43.210349 containerd[1913]: time="2025-05-15T23:30:43.210335546Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 15 23:30:43.210369 containerd[1913]: time="2025-05-15T23:30:43.210360466Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 15 23:30:43.210398 containerd[1913]: time="2025-05-15T23:30:43.210369786Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 15 23:30:43.210423 containerd[1913]: time="2025-05-15T23:30:43.210410506Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 15 23:30:43.210661 containerd[1913]: time="2025-05-15T23:30:43.210639306Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 15 23:30:43.210702 containerd[1913]: time="2025-05-15T23:30:43.210665066Z" level=info msg="metadata content store policy set" policy=shared May 15 23:30:43.210857 containerd[1913]: time="2025-05-15T23:30:43.210781226Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 15 23:30:43.210857 containerd[1913]: time="2025-05-15T23:30:43.210810626Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 15 23:30:43.210857 containerd[1913]: time="2025-05-15T23:30:43.210830506Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 15 23:30:43.210857 containerd[1913]: time="2025-05-15T23:30:43.210842986Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 15 23:30:43.210857 containerd[1913]: time="2025-05-15T23:30:43.210853986Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210865026Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210876106Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210887466Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210897706Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210907626Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210917386Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 15 23:30:43.210954 containerd[1913]: time="2025-05-15T23:30:43.210931146Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 15 23:30:43.212094 containerd[1913]: time="2025-05-15T23:30:43.212056346Z" level=info msg="connecting to shim 94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed" address="unix:///run/containerd/s/765a42c5a7d5c7b56c7d9a865f4932e0c8531f996f222276da8e9690bacbcab3" namespace=moby protocol=ttrpc version=3 May 15 23:30:43.219154 containerd[1913]: time="2025-05-15T23:30:43.219123826Z" level=info msg="cleaning leaked shim process" id=94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed namespace=moby May 15 23:30:43.228372 containerd[1913]: time="2025-05-15T23:30:43.228259226Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 15 23:30:43.228861 containerd[1913]: time="2025-05-15T23:30:43.228820186Z" level=info msg="shim disconnected" id=94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed namespace=moby May 15 23:30:43.228913 containerd[1913]: time="2025-05-15T23:30:43.228855706Z" level=warning msg="cleaning up after shim disconnected" id=94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed namespace=moby May 15 23:30:43.228913 containerd[1913]: time="2025-05-15T23:30:43.228889346Z" level=info msg="cleaning up dead shim" namespace=moby May 15 23:30:43.241662 containerd[1913]: time="2025-05-15T23:30:43.241585946Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 15 23:30:43.241807 containerd[1913]: time="2025-05-15T23:30:43.241735386Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 15 23:30:43.241807 containerd[1913]: time="2025-05-15T23:30:43.241759986Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 15 23:30:43.241807 containerd[1913]: time="2025-05-15T23:30:43.241774266Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 15 23:30:43.241807 containerd[1913]: time="2025-05-15T23:30:43.241786626Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 15 23:30:43.241807 containerd[1913]: time="2025-05-15T23:30:43.241798106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 15 23:30:43.241807 containerd[1913]: time="2025-05-15T23:30:43.241808746Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241821386Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241833106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241845346Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241857426Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241867946Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241935386Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 15 23:30:43.241956 containerd[1913]: time="2025-05-15T23:30:43.241952666Z" level=info msg="Start snapshots syncer" May 15 23:30:43.242177 containerd[1913]: time="2025-05-15T23:30:43.241991666Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 15 23:30:43.242252 containerd[1913]: time="2025-05-15T23:30:43.242216986Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 15 23:30:43.242435 containerd[1913]: time="2025-05-15T23:30:43.242270146Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 15 23:30:43.242435 containerd[1913]: time="2025-05-15T23:30:43.242346106Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 15 23:30:43.242435 containerd[1913]: time="2025-05-15T23:30:43.242430346Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 15 23:30:43.242517 containerd[1913]: time="2025-05-15T23:30:43.242451026Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 15 23:30:43.242517 containerd[1913]: time="2025-05-15T23:30:43.242462546Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 15 23:30:43.242517 containerd[1913]: time="2025-05-15T23:30:43.242485666Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 15 23:30:43.242517 containerd[1913]: time="2025-05-15T23:30:43.242503626Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 15 23:30:43.242517 containerd[1913]: time="2025-05-15T23:30:43.242514226Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 15 23:30:43.242602 containerd[1913]: time="2025-05-15T23:30:43.242526186Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 15 23:30:43.242602 containerd[1913]: time="2025-05-15T23:30:43.242552346Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 15 23:30:43.242602 containerd[1913]: time="2025-05-15T23:30:43.242564626Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 15 23:30:43.242602 containerd[1913]: time="2025-05-15T23:30:43.242574226Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242604826Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242618946Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242628426Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242637706Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242645906Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242656266Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 15 23:30:43.242670 containerd[1913]: time="2025-05-15T23:30:43.242666706Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 15 23:30:43.242784 containerd[1913]: time="2025-05-15T23:30:43.242682586Z" level=info msg="runtime interface created" May 15 23:30:43.242784 containerd[1913]: time="2025-05-15T23:30:43.242687986Z" level=info msg="created NRI interface" May 15 23:30:43.242784 containerd[1913]: time="2025-05-15T23:30:43.242696106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 15 23:30:43.242784 containerd[1913]: time="2025-05-15T23:30:43.242706986Z" level=info msg="Connect containerd service" May 15 23:30:43.242784 containerd[1913]: time="2025-05-15T23:30:43.242736706Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 15 23:30:43.243280 containerd[1913]: time="2025-05-15T23:30:43.243251346Z" 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" May 15 23:30:43.253716 containerd[1913]: time="2025-05-15T23:30:43.253645146Z" level=info msg="Start subscribing containerd event" May 15 23:30:43.253716 containerd[1913]: time="2025-05-15T23:30:43.253723026Z" level=info msg="Start recovering state" May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253669306Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253805346Z" level=info msg="Start event monitor" May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253820546Z" level=info msg="Start cni network conf syncer for default" May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253827706Z" level=info msg="Start streaming server" May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253844266Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253853266Z" level=info msg="runtime interface starting up..." May 15 23:30:43.253856 containerd[1913]: time="2025-05-15T23:30:43.253859426Z" level=info msg="starting plugins..." May 15 23:30:43.253983 containerd[1913]: time="2025-05-15T23:30:43.253870066Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 15 23:30:43.253983 containerd[1913]: time="2025-05-15T23:30:43.253847746Z" level=info msg=serving... address=/run/containerd/containerd.sock May 15 23:30:43.254021 containerd[1913]: time="2025-05-15T23:30:43.254003066Z" level=info msg="containerd successfully booted in 0.052895s" May 15 23:30:43.254175 systemd[1]: Started containerd.service - containerd container runtime. May 15 23:30:43.257022 systemd[1]: Starting docker.service - Docker Application Container Engine... May 15 23:30:43.273761 (dockerd)[1960]: 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 May 15 23:30:43.300316 dockerd[1960]: time="2025-05-15T23:30:43.299922986Z" level=info msg="Starting up" May 15 23:30:43.300717 dockerd[1960]: time="2025-05-15T23:30:43.300697746Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 15 23:30:43.479331 dockerd[1960]: time="2025-05-15T23:30:43.479183026Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 15 23:30:43.486886 dockerd[1960]: time="2025-05-15T23:30:43.486834626Z" level=info msg="Loading containers: start." May 15 23:30:43.597767 systemd[1]: var-lib-docker-overlay2-e8ef2cbd26666a2f8640cc176f924df145c54c9bad6fb0af7ef33750a4e8ddb7-merged.mount: Deactivated successfully. May 15 23:30:43.874489 dockerd[1960]: time="2025-05-15T23:30:43.874105706Z" level=info msg="Removing stale sandbox 46872ae503ebd8f146fffd9fb5975eb1e8619cb440590f1203a73eb02c6c1d5e (94de80b250f35d174ac7a7d21ddfe06d270bbb65833fda25448ddaf3664e93ed)" May 15 23:30:43.878939 dockerd[1960]: time="2025-05-15T23:30:43.878894706Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint bd73c491874c3ed5715bc85e7bbd2cf037702104b00512e6504c5c6c661bbd08 ed0d95d9c7177c74fb60bf56dd9c700d89037273d30984382b05e2838f3082c4], retrying...." May 15 23:30:43.886686 systemd-networkd[1325]: vethde26f49: Link DOWN May 15 23:30:43.887525 kernel: docker0: port 1(vethde26f49) entered disabled state May 15 23:30:43.887553 kernel: vethde26f49 (unregistering): left allmulticast mode May 15 23:30:43.886693 systemd-networkd[1325]: vethde26f49: Lost carrier May 15 23:30:43.888458 kernel: vethde26f49 (unregistering): left promiscuous mode May 15 23:30:43.888508 kernel: docker0: port 1(vethde26f49) entered disabled state May 15 23:30:43.909446 systemd-networkd[1325]: docker0: Lost carrier May 15 23:30:44.000855 dockerd[1960]: time="2025-05-15T23:30:44.000532585Z" 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" May 15 23:30:44.114732 dockerd[1960]: time="2025-05-15T23:30:44.114674079Z" level=warning msg="error locating sandbox id 46872ae503ebd8f146fffd9fb5975eb1e8619cb440590f1203a73eb02c6c1d5e: sandbox 46872ae503ebd8f146fffd9fb5975eb1e8619cb440590f1203a73eb02c6c1d5e not found" May 15 23:30:44.114932 dockerd[1960]: time="2025-05-15T23:30:44.114914759Z" level=info msg="Loading containers: done." May 15 23:30:44.127603 dockerd[1960]: time="2025-05-15T23:30:44.127499632Z" 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 May 15 23:30:44.127603 dockerd[1960]: time="2025-05-15T23:30:44.127587392Z" level=info msg="Docker daemon" commit=c710b88579fcb5e0d53f96dcae976d79323b9166 containerd-snapshotter=false storage-driver=overlay2 version=27.4.1 May 15 23:30:44.127742 dockerd[1960]: time="2025-05-15T23:30:44.127636872Z" level=info msg="Daemon has completed initialization" May 15 23:30:44.146380 dockerd[1960]: time="2025-05-15T23:30:44.146306541Z" level=info msg="API listen on /run/docker.sock" May 15 23:30:44.146593 systemd[1]: Started docker.service - Docker Application Container Engine. May 15 23:30:44.387345 systemd[1]: run-docker-netns-46872ae503eb.mount: Deactivated successfully. May 15 23:30:47.695438 systemd[1]: Started sshd@14-10.0.0.63:22-10.0.0.1:45160.service - OpenSSH per-connection server daemon (10.0.0.1:45160). May 15 23:30:47.740630 sshd[2168]: Accepted publickey for core from 10.0.0.1 port 45160 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:47.742092 sshd-session[2168]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:47.746306 systemd-logind[1375]: New session 15 of user core. May 15 23:30:47.758639 systemd[1]: Started session-15.scope - Session 15 of User core. May 15 23:30:47.812097 sshd[2170]: Connection closed by 10.0.0.1 port 45160 May 15 23:30:47.812751 sshd-session[2168]: pam_unix(sshd:session): session closed for user core May 15 23:30:47.827277 systemd[1]: sshd@14-10.0.0.63:22-10.0.0.1:45160.service: Deactivated successfully. May 15 23:30:47.831409 systemd[1]: session-15.scope: Deactivated successfully. May 15 23:30:47.832554 systemd-logind[1375]: Session 15 logged out. Waiting for processes to exit. May 15 23:30:47.835122 systemd[1]: Started sshd@15-10.0.0.63:22-10.0.0.1:45172.service - OpenSSH per-connection server daemon (10.0.0.1:45172). May 15 23:30:47.835597 systemd-logind[1375]: Removed session 15. May 15 23:30:47.896005 sshd[2175]: Accepted publickey for core from 10.0.0.1 port 45172 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:47.897563 sshd-session[2175]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:47.902864 systemd-logind[1375]: New session 16 of user core. May 15 23:30:47.913616 systemd[1]: Started session-16.scope - Session 16 of User core. May 15 23:30:47.968159 sshd[2178]: Connection closed by 10.0.0.1 port 45172 May 15 23:30:47.968683 sshd-session[2175]: pam_unix(sshd:session): session closed for user core May 15 23:30:47.986161 systemd[1]: sshd@15-10.0.0.63:22-10.0.0.1:45172.service: Deactivated successfully. May 15 23:30:47.988027 systemd[1]: session-16.scope: Deactivated successfully. May 15 23:30:47.991994 systemd-logind[1375]: Session 16 logged out. Waiting for processes to exit. May 15 23:30:47.992777 systemd[1]: Started sshd@16-10.0.0.63:22-10.0.0.1:45178.service - OpenSSH per-connection server daemon (10.0.0.1:45178). May 15 23:30:47.993604 systemd-logind[1375]: Removed session 16. May 15 23:30:48.050797 sshd[2183]: Accepted publickey for core from 10.0.0.1 port 45178 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:48.052100 sshd-session[2183]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:48.056065 systemd-logind[1375]: New session 17 of user core. May 15 23:30:48.062595 systemd[1]: Started session-17.scope - Session 17 of User core. May 15 23:30:48.125982 sshd[2186]: Connection closed by 10.0.0.1 port 45178 May 15 23:30:48.126511 sshd-session[2183]: pam_unix(sshd:session): session closed for user core May 15 23:30:48.142780 systemd[1]: sshd@16-10.0.0.63:22-10.0.0.1:45178.service: Deactivated successfully. May 15 23:30:48.144858 systemd[1]: session-17.scope: Deactivated successfully. May 15 23:30:48.146432 systemd-logind[1375]: Session 17 logged out. Waiting for processes to exit. May 15 23:30:48.148264 systemd[1]: Started sshd@17-10.0.0.63:22-10.0.0.1:45182.service - OpenSSH per-connection server daemon (10.0.0.1:45182). May 15 23:30:48.149104 systemd-logind[1375]: Removed session 17. May 15 23:30:48.208396 sshd[2197]: Accepted publickey for core from 10.0.0.1 port 45182 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:48.209746 sshd-session[2197]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:48.214398 systemd-logind[1375]: New session 18 of user core. May 15 23:30:48.224567 systemd[1]: Started session-18.scope - Session 18 of User core. May 15 23:30:48.291200 systemd[1]: var-lib-docker-overlay2-8cd545582d7f70ec17daa33a5cc327236865465286aba077398641173a6c0057\x2dinit-merged.mount: Deactivated successfully. May 15 23:30:48.312458 kernel: docker0: port 1(veth282a55d) entered blocking state May 15 23:30:48.312586 kernel: docker0: port 1(veth282a55d) entered disabled state May 15 23:30:48.312625 kernel: veth282a55d: entered allmulticast mode May 15 23:30:48.312707 kernel: veth282a55d: entered promiscuous mode May 15 23:30:48.313424 kernel: docker0: port 1(veth282a55d) entered blocking state May 15 23:30:48.313487 kernel: docker0: port 1(veth282a55d) entered forwarding state May 15 23:30:48.314461 kernel: docker0: port 1(veth282a55d) entered disabled state May 15 23:30:48.315179 systemd-networkd[1325]: veth282a55d: Link UP May 15 23:30:48.353090 containerd[1913]: time="2025-05-15T23:30:48.353039709Z" level=info msg="connecting to shim dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc" address="unix:///run/containerd/s/739371e4823b2ca43ce0956112c305591b1d5329a6daccd5dc76840d2ce8a98f" namespace=moby protocol=ttrpc version=3 May 15 23:30:48.372565 systemd[1]: Started docker-dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc.scope - libcontainer container dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc. May 15 23:30:48.415423 kernel: eth0: renamed from veth97d0504 May 15 23:30:48.427052 systemd-networkd[1325]: veth282a55d: Gained carrier May 15 23:30:48.427731 kernel: docker0: port 1(veth282a55d) entered blocking state May 15 23:30:48.427784 kernel: docker0: port 1(veth282a55d) entered forwarding state May 15 23:30:48.427285 systemd-networkd[1325]: docker0: Gained carrier May 15 23:30:48.429692 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 15 23:30:48.454625 sshd[2200]: Connection closed by 10.0.0.1 port 45182 May 15 23:30:48.455121 sshd-session[2197]: pam_unix(sshd:session): session closed for user core May 15 23:30:48.465975 systemd[1]: sshd@17-10.0.0.63:22-10.0.0.1:45182.service: Deactivated successfully. May 15 23:30:48.467753 systemd[1]: session-18.scope: Deactivated successfully. May 15 23:30:48.470672 systemd-logind[1375]: Session 18 logged out. Waiting for processes to exit. May 15 23:30:48.472073 systemd[1]: Started sshd@18-10.0.0.63:22-10.0.0.1:45184.service - OpenSSH per-connection server daemon (10.0.0.1:45184). May 15 23:30:48.473849 systemd-logind[1375]: Removed session 18. May 15 23:30:48.525926 sshd[2281]: Accepted publickey for core from 10.0.0.1 port 45184 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:48.527224 sshd-session[2281]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:48.531170 systemd-logind[1375]: New session 19 of user core. May 15 23:30:48.547563 systemd[1]: Started session-19.scope - Session 19 of User core. May 15 23:30:48.602111 sshd[2284]: Connection closed by 10.0.0.1 port 45184 May 15 23:30:48.602452 sshd-session[2281]: pam_unix(sshd:session): session closed for user core May 15 23:30:48.616174 systemd[1]: sshd@18-10.0.0.63:22-10.0.0.1:45184.service: Deactivated successfully. May 15 23:30:48.617721 systemd[1]: session-19.scope: Deactivated successfully. May 15 23:30:48.618994 systemd-logind[1375]: Session 19 logged out. Waiting for processes to exit. May 15 23:30:48.621226 systemd[1]: Started sshd@19-10.0.0.63:22-10.0.0.1:45198.service - OpenSSH per-connection server daemon (10.0.0.1:45198). May 15 23:30:48.622004 systemd-logind[1375]: Removed session 19. May 15 23:30:48.680791 sshd[2289]: Accepted publickey for core from 10.0.0.1 port 45198 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:48.682022 sshd-session[2289]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:48.686495 systemd-logind[1375]: New session 20 of user core. May 15 23:30:48.692546 systemd[1]: Started session-20.scope - Session 20 of User core. May 15 23:30:48.744308 sudo[2293]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1913 May 15 23:30:48.744639 sudo[2293]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 15 23:30:48.747377 sudo[2293]: pam_unix(sudo:session): session closed for user root May 15 23:30:48.749652 sshd[2292]: Connection closed by 10.0.0.1 port 45198 May 15 23:30:48.749763 sshd-session[2289]: pam_unix(sshd:session): session closed for user core May 15 23:30:48.763288 dockerd[1960]: time="2025-05-15T23:30:48.750491691Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 15 23:30:48.763288 dockerd[1960]: time="2025-05-15T23:30:48.750527611Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 15 23:30:48.763288 dockerd[1960]: time="2025-05-15T23:30:48.750602811Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 15 23:30:48.763288 dockerd[1960]: time="2025-05-15T23:30:48.750629771Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 15 23:30:48.766489 systemd[1]: containerd.service: Deactivated successfully. May 15 23:30:48.766599 systemd[1]: containerd.service: Unit process 2231 (containerd-shim) remains running after unit stopped. May 15 23:30:48.766829 systemd[1]: containerd.service: Consumed 173ms CPU time, 162.5M memory peak. May 15 23:30:48.767196 systemd[1]: sshd@19-10.0.0.63:22-10.0.0.1:45198.service: Deactivated successfully. May 15 23:30:48.768705 systemd[1]: session-20.scope: Deactivated successfully. May 15 23:30:48.769921 systemd-logind[1375]: Session 20 logged out. Waiting for processes to exit. May 15 23:30:48.772141 systemd[1]: Started sshd@20-10.0.0.63:22-10.0.0.1:45200.service - OpenSSH per-connection server daemon (10.0.0.1:45200). May 15 23:30:48.772886 systemd-logind[1375]: Removed session 20. May 15 23:30:48.833833 sshd[2299]: Accepted publickey for core from 10.0.0.1 port 45200 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:48.835046 sshd-session[2299]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:48.838704 systemd-logind[1375]: New session 21 of user core. May 15 23:30:48.855548 systemd[1]: Started session-21.scope - Session 21 of User core. May 15 23:30:48.909536 sshd[2302]: Connection closed by 10.0.0.1 port 45200 May 15 23:30:48.909883 sshd-session[2299]: pam_unix(sshd:session): session closed for user core May 15 23:30:48.913147 systemd[1]: sshd@20-10.0.0.63:22-10.0.0.1:45200.service: Deactivated successfully. May 15 23:30:48.914946 systemd[1]: session-21.scope: Deactivated successfully. May 15 23:30:48.915597 systemd-logind[1375]: Session 21 logged out. Waiting for processes to exit. May 15 23:30:48.916611 systemd-logind[1375]: Removed session 21. May 15 23:30:50.357547 systemd-networkd[1325]: veth282a55d: Gained IPv6LL May 15 23:30:53.899929 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. May 15 23:30:53.900266 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 15 23:30:53.900478 dockerd[1960]: time="2025-05-15T23:30:53.900427030Z" level=info msg="Processing signal 'terminated'" May 15 23:30:54.920354 systemd[1]: Started sshd@21-10.0.0.63:22-10.0.0.1:36638.service - OpenSSH per-connection server daemon (10.0.0.1:36638). May 15 23:30:54.971815 sshd[2308]: Accepted publickey for core from 10.0.0.1 port 36638 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:30:54.972917 sshd-session[2308]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:30:54.976639 systemd-logind[1375]: New session 22 of user core. May 15 23:30:54.984519 systemd[1]: Started session-22.scope - Session 22 of User core. May 15 23:30:55.036424 sshd[2310]: Connection closed by 10.0.0.1 port 36638 May 15 23:30:55.036823 sshd-session[2308]: pam_unix(sshd:session): session closed for user core May 15 23:30:55.039699 systemd[1]: sshd@21-10.0.0.63:22-10.0.0.1:36638.service: Deactivated successfully. May 15 23:30:55.041344 systemd[1]: session-22.scope: Deactivated successfully. May 15 23:30:55.042010 systemd-logind[1375]: Session 22 logged out. Waiting for processes to exit. May 15 23:30:55.042696 systemd-logind[1375]: Removed session 22. May 15 23:30:55.902146 dockerd[1960]: time="2025-05-15T23:30:55.902022593Z" level=error msg="Error sending stop (signal 15) to container" container=dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc error="Cannot kill container dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" May 15 23:30:55.902146 dockerd[1960]: time="2025-05-15T23:30:55.902100193Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc May 15 23:30:56.656486 update_engine[1378]: I20250515 23:30:56.656050 1378 update_attempter.cc:509] Updating boot flags... May 15 23:30:56.674408 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2322) May 15 23:30:56.709406 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2320) May 15 23:30:56.736540 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2320) May 15 23:31:01.047611 systemd[1]: Started sshd@22-10.0.0.63:22-10.0.0.1:36650.service - OpenSSH per-connection server daemon (10.0.0.1:36650). May 15 23:31:01.093460 sshd[2331]: Accepted publickey for core from 10.0.0.1 port 36650 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:31:01.094736 sshd-session[2331]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:31:01.099279 systemd-logind[1375]: New session 23 of user core. May 15 23:31:01.111548 systemd[1]: Started session-23.scope - Session 23 of User core. May 15 23:31:01.164759 sshd[2333]: Connection closed by 10.0.0.1 port 36650 May 15 23:31:01.164641 sshd-session[2331]: pam_unix(sshd:session): session closed for user core May 15 23:31:01.167941 systemd[1]: sshd@22-10.0.0.63:22-10.0.0.1:36650.service: Deactivated successfully. May 15 23:31:01.169527 systemd[1]: session-23.scope: Deactivated successfully. May 15 23:31:01.170087 systemd-logind[1375]: Session 23 logged out. Waiting for processes to exit. May 15 23:31:01.170843 systemd-logind[1375]: Removed session 23. May 15 23:31:05.902843 dockerd[1960]: time="2025-05-15T23:31:05.902582412Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc error="context deadline exceeded" May 15 23:31:05.903294 systemd[1]: docker-dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc.scope: Deactivated successfully. May 15 23:31:07.179063 systemd[1]: Started sshd@23-10.0.0.63:22-10.0.0.1:55330.service - OpenSSH per-connection server daemon (10.0.0.1:55330). May 15 23:31:07.238686 sshd[2339]: Accepted publickey for core from 10.0.0.1 port 55330 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:31:07.240058 sshd-session[2339]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:31:07.248102 systemd-logind[1375]: New session 24 of user core. May 15 23:31:07.257590 systemd[1]: Started session-24.scope - Session 24 of User core. May 15 23:31:07.311376 sshd[2341]: Connection closed by 10.0.0.1 port 55330 May 15 23:31:07.311739 sshd-session[2339]: pam_unix(sshd:session): session closed for user core May 15 23:31:07.314912 systemd[1]: sshd@23-10.0.0.63:22-10.0.0.1:55330.service: Deactivated successfully. May 15 23:31:07.316499 systemd[1]: session-24.scope: Deactivated successfully. May 15 23:31:07.317213 systemd-logind[1375]: Session 24 logged out. Waiting for processes to exit. May 15 23:31:07.318163 systemd-logind[1375]: Removed session 24. May 15 23:31:08.901491 dockerd[1960]: time="2025-05-15T23:31:08.901410532Z" level=error msg="Force shutdown daemon" May 15 23:31:08.901948 dockerd[1960]: time="2025-05-15T23:31:08.901559932Z" level=info msg="Daemon shutdown complete" May 15 23:31:08.904851 systemd[1]: docker.service: Deactivated successfully. May 15 23:31:08.905261 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 15 23:31:08.906065 systemd[1]: docker.socket: Deactivated successfully. May 15 23:31:08.906351 systemd[1]: Closed docker.socket - Docker Socket for the API. May 15 23:31:08.906413 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 15 23:31:08.908351 systemd[1]: Starting docker.socket - Docker Socket for the API... May 15 23:31:08.908656 systemd[1]: containerd.service: Found left-over process 2231 (containerd-shim) in control group while starting unit. Ignoring. May 15 23:31:08.908665 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 15 23:31:08.912079 systemd[1]: Starting containerd.service - containerd container runtime... May 15 23:31:08.912822 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 15 23:31:08.953283 systemd[1]: containerd.service: Found left-over process 2231 (containerd-shim) in control group while starting unit. Ignoring. May 15 23:31:08.953296 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 15 23:31:08.983826 (ntainerd)[2352]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 15 23:31:09.002479 containerd[2352]: time="2025-05-15T23:31:09Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 15 23:31:09.002971 containerd[2352]: time="2025-05-15T23:31:09.002939720Z" level=info msg="starting containerd" revision=88aa2f531d6c2922003cc7929e51daf1c14caa0a version=v2.0.1 May 15 23:31:09.012278 containerd[2352]: time="2025-05-15T23:31:09.012190359Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.52µs" May 15 23:31:09.012278 containerd[2352]: time="2025-05-15T23:31:09.012240599Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 15 23:31:09.012278 containerd[2352]: time="2025-05-15T23:31:09.012264199Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 15 23:31:09.012443 containerd[2352]: time="2025-05-15T23:31:09.012312239Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 15 23:31:09.012443 containerd[2352]: time="2025-05-15T23:31:09.012327679Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 15 23:31:09.012634 containerd[2352]: time="2025-05-15T23:31:09.012582919Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 15 23:31:09.012668 containerd[2352]: time="2025-05-15T23:31:09.012636679Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 15 23:31:09.012668 containerd[2352]: time="2025-05-15T23:31:09.012649599Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.012895639Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.012919439Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.012931679Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.012939239Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.012964799Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.013052559Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.013080279Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.013095519Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 15 23:31:09.013267 containerd[2352]: time="2025-05-15T23:31:09.013124119Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 15 23:31:09.013619 containerd[2352]: time="2025-05-15T23:31:09.013347039Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 15 23:31:09.013619 containerd[2352]: time="2025-05-15T23:31:09.013365759Z" level=info msg="metadata content store policy set" policy=shared May 15 23:31:09.013619 containerd[2352]: time="2025-05-15T23:31:09.013602038Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 15 23:31:09.013680 containerd[2352]: time="2025-05-15T23:31:09.013634358Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 15 23:31:09.013680 containerd[2352]: time="2025-05-15T23:31:09.013647558Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 15 23:31:09.013680 containerd[2352]: time="2025-05-15T23:31:09.013661558Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 15 23:31:09.013680 containerd[2352]: time="2025-05-15T23:31:09.013672998Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 15 23:31:09.013751 containerd[2352]: time="2025-05-15T23:31:09.013684238Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 15 23:31:09.013751 containerd[2352]: time="2025-05-15T23:31:09.013696718Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 15 23:31:09.013751 containerd[2352]: time="2025-05-15T23:31:09.013710038Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 15 23:31:09.013751 containerd[2352]: time="2025-05-15T23:31:09.013720838Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 15 23:31:09.013751 containerd[2352]: time="2025-05-15T23:31:09.013733318Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 15 23:31:09.013751 containerd[2352]: time="2025-05-15T23:31:09.013743838Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 15 23:31:09.013856 containerd[2352]: time="2025-05-15T23:31:09.013762318Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 15 23:31:09.014024 containerd[2352]: time="2025-05-15T23:31:09.014003118Z" level=info msg="connecting to shim dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc" address="unix:///run/containerd/s/739371e4823b2ca43ce0956112c305591b1d5329a6daccd5dc76840d2ce8a98f" namespace=moby protocol=ttrpc version=3 May 15 23:31:09.023145 containerd[2352]: time="2025-05-15T23:31:09.023103637Z" level=info msg="cleaning leaked shim process" id=dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc namespace=moby May 15 23:31:09.033851 containerd[2352]: time="2025-05-15T23:31:09.033739636Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 15 23:31:09.034989 containerd[2352]: time="2025-05-15T23:31:09.034961116Z" level=info msg="shim disconnected" id=dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc namespace=moby May 15 23:31:09.035078 containerd[2352]: time="2025-05-15T23:31:09.034990636Z" level=warning msg="cleaning up after shim disconnected" id=dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc namespace=moby May 15 23:31:09.035078 containerd[2352]: time="2025-05-15T23:31:09.035067916Z" level=info msg="cleaning up dead shim" namespace=moby May 15 23:31:09.046552 containerd[2352]: time="2025-05-15T23:31:09.046418835Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046585555Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046610275Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046626395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046637355Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046648995Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046660155Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 15 23:31:09.046680 containerd[2352]: time="2025-05-15T23:31:09.046673355Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 15 23:31:09.046811 containerd[2352]: time="2025-05-15T23:31:09.046684875Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 15 23:31:09.046811 containerd[2352]: time="2025-05-15T23:31:09.046698955Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 15 23:31:09.046811 containerd[2352]: time="2025-05-15T23:31:09.046717155Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 15 23:31:09.046811 containerd[2352]: time="2025-05-15T23:31:09.046729035Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 15 23:31:09.046811 containerd[2352]: time="2025-05-15T23:31:09.046796515Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 15 23:31:09.046898 containerd[2352]: time="2025-05-15T23:31:09.046815315Z" level=info msg="Start snapshots syncer" May 15 23:31:09.046898 containerd[2352]: time="2025-05-15T23:31:09.046838235Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 15 23:31:09.047130 containerd[2352]: time="2025-05-15T23:31:09.047073915Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 15 23:31:09.047223 containerd[2352]: time="2025-05-15T23:31:09.047135995Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 15 23:31:09.047223 containerd[2352]: time="2025-05-15T23:31:09.047204035Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 15 23:31:09.047271 containerd[2352]: time="2025-05-15T23:31:09.047251715Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 15 23:31:09.047291 containerd[2352]: time="2025-05-15T23:31:09.047271275Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 15 23:31:09.047291 containerd[2352]: time="2025-05-15T23:31:09.047282515Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 15 23:31:09.047324 containerd[2352]: time="2025-05-15T23:31:09.047293235Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 15 23:31:09.047324 containerd[2352]: time="2025-05-15T23:31:09.047306675Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 15 23:31:09.047324 containerd[2352]: time="2025-05-15T23:31:09.047317995Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 15 23:31:09.047378 containerd[2352]: time="2025-05-15T23:31:09.047329115Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 15 23:31:09.047378 containerd[2352]: time="2025-05-15T23:31:09.047355555Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 15 23:31:09.047378 containerd[2352]: time="2025-05-15T23:31:09.047369955Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 15 23:31:09.047462 containerd[2352]: time="2025-05-15T23:31:09.047380275Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 15 23:31:09.047462 containerd[2352]: time="2025-05-15T23:31:09.047446115Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 15 23:31:09.047508 containerd[2352]: time="2025-05-15T23:31:09.047464955Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 15 23:31:09.047508 containerd[2352]: time="2025-05-15T23:31:09.047474315Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 15 23:31:09.047508 containerd[2352]: time="2025-05-15T23:31:09.047484515Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 15 23:31:09.047508 containerd[2352]: time="2025-05-15T23:31:09.047493035Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 15 23:31:09.047508 containerd[2352]: time="2025-05-15T23:31:09.047503395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 15 23:31:09.047592 containerd[2352]: time="2025-05-15T23:31:09.047514755Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 15 23:31:09.047592 containerd[2352]: time="2025-05-15T23:31:09.047533675Z" level=info msg="runtime interface created" May 15 23:31:09.047592 containerd[2352]: time="2025-05-15T23:31:09.047540395Z" level=info msg="created NRI interface" May 15 23:31:09.047592 containerd[2352]: time="2025-05-15T23:31:09.047549075Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 15 23:31:09.047592 containerd[2352]: time="2025-05-15T23:31:09.047560835Z" level=info msg="Connect containerd service" May 15 23:31:09.047679 containerd[2352]: time="2025-05-15T23:31:09.047596275Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 15 23:31:09.049096 containerd[2352]: time="2025-05-15T23:31:09.049061314Z" 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" May 15 23:31:09.058628 containerd[2352]: time="2025-05-15T23:31:09.058556393Z" level=info msg="Start subscribing containerd event" May 15 23:31:09.058628 containerd[2352]: time="2025-05-15T23:31:09.058637273Z" level=info msg="Start recovering state" May 15 23:31:09.058753 containerd[2352]: time="2025-05-15T23:31:09.058686793Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 15 23:31:09.058753 containerd[2352]: time="2025-05-15T23:31:09.058722273Z" level=info msg="Start event monitor" May 15 23:31:09.058753 containerd[2352]: time="2025-05-15T23:31:09.058737353Z" level=info msg="Start cni network conf syncer for default" May 15 23:31:09.058753 containerd[2352]: time="2025-05-15T23:31:09.058751553Z" level=info msg="Start streaming server" May 15 23:31:09.058861 containerd[2352]: time="2025-05-15T23:31:09.058762353Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 15 23:31:09.058861 containerd[2352]: time="2025-05-15T23:31:09.058770993Z" level=info msg="runtime interface starting up..." May 15 23:31:09.058861 containerd[2352]: time="2025-05-15T23:31:09.058776473Z" level=info msg="starting plugins..." May 15 23:31:09.058861 containerd[2352]: time="2025-05-15T23:31:09.058787113Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 15 23:31:09.058861 containerd[2352]: time="2025-05-15T23:31:09.058736873Z" level=info msg=serving... address=/run/containerd/containerd.sock May 15 23:31:09.058955 containerd[2352]: time="2025-05-15T23:31:09.058920673Z" level=info msg="containerd successfully booted in 0.056664s" May 15 23:31:09.059047 systemd[1]: Started containerd.service - containerd container runtime. May 15 23:31:09.061172 systemd[1]: Starting docker.service - Docker Application Container Engine... May 15 23:31:09.077771 (dockerd)[2399]: 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 May 15 23:31:09.108663 dockerd[2399]: time="2025-05-15T23:31:09.108494987Z" level=info msg="Starting up" May 15 23:31:09.109264 dockerd[2399]: time="2025-05-15T23:31:09.109241347Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 15 23:31:09.136769 dockerd[2399]: time="2025-05-15T23:31:09.136703944Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 15 23:31:09.144668 dockerd[2399]: time="2025-05-15T23:31:09.144458663Z" level=info msg="Loading containers: start." May 15 23:31:09.167332 systemd[1]: var-lib-docker-overlay2-8cd545582d7f70ec17daa33a5cc327236865465286aba077398641173a6c0057-merged.mount: Deactivated successfully. May 15 23:31:09.512439 dockerd[2399]: time="2025-05-15T23:31:09.512316181Z" level=info msg="Removing stale sandbox 378b1885fe8d6b4d3d7e5f0a237d8e002c7d59493dcccae0e74bce0154fd883d (dbc9a8a2adb42e405527abab9840d3f946a5029a59e292a66ec726a69ca72acc)" May 15 23:31:09.515219 dockerd[2399]: time="2025-05-15T23:31:09.515149820Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint f581eae24b2bbaa57ba7c0bb90fd3b8a6dacd410ca6f1bb87be9455f934f8dd2 6cc5950793f835918e6e830bf27d8c3eecac467cd884684487c9edf9a94d0fa5], retrying...." May 15 23:31:09.524676 systemd-networkd[1325]: veth282a55d: Link DOWN May 15 23:31:09.524683 systemd-networkd[1325]: veth282a55d: Lost carrier May 15 23:31:09.525503 kernel: docker0: port 1(veth282a55d) entered disabled state May 15 23:31:09.525554 kernel: veth282a55d (unregistering): left allmulticast mode May 15 23:31:09.526720 kernel: veth282a55d (unregistering): left promiscuous mode May 15 23:31:09.526767 kernel: docker0: port 1(veth282a55d) entered disabled state May 15 23:31:09.542890 systemd-networkd[1325]: docker0: Lost carrier May 15 23:31:09.670961 dockerd[2399]: time="2025-05-15T23:31:09.670901282Z" 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" May 15 23:31:09.776299 dockerd[2399]: time="2025-05-15T23:31:09.776144430Z" level=warning msg="error locating sandbox id 46872ae503ebd8f146fffd9fb5975eb1e8619cb440590f1203a73eb02c6c1d5e: sandbox 46872ae503ebd8f146fffd9fb5975eb1e8619cb440590f1203a73eb02c6c1d5e not found" May 15 23:31:09.776299 dockerd[2399]: time="2025-05-15T23:31:09.776191390Z" level=warning msg="error locating sandbox id 378b1885fe8d6b4d3d7e5f0a237d8e002c7d59493dcccae0e74bce0154fd883d: sandbox 378b1885fe8d6b4d3d7e5f0a237d8e002c7d59493dcccae0e74bce0154fd883d not found" May 15 23:31:09.776585 dockerd[2399]: time="2025-05-15T23:31:09.776464950Z" level=info msg="Loading containers: done." May 15 23:31:09.790145 dockerd[2399]: time="2025-05-15T23:31:09.790090308Z" 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 May 15 23:31:09.790463 dockerd[2399]: time="2025-05-15T23:31:09.790180988Z" level=info msg="Docker daemon" commit=c710b88579fcb5e0d53f96dcae976d79323b9166 containerd-snapshotter=false storage-driver=overlay2 version=27.4.1 May 15 23:31:09.790463 dockerd[2399]: time="2025-05-15T23:31:09.790233508Z" level=info msg="Daemon has completed initialization" May 15 23:31:09.815545 dockerd[2399]: time="2025-05-15T23:31:09.815472026Z" level=info msg="API listen on /run/docker.sock" May 15 23:31:09.815710 systemd[1]: Started docker.service - Docker Application Container Engine. May 15 23:31:10.129558 systemd[1]: run-docker-netns-378b1885fe8d.mount: Deactivated successfully. May 15 23:31:13.329878 systemd[1]: Started sshd@24-10.0.0.63:22-10.0.0.1:46914.service - OpenSSH per-connection server daemon (10.0.0.1:46914). May 15 23:31:13.384209 sshd[2608]: Accepted publickey for core from 10.0.0.1 port 46914 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:31:13.385502 sshd-session[2608]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:31:13.395492 systemd-logind[1375]: New session 25 of user core. May 15 23:31:13.402832 systemd[1]: Started session-25.scope - Session 25 of User core. May 15 23:31:13.459063 sshd[2610]: Connection closed by 10.0.0.1 port 46914 May 15 23:31:13.460486 sshd-session[2608]: pam_unix(sshd:session): session closed for user core May 15 23:31:13.486723 systemd[1]: Started sshd@25-10.0.0.63:22-10.0.0.1:46924.service - OpenSSH per-connection server daemon (10.0.0.1:46924). May 15 23:31:13.487144 systemd[1]: sshd@24-10.0.0.63:22-10.0.0.1:46914.service: Deactivated successfully. May 15 23:31:13.489233 systemd[1]: session-25.scope: Deactivated successfully. May 15 23:31:13.491130 systemd-logind[1375]: Session 25 logged out. Waiting for processes to exit. May 15 23:31:13.493209 systemd-logind[1375]: Removed session 25. May 15 23:31:13.554846 sshd[2613]: Accepted publickey for core from 10.0.0.1 port 46924 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:31:13.554684 sshd-session[2613]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:31:13.560472 systemd-logind[1375]: New session 26 of user core. May 15 23:31:13.569576 systemd[1]: Started session-26.scope - Session 26 of User core. May 15 23:31:13.624021 sshd[2618]: Connection closed by 10.0.0.1 port 46924 May 15 23:31:13.625866 sshd-session[2613]: pam_unix(sshd:session): session closed for user core May 15 23:31:13.641348 systemd[1]: sshd@25-10.0.0.63:22-10.0.0.1:46924.service: Deactivated successfully. May 15 23:31:13.643022 systemd[1]: session-26.scope: Deactivated successfully. May 15 23:31:13.646146 systemd-logind[1375]: Session 26 logged out. Waiting for processes to exit. May 15 23:31:13.649577 systemd[1]: Started sshd@26-10.0.0.63:22-10.0.0.1:46934.service - OpenSSH per-connection server daemon (10.0.0.1:46934). May 15 23:31:13.653900 systemd-logind[1375]: Removed session 26. May 15 23:31:13.710052 sshd[2623]: Accepted publickey for core from 10.0.0.1 port 46934 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:31:13.711310 sshd-session[2623]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:31:13.715824 systemd-logind[1375]: New session 27 of user core. May 15 23:31:13.726602 systemd[1]: Started session-27.scope - Session 27 of User core. May 15 23:31:13.785613 sshd[2626]: Connection closed by 10.0.0.1 port 46934 May 15 23:31:13.785977 sshd-session[2623]: pam_unix(sshd:session): session closed for user core May 15 23:31:13.797568 systemd[1]: sshd@26-10.0.0.63:22-10.0.0.1:46934.service: Deactivated successfully. May 15 23:31:13.799623 systemd[1]: session-27.scope: Deactivated successfully. May 15 23:31:13.801366 systemd-logind[1375]: Session 27 logged out. Waiting for processes to exit. May 15 23:31:13.803490 systemd[1]: Started sshd@27-10.0.0.63:22-10.0.0.1:46938.service - OpenSSH per-connection server daemon (10.0.0.1:46938). May 15 23:31:13.804429 systemd-logind[1375]: Removed session 27. May 15 23:31:13.866324 sshd[2638]: Accepted publickey for core from 10.0.0.1 port 46938 ssh2: RSA SHA256:6GFLX06zIq6nlESG7l1+qHx7vN81iF4ij8UxPyFkEhg May 15 23:31:13.867687 sshd-session[2638]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 15 23:31:13.872415 systemd-logind[1375]: New session 28 of user core. May 15 23:31:13.883580 systemd[1]: Started session-28.scope - Session 28 of User core. May 15 23:31:14.109084 systemd[1]: var-lib-docker-overlay2-eceb6e3f5df5f80e9e4d4c1f41ebe5b621d67c12cb50012bbcc238df49326ba9\x2dinit-merged.mount: Deactivated successfully. May 15 23:31:14.343582 kernel: docker0: port 1(veth09b8305) entered blocking state May 15 23:31:14.343703 kernel: docker0: port 1(veth09b8305) entered disabled state May 15 23:31:14.343723 kernel: veth09b8305: entered allmulticast mode May 15 23:31:14.343752 kernel: veth09b8305: entered promiscuous mode May 15 23:31:14.344302 systemd-networkd[1325]: veth09b8305: Link UP May 15 23:31:14.398864 containerd[2352]: time="2025-05-15T23:31:14.398816655Z" level=info msg="connecting to shim dc974401031105c31e360d27e930a1d43a2b2f0fe384c7666030d1b0ef62f1a6" address="unix:///run/containerd/s/82e92920a8e6b31bf95446add720332f7d7d07df68d687f082a5f332949c64be" namespace=moby protocol=ttrpc version=3 May 15 23:31:14.426573 systemd[1]: Started docker-dc974401031105c31e360d27e930a1d43a2b2f0fe384c7666030d1b0ef62f1a6.scope - libcontainer container dc974401031105c31e360d27e930a1d43a2b2f0fe384c7666030d1b0ef62f1a6. May 15 23:31:14.480413 kernel: eth0: renamed from vethb9d6ed3 May 15 23:31:14.489084 systemd-networkd[1325]: veth09b8305: Gained carrier May 15 23:31:14.489287 systemd-networkd[1325]: docker0: Gained carrier May 15 23:31:14.489403 kernel: docker0: port 1(veth09b8305) entered blocking state May 15 23:31:14.489442 kernel: docker0: port 1(veth09b8305) entered forwarding state May 15 23:31:14.497058 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 15 23:31:14.525905 sshd[2641]: Connection closed by 10.0.0.1 port 46938 May 15 23:31:14.526426 sshd-session[2638]: pam_unix(sshd:session): session closed for user core May 15 23:31:14.528997 systemd[1]: sshd@27-10.0.0.63:22-10.0.0.1:46938.service: Deactivated successfully. May 15 23:31:14.530793 systemd[1]: session-28.scope: Deactivated successfully. May 15 23:31:14.532146 systemd-logind[1375]: Session 28 logged out. Waiting for processes to exit. May 15 23:31:14.533337 systemd-logind[1375]: Removed session 28.