May 27 03:05:22.787992 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 27 03:05:22.788020 kernel: Linux version 6.12.30-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 Tue May 27 01:20:04 -00 2025 May 27 03:05:22.788030 kernel: KASLR enabled May 27 03:05:22.788036 kernel: efi: EFI v2.7 by EDK II May 27 03:05:22.788041 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 May 27 03:05:22.788047 kernel: random: crng init done May 27 03:05:22.788053 kernel: secureboot: Secure boot disabled May 27 03:05:22.788059 kernel: ACPI: Early table checksum verification disabled May 27 03:05:22.788065 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) May 27 03:05:22.788072 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) May 27 03:05:22.788078 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788083 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788089 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788095 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788102 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788109 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788116 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788122 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788128 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 27 03:05:22.788134 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 27 03:05:22.788140 kernel: ACPI: Use ACPI SPCR as default console: Yes May 27 03:05:22.788146 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 27 03:05:22.788152 kernel: NODE_DATA(0) allocated [mem 0xdc964dc0-0xdc96bfff] May 27 03:05:22.788158 kernel: Zone ranges: May 27 03:05:22.788164 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 27 03:05:22.788172 kernel: DMA32 empty May 27 03:05:22.788178 kernel: Normal empty May 27 03:05:22.788183 kernel: Device empty May 27 03:05:22.788189 kernel: Movable zone start for each node May 27 03:05:22.788195 kernel: Early memory node ranges May 27 03:05:22.788201 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] May 27 03:05:22.788207 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] May 27 03:05:22.788213 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] May 27 03:05:22.788219 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] May 27 03:05:22.788225 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] May 27 03:05:22.788232 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] May 27 03:05:22.788238 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] May 27 03:05:22.788245 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] May 27 03:05:22.788251 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] May 27 03:05:22.788257 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] May 27 03:05:22.788266 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] May 27 03:05:22.788272 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] May 27 03:05:22.788279 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] May 27 03:05:22.788286 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 27 03:05:22.788293 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 27 03:05:22.788299 kernel: psci: probing for conduit method from ACPI. May 27 03:05:22.788306 kernel: psci: PSCIv1.1 detected in firmware. May 27 03:05:22.788312 kernel: psci: Using standard PSCI v0.2 function IDs May 27 03:05:22.788318 kernel: psci: Trusted OS migration not required May 27 03:05:22.788325 kernel: psci: SMC Calling Convention v1.1 May 27 03:05:22.788335 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 27 03:05:22.788342 kernel: percpu: Embedded 33 pages/cpu s98136 r8192 d28840 u135168 May 27 03:05:22.788348 kernel: pcpu-alloc: s98136 r8192 d28840 u135168 alloc=33*4096 May 27 03:05:22.788356 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 27 03:05:22.788362 kernel: Detected PIPT I-cache on CPU0 May 27 03:05:22.788369 kernel: CPU features: detected: GIC system register CPU interface May 27 03:05:22.788375 kernel: CPU features: detected: Spectre-v4 May 27 03:05:22.788381 kernel: CPU features: detected: Spectre-BHB May 27 03:05:22.788388 kernel: CPU features: kernel page table isolation forced ON by KASLR May 27 03:05:22.788394 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 27 03:05:22.788401 kernel: CPU features: detected: ARM erratum 1418040 May 27 03:05:22.788407 kernel: CPU features: detected: SSBS not fully self-synchronizing May 27 03:05:22.788414 kernel: alternatives: applying boot alternatives May 27 03:05:22.788421 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=4c3f98aae7a61b3dcbab6391ba922461adab29dbcb79fd6e18169f93c5a4ab5a May 27 03:05:22.788429 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 27 03:05:22.788435 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 27 03:05:22.788442 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 27 03:05:22.788448 kernel: Fallback order for Node 0: 0 May 27 03:05:22.788454 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 May 27 03:05:22.788461 kernel: Policy zone: DMA May 27 03:05:22.788467 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 27 03:05:22.788474 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB May 27 03:05:22.788480 kernel: software IO TLB: area num 4. May 27 03:05:22.788486 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB May 27 03:05:22.788493 kernel: software IO TLB: mapped [mem 0x00000000d8c00000-0x00000000d9000000] (4MB) May 27 03:05:22.788499 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 27 03:05:22.788507 kernel: rcu: Preemptible hierarchical RCU implementation. May 27 03:05:22.788514 kernel: rcu: RCU event tracing is enabled. May 27 03:05:22.788520 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 27 03:05:22.788527 kernel: Trampoline variant of Tasks RCU enabled. May 27 03:05:22.788533 kernel: Tracing variant of Tasks RCU enabled. May 27 03:05:22.788540 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 27 03:05:22.788546 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 27 03:05:22.788552 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 27 03:05:22.788559 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 27 03:05:22.788565 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 27 03:05:22.788572 kernel: GICv3: 256 SPIs implemented May 27 03:05:22.788579 kernel: GICv3: 0 Extended SPIs implemented May 27 03:05:22.788586 kernel: Root IRQ handler: gic_handle_irq May 27 03:05:22.788592 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI May 27 03:05:22.788598 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 May 27 03:05:22.788605 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 27 03:05:22.788611 kernel: ITS [mem 0x08080000-0x0809ffff] May 27 03:05:22.788618 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) May 27 03:05:22.788624 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) May 27 03:05:22.788631 kernel: GICv3: using LPI property table @0x00000000400f0000 May 27 03:05:22.788637 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040110000 May 27 03:05:22.788644 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 27 03:05:22.788650 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 27 03:05:22.788658 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 27 03:05:22.788664 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 27 03:05:22.788671 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 27 03:05:22.788677 kernel: arm-pv: using stolen time PV May 27 03:05:22.788684 kernel: Console: colour dummy device 80x25 May 27 03:05:22.788690 kernel: ACPI: Core revision 20240827 May 27 03:05:22.788697 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 27 03:05:22.788703 kernel: pid_max: default: 32768 minimum: 301 May 27 03:05:22.788710 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 27 03:05:22.788718 kernel: landlock: Up and running. May 27 03:05:22.788724 kernel: SELinux: Initializing. May 27 03:05:22.788731 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 27 03:05:22.788737 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 27 03:05:22.788744 kernel: rcu: Hierarchical SRCU implementation. May 27 03:05:22.788751 kernel: rcu: Max phase no-delay instances is 400. May 27 03:05:22.788757 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 27 03:05:22.788773 kernel: Remapping and enabling EFI services. May 27 03:05:22.788780 kernel: smp: Bringing up secondary CPUs ... May 27 03:05:22.788787 kernel: Detected PIPT I-cache on CPU1 May 27 03:05:22.788799 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 27 03:05:22.788806 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040120000 May 27 03:05:22.788814 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 27 03:05:22.788821 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 27 03:05:22.788828 kernel: Detected PIPT I-cache on CPU2 May 27 03:05:22.788835 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 27 03:05:22.788842 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040130000 May 27 03:05:22.788851 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 27 03:05:22.788858 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 27 03:05:22.788865 kernel: Detected PIPT I-cache on CPU3 May 27 03:05:22.788872 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 27 03:05:22.788879 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040140000 May 27 03:05:22.788886 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 27 03:05:22.788893 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 27 03:05:22.788899 kernel: smp: Brought up 1 node, 4 CPUs May 27 03:05:22.788906 kernel: SMP: Total of 4 processors activated. May 27 03:05:22.788913 kernel: CPU: All CPU(s) started at EL1 May 27 03:05:22.788921 kernel: CPU features: detected: 32-bit EL0 Support May 27 03:05:22.788928 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 27 03:05:22.788935 kernel: CPU features: detected: Common not Private translations May 27 03:05:22.788942 kernel: CPU features: detected: CRC32 instructions May 27 03:05:22.788949 kernel: CPU features: detected: Enhanced Virtualization Traps May 27 03:05:22.788956 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 27 03:05:22.788963 kernel: CPU features: detected: LSE atomic instructions May 27 03:05:22.788969 kernel: CPU features: detected: Privileged Access Never May 27 03:05:22.788976 kernel: CPU features: detected: RAS Extension Support May 27 03:05:22.788985 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 27 03:05:22.788992 kernel: alternatives: applying system-wide alternatives May 27 03:05:22.788999 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 May 27 03:05:22.789006 kernel: Memory: 2440980K/2572288K available (11072K kernel code, 2276K rwdata, 8936K rodata, 39424K init, 1034K bss, 125540K reserved, 0K cma-reserved) May 27 03:05:22.789018 kernel: devtmpfs: initialized May 27 03:05:22.789025 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 27 03:05:22.789032 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 27 03:05:22.789039 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL May 27 03:05:22.789046 kernel: 0 pages in range for non-PLT usage May 27 03:05:22.789055 kernel: 508544 pages in range for PLT usage May 27 03:05:22.789062 kernel: pinctrl core: initialized pinctrl subsystem May 27 03:05:22.789069 kernel: SMBIOS 3.0.0 present. May 27 03:05:22.789076 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 May 27 03:05:22.789082 kernel: DMI: Memory slots populated: 1/1 May 27 03:05:22.789090 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 27 03:05:22.789097 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 27 03:05:22.789104 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 27 03:05:22.789111 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 27 03:05:22.789119 kernel: audit: initializing netlink subsys (disabled) May 27 03:05:22.789126 kernel: audit: type=2000 audit(0.029:1): state=initialized audit_enabled=0 res=1 May 27 03:05:22.789133 kernel: thermal_sys: Registered thermal governor 'step_wise' May 27 03:05:22.789139 kernel: cpuidle: using governor menu May 27 03:05:22.789146 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 27 03:05:22.789153 kernel: ASID allocator initialised with 32768 entries May 27 03:05:22.789160 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 27 03:05:22.789167 kernel: Serial: AMBA PL011 UART driver May 27 03:05:22.789174 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 27 03:05:22.789182 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 27 03:05:22.789189 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 27 03:05:22.789195 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 27 03:05:22.789202 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 27 03:05:22.789209 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 27 03:05:22.789216 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 27 03:05:22.789223 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 27 03:05:22.789230 kernel: ACPI: Added _OSI(Module Device) May 27 03:05:22.789237 kernel: ACPI: Added _OSI(Processor Device) May 27 03:05:22.789245 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 27 03:05:22.789252 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 27 03:05:22.789259 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 27 03:05:22.789266 kernel: ACPI: Interpreter enabled May 27 03:05:22.789273 kernel: ACPI: Using GIC for interrupt routing May 27 03:05:22.789279 kernel: ACPI: MCFG table detected, 1 entries May 27 03:05:22.789286 kernel: ACPI: CPU0 has been hot-added May 27 03:05:22.789293 kernel: ACPI: CPU1 has been hot-added May 27 03:05:22.789300 kernel: ACPI: CPU2 has been hot-added May 27 03:05:22.789307 kernel: ACPI: CPU3 has been hot-added May 27 03:05:22.789315 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 27 03:05:22.789322 kernel: printk: legacy console [ttyAMA0] enabled May 27 03:05:22.789328 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 27 03:05:22.789456 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 27 03:05:22.789524 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 27 03:05:22.789585 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 27 03:05:22.789646 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 27 03:05:22.789723 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 27 03:05:22.789732 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 27 03:05:22.789740 kernel: PCI host bridge to bus 0000:00 May 27 03:05:22.789825 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 27 03:05:22.789887 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 27 03:05:22.789942 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 27 03:05:22.789996 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 27 03:05:22.790081 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint May 27 03:05:22.790154 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint May 27 03:05:22.790218 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] May 27 03:05:22.790281 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] May 27 03:05:22.790349 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] May 27 03:05:22.790410 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned May 27 03:05:22.790474 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned May 27 03:05:22.790540 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned May 27 03:05:22.790595 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 27 03:05:22.790651 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 27 03:05:22.790708 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 27 03:05:22.790717 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 27 03:05:22.790724 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 27 03:05:22.790731 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 27 03:05:22.790740 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 27 03:05:22.790747 kernel: iommu: Default domain type: Translated May 27 03:05:22.790754 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 27 03:05:22.790769 kernel: efivars: Registered efivars operations May 27 03:05:22.790777 kernel: vgaarb: loaded May 27 03:05:22.790784 kernel: clocksource: Switched to clocksource arch_sys_counter May 27 03:05:22.790791 kernel: VFS: Disk quotas dquot_6.6.0 May 27 03:05:22.790798 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 27 03:05:22.790805 kernel: pnp: PnP ACPI init May 27 03:05:22.790882 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 27 03:05:22.790892 kernel: pnp: PnP ACPI: found 1 devices May 27 03:05:22.790899 kernel: NET: Registered PF_INET protocol family May 27 03:05:22.790906 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 27 03:05:22.790913 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 27 03:05:22.790920 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 27 03:05:22.790927 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 27 03:05:22.790934 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 27 03:05:22.790943 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 27 03:05:22.790950 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 27 03:05:22.790957 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 27 03:05:22.790964 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 27 03:05:22.790971 kernel: PCI: CLS 0 bytes, default 64 May 27 03:05:22.790978 kernel: kvm [1]: HYP mode not available May 27 03:05:22.790985 kernel: Initialise system trusted keyrings May 27 03:05:22.790993 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 27 03:05:22.791000 kernel: Key type asymmetric registered May 27 03:05:22.791013 kernel: Asymmetric key parser 'x509' registered May 27 03:05:22.791021 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) May 27 03:05:22.791028 kernel: io scheduler mq-deadline registered May 27 03:05:22.791035 kernel: io scheduler kyber registered May 27 03:05:22.791042 kernel: io scheduler bfq registered May 27 03:05:22.791049 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 27 03:05:22.791056 kernel: ACPI: button: Power Button [PWRB] May 27 03:05:22.791063 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 27 03:05:22.791130 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 27 03:05:22.791141 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 27 03:05:22.791148 kernel: thunder_xcv, ver 1.0 May 27 03:05:22.791155 kernel: thunder_bgx, ver 1.0 May 27 03:05:22.791162 kernel: nicpf, ver 1.0 May 27 03:05:22.791169 kernel: nicvf, ver 1.0 May 27 03:05:22.791239 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 27 03:05:22.791299 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-27T03:05:22 UTC (1748315122) May 27 03:05:22.791308 kernel: hid: raw HID events driver (C) Jiri Kosina May 27 03:05:22.791317 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available May 27 03:05:22.791324 kernel: watchdog: NMI not fully supported May 27 03:05:22.791331 kernel: watchdog: Hard watchdog permanently disabled May 27 03:05:22.791338 kernel: NET: Registered PF_INET6 protocol family May 27 03:05:22.791345 kernel: Segment Routing with IPv6 May 27 03:05:22.791351 kernel: In-situ OAM (IOAM) with IPv6 May 27 03:05:22.791358 kernel: NET: Registered PF_PACKET protocol family May 27 03:05:22.791365 kernel: Key type dns_resolver registered May 27 03:05:22.791372 kernel: registered taskstats version 1 May 27 03:05:22.791379 kernel: Loading compiled-in X.509 certificates May 27 03:05:22.791387 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.30-flatcar: 6bbf5412ef1f8a32378a640b6d048f74e6d74df0' May 27 03:05:22.791394 kernel: Demotion targets for Node 0: null May 27 03:05:22.791401 kernel: Key type .fscrypt registered May 27 03:05:22.791408 kernel: Key type fscrypt-provisioning registered May 27 03:05:22.791415 kernel: ima: No TPM chip found, activating TPM-bypass! May 27 03:05:22.791422 kernel: ima: Allocated hash algorithm: sha1 May 27 03:05:22.791428 kernel: ima: No architecture policies found May 27 03:05:22.791435 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 27 03:05:22.791444 kernel: clk: Disabling unused clocks May 27 03:05:22.791451 kernel: PM: genpd: Disabling unused power domains May 27 03:05:22.791458 kernel: Warning: unable to open an initial console. May 27 03:05:22.791464 kernel: Freeing unused kernel memory: 39424K May 27 03:05:22.791471 kernel: Run /init as init process May 27 03:05:22.791478 kernel: with arguments: May 27 03:05:22.791485 kernel: /init May 27 03:05:22.791492 kernel: with environment: May 27 03:05:22.791498 kernel: HOME=/ May 27 03:05:22.791506 kernel: TERM=linux May 27 03:05:22.791513 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 27 03:05:22.791521 systemd[1]: Successfully made /usr/ read-only. May 27 03:05:22.791531 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 27 03:05:22.791539 systemd[1]: Detected virtualization kvm. May 27 03:05:22.791546 systemd[1]: Detected architecture arm64. May 27 03:05:22.791553 systemd[1]: Running in initrd. May 27 03:05:22.791561 systemd[1]: No hostname configured, using default hostname. May 27 03:05:22.791570 systemd[1]: Hostname set to . May 27 03:05:22.791577 systemd[1]: Initializing machine ID from VM UUID. May 27 03:05:22.791584 systemd[1]: Queued start job for default target initrd.target. May 27 03:05:22.791592 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 27 03:05:22.791599 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 27 03:05:22.791607 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 27 03:05:22.791615 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 27 03:05:22.791622 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 27 03:05:22.791632 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 27 03:05:22.791640 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 27 03:05:22.791648 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 27 03:05:22.791655 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 27 03:05:22.791663 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 27 03:05:22.791670 systemd[1]: Reached target paths.target - Path Units. May 27 03:05:22.791678 systemd[1]: Reached target slices.target - Slice Units. May 27 03:05:22.791687 systemd[1]: Reached target swap.target - Swaps. May 27 03:05:22.791694 systemd[1]: Reached target timers.target - Timer Units. May 27 03:05:22.791701 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 27 03:05:22.791709 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 27 03:05:22.791716 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 27 03:05:22.791724 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 27 03:05:22.791731 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 27 03:05:22.791739 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 27 03:05:22.791747 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 27 03:05:22.791755 systemd[1]: Reached target sockets.target - Socket Units. May 27 03:05:22.791794 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 27 03:05:22.791802 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 27 03:05:22.791810 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 27 03:05:22.791817 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). May 27 03:05:22.791825 systemd[1]: Starting systemd-fsck-usr.service... May 27 03:05:22.791832 systemd[1]: Starting systemd-journald.service - Journal Service... May 27 03:05:22.791840 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 27 03:05:22.791850 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 03:05:22.791857 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 27 03:05:22.791865 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 27 03:05:22.791873 systemd[1]: Finished systemd-fsck-usr.service. May 27 03:05:22.791881 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 27 03:05:22.791905 systemd-journald[242]: Collecting audit messages is disabled. May 27 03:05:22.791923 systemd-journald[242]: Journal started May 27 03:05:22.791943 systemd-journald[242]: Runtime Journal (/run/log/journal/dc0a1dfa5cea4a2d815702c897a99531) is 6M, max 48.5M, 42.4M free. May 27 03:05:22.781381 systemd-modules-load[244]: Inserted module 'overlay' May 27 03:05:22.793265 systemd[1]: Started systemd-journald.service - Journal Service. May 27 03:05:22.795216 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 27 03:05:22.796521 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 27 03:05:22.801004 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 27 03:05:22.801505 systemd-modules-load[244]: Inserted module 'br_netfilter' May 27 03:05:22.802394 kernel: Bridge firewalling registered May 27 03:05:22.801740 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 27 03:05:22.804036 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 27 03:05:22.812244 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 27 03:05:22.813727 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 27 03:05:22.816776 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 27 03:05:22.822275 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 03:05:22.823716 systemd-tmpfiles[266]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 27 03:05:22.826753 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 03:05:22.830550 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 27 03:05:22.832655 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 27 03:05:22.835389 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 27 03:05:22.837394 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 27 03:05:22.857467 dracut-cmdline[286]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=4c3f98aae7a61b3dcbab6391ba922461adab29dbcb79fd6e18169f93c5a4ab5a May 27 03:05:22.872663 systemd-resolved[287]: Positive Trust Anchors: May 27 03:05:22.872680 systemd-resolved[287]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 27 03:05:22.872711 systemd-resolved[287]: 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 27 03:05:22.877430 systemd-resolved[287]: Defaulting to hostname 'linux'. May 27 03:05:22.878349 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 27 03:05:22.879700 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 27 03:05:22.929800 kernel: SCSI subsystem initialized May 27 03:05:22.934780 kernel: Loading iSCSI transport class v2.0-870. May 27 03:05:22.943789 kernel: iscsi: registered transport (tcp) May 27 03:05:22.955931 kernel: iscsi: registered transport (qla4xxx) May 27 03:05:22.955948 kernel: QLogic iSCSI HBA Driver May 27 03:05:22.971559 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 27 03:05:22.986675 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 27 03:05:22.988820 systemd[1]: Reached target network-pre.target - Preparation for Network. May 27 03:05:23.029280 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 27 03:05:23.031579 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 27 03:05:23.092825 kernel: raid6: neonx8 gen() 15769 MB/s May 27 03:05:23.109781 kernel: raid6: neonx4 gen() 15776 MB/s May 27 03:05:23.126789 kernel: raid6: neonx2 gen() 13182 MB/s May 27 03:05:23.143779 kernel: raid6: neonx1 gen() 10523 MB/s May 27 03:05:23.160780 kernel: raid6: int64x8 gen() 6900 MB/s May 27 03:05:23.177777 kernel: raid6: int64x4 gen() 7343 MB/s May 27 03:05:23.194778 kernel: raid6: int64x2 gen() 6098 MB/s May 27 03:05:23.211778 kernel: raid6: int64x1 gen() 5059 MB/s May 27 03:05:23.211804 kernel: raid6: using algorithm neonx4 gen() 15776 MB/s May 27 03:05:23.228804 kernel: raid6: .... xor() 12383 MB/s, rmw enabled May 27 03:05:23.228841 kernel: raid6: using neon recovery algorithm May 27 03:05:23.233902 kernel: xor: measuring software checksum speed May 27 03:05:23.233924 kernel: 8regs : 21613 MB/sec May 27 03:05:23.235015 kernel: 32regs : 21052 MB/sec May 27 03:05:23.235042 kernel: arm64_neon : 28118 MB/sec May 27 03:05:23.235059 kernel: xor: using function: arm64_neon (28118 MB/sec) May 27 03:05:23.289799 kernel: Btrfs loaded, zoned=no, fsverity=no May 27 03:05:23.295732 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 27 03:05:23.298301 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 03:05:23.323458 systemd-udevd[497]: Using default interface naming scheme 'v255'. May 27 03:05:23.327590 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 03:05:23.329923 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 27 03:05:23.357904 dracut-pre-trigger[505]: rd.md=0: removing MD RAID activation May 27 03:05:23.379903 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 27 03:05:23.382150 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 27 03:05:23.437455 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 27 03:05:23.439920 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 27 03:05:23.483410 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues May 27 03:05:23.483571 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 27 03:05:23.486818 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 03:05:23.491027 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 27 03:05:23.491153 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 27 03:05:23.494365 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 27 03:05:23.496869 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 03:05:23.521666 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 27 03:05:23.529356 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 27 03:05:23.537399 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 27 03:05:23.538631 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 27 03:05:23.551740 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 27 03:05:23.558498 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 27 03:05:23.559399 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 27 03:05:23.562055 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 27 03:05:23.563925 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 27 03:05:23.565682 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 27 03:05:23.568192 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 27 03:05:23.570028 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 27 03:05:23.598787 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 03:05:23.600576 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 27 03:05:24.608788 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 03:05:24.609190 disk-uuid[593]: The operation has completed successfully. May 27 03:05:24.635030 systemd[1]: disk-uuid.service: Deactivated successfully. May 27 03:05:24.635143 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 27 03:05:24.659070 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 27 03:05:24.682707 sh[611]: Success May 27 03:05:24.697127 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 27 03:05:24.697166 kernel: device-mapper: uevent: version 1.0.3 May 27 03:05:24.697187 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 27 03:05:24.705778 kernel: device-mapper: verity: sha256 using shash "sha256-ce" May 27 03:05:24.740892 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 27 03:05:24.743445 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 27 03:05:24.762008 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 27 03:05:24.768959 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' May 27 03:05:24.769015 kernel: BTRFS: device fsid 5c6341ea-4eb5-44b6-ac57-c4d29847e384 devid 1 transid 41 /dev/mapper/usr (253:0) scanned by mount (623) May 27 03:05:24.770186 kernel: BTRFS info (device dm-0): first mount of filesystem 5c6341ea-4eb5-44b6-ac57-c4d29847e384 May 27 03:05:24.770213 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 27 03:05:24.771778 kernel: BTRFS info (device dm-0): using free-space-tree May 27 03:05:24.776403 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 27 03:05:24.777476 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 27 03:05:24.778715 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 27 03:05:24.779517 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 27 03:05:24.780939 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 27 03:05:24.799815 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (654) May 27 03:05:24.799859 kernel: BTRFS info (device vda6): first mount of filesystem eabe2c18-04ac-4289-8962-26387aada3f9 May 27 03:05:24.801284 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 27 03:05:24.801317 kernel: BTRFS info (device vda6): using free-space-tree May 27 03:05:24.808784 kernel: BTRFS info (device vda6): last unmount of filesystem eabe2c18-04ac-4289-8962-26387aada3f9 May 27 03:05:24.809878 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 27 03:05:24.811665 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 27 03:05:24.877901 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 27 03:05:24.880922 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 27 03:05:24.929336 systemd-networkd[799]: lo: Link UP May 27 03:05:24.930161 systemd-networkd[799]: lo: Gained carrier May 27 03:05:24.931663 systemd-networkd[799]: Enumeration completed May 27 03:05:24.932421 systemd[1]: Started systemd-networkd.service - Network Configuration. May 27 03:05:24.933100 systemd-networkd[799]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 03:05:24.933104 systemd-networkd[799]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 27 03:05:24.934730 systemd[1]: Reached target network.target - Network. May 27 03:05:24.935545 systemd-networkd[799]: eth0: Link UP May 27 03:05:24.935549 systemd-networkd[799]: eth0: Gained carrier May 27 03:05:24.935558 systemd-networkd[799]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 03:05:24.959851 systemd-networkd[799]: eth0: DHCPv4 address 10.0.0.133/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 27 03:05:24.965015 ignition[699]: Ignition 2.21.0 May 27 03:05:24.965028 ignition[699]: Stage: fetch-offline May 27 03:05:24.965058 ignition[699]: no configs at "/usr/lib/ignition/base.d" May 27 03:05:24.965066 ignition[699]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 03:05:24.965298 ignition[699]: parsed url from cmdline: "" May 27 03:05:24.965302 ignition[699]: no config URL provided May 27 03:05:24.965306 ignition[699]: reading system config file "/usr/lib/ignition/user.ign" May 27 03:05:24.965315 ignition[699]: no config at "/usr/lib/ignition/user.ign" May 27 03:05:24.965333 ignition[699]: op(1): [started] loading QEMU firmware config module May 27 03:05:24.965338 ignition[699]: op(1): executing: "modprobe" "qemu_fw_cfg" May 27 03:05:24.972810 ignition[699]: op(1): [finished] loading QEMU firmware config module May 27 03:05:24.972835 ignition[699]: QEMU firmware config was not found. Ignoring... May 27 03:05:24.977174 ignition[699]: parsing config with SHA512: 115a5bcb715ff4e58d32ebaacb3f2029eb1826189d38701793a446fc945c26a3ee994af53e410fe374090f31b1673c4acc60f67bcdb8374c580489bd403a10aa May 27 03:05:24.981869 unknown[699]: fetched base config from "system" May 27 03:05:24.981879 unknown[699]: fetched user config from "qemu" May 27 03:05:24.982048 ignition[699]: fetch-offline: fetch-offline passed May 27 03:05:24.982130 ignition[699]: Ignition finished successfully May 27 03:05:24.984827 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 27 03:05:24.986238 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 27 03:05:24.987028 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 27 03:05:25.019982 ignition[812]: Ignition 2.21.0 May 27 03:05:25.019995 ignition[812]: Stage: kargs May 27 03:05:25.020156 ignition[812]: no configs at "/usr/lib/ignition/base.d" May 27 03:05:25.020166 ignition[812]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 03:05:25.022861 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 27 03:05:25.020679 ignition[812]: kargs: kargs passed May 27 03:05:25.020723 ignition[812]: Ignition finished successfully May 27 03:05:25.025191 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 27 03:05:25.061865 ignition[820]: Ignition 2.21.0 May 27 03:05:25.061881 ignition[820]: Stage: disks May 27 03:05:25.062029 ignition[820]: no configs at "/usr/lib/ignition/base.d" May 27 03:05:25.062039 ignition[820]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 03:05:25.064507 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 27 03:05:25.062520 ignition[820]: disks: disks passed May 27 03:05:25.066367 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 27 03:05:25.062563 ignition[820]: Ignition finished successfully May 27 03:05:25.068173 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 27 03:05:25.070081 systemd[1]: Reached target local-fs.target - Local File Systems. May 27 03:05:25.071525 systemd[1]: Reached target sysinit.target - System Initialization. May 27 03:05:25.073355 systemd[1]: Reached target basic.target - Basic System. May 27 03:05:25.075666 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 27 03:05:25.105136 systemd-fsck[830]: ROOT: clean, 15/553520 files, 52789/553472 blocks May 27 03:05:25.109686 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 27 03:05:25.112104 systemd[1]: Mounting sysroot.mount - /sysroot... May 27 03:05:25.187801 kernel: EXT4-fs (vda9): mounted filesystem 5656cec4-efbd-4a2d-be98-2263e6ae16bd r/w with ordered data mode. Quota mode: none. May 27 03:05:25.188444 systemd[1]: Mounted sysroot.mount - /sysroot. May 27 03:05:25.189714 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 27 03:05:25.192196 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 27 03:05:25.193900 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 27 03:05:25.194894 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 27 03:05:25.194953 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 27 03:05:25.194978 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 27 03:05:25.208689 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 27 03:05:25.211252 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 27 03:05:25.215445 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (838) May 27 03:05:25.215476 kernel: BTRFS info (device vda6): first mount of filesystem eabe2c18-04ac-4289-8962-26387aada3f9 May 27 03:05:25.215487 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 27 03:05:25.216774 kernel: BTRFS info (device vda6): using free-space-tree May 27 03:05:25.220296 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 27 03:05:25.259889 initrd-setup-root[862]: cut: /sysroot/etc/passwd: No such file or directory May 27 03:05:25.263796 initrd-setup-root[869]: cut: /sysroot/etc/group: No such file or directory May 27 03:05:25.267735 initrd-setup-root[876]: cut: /sysroot/etc/shadow: No such file or directory May 27 03:05:25.270543 initrd-setup-root[883]: cut: /sysroot/etc/gshadow: No such file or directory May 27 03:05:25.347830 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 27 03:05:25.349595 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 27 03:05:25.351897 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 27 03:05:25.372797 kernel: BTRFS info (device vda6): last unmount of filesystem eabe2c18-04ac-4289-8962-26387aada3f9 May 27 03:05:25.388888 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 27 03:05:25.400201 ignition[952]: INFO : Ignition 2.21.0 May 27 03:05:25.400201 ignition[952]: INFO : Stage: mount May 27 03:05:25.402850 ignition[952]: INFO : no configs at "/usr/lib/ignition/base.d" May 27 03:05:25.402850 ignition[952]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 03:05:25.402850 ignition[952]: INFO : mount: mount passed May 27 03:05:25.402850 ignition[952]: INFO : Ignition finished successfully May 27 03:05:25.403109 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 27 03:05:25.406665 systemd[1]: Starting ignition-files.service - Ignition (files)... May 27 03:05:25.777160 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 27 03:05:25.778628 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 27 03:05:25.811013 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (964) May 27 03:05:25.811048 kernel: BTRFS info (device vda6): first mount of filesystem eabe2c18-04ac-4289-8962-26387aada3f9 May 27 03:05:25.811059 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 27 03:05:25.812142 kernel: BTRFS info (device vda6): using free-space-tree May 27 03:05:25.814563 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 27 03:05:25.837205 ignition[981]: INFO : Ignition 2.21.0 May 27 03:05:25.837205 ignition[981]: INFO : Stage: files May 27 03:05:25.839461 ignition[981]: INFO : no configs at "/usr/lib/ignition/base.d" May 27 03:05:25.839461 ignition[981]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 03:05:25.839461 ignition[981]: DEBUG : files: compiled without relabeling support, skipping May 27 03:05:25.842851 ignition[981]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 27 03:05:25.842851 ignition[981]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 27 03:05:25.842851 ignition[981]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 27 03:05:25.842851 ignition[981]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 27 03:05:25.842851 ignition[981]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 27 03:05:25.841943 unknown[981]: wrote ssh authorized keys file for user: core May 27 03:05:25.850829 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 27 03:05:25.850829 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 27 03:05:25.850829 ignition[981]: INFO : files: op(4): [started] processing unit "docker.service" May 27 03:05:25.850829 ignition[981]: INFO : files: op(4): [finished] processing unit "docker.service" May 27 03:05:25.850829 ignition[981]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" May 27 03:05:25.850829 ignition[981]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 27 03:05:25.850829 ignition[981]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 27 03:05:25.850829 ignition[981]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" May 27 03:05:25.850829 ignition[981]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" May 27 03:05:25.866159 ignition[981]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" May 27 03:05:25.869330 ignition[981]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 27 03:05:25.870784 ignition[981]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" May 27 03:05:25.870784 ignition[981]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" May 27 03:05:25.870784 ignition[981]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" May 27 03:05:25.870784 ignition[981]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 27 03:05:25.870784 ignition[981]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 27 03:05:25.870784 ignition[981]: INFO : files: files passed May 27 03:05:25.870784 ignition[981]: INFO : Ignition finished successfully May 27 03:05:25.871403 systemd[1]: Finished ignition-files.service - Ignition (files). May 27 03:05:25.873883 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 27 03:05:25.875781 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 27 03:05:25.886715 systemd[1]: ignition-quench.service: Deactivated successfully. May 27 03:05:25.886825 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 27 03:05:25.889882 initrd-setup-root-after-ignition[1009]: grep: /sysroot/oem/oem-release: No such file or directory May 27 03:05:25.891155 initrd-setup-root-after-ignition[1011]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 27 03:05:25.891155 initrd-setup-root-after-ignition[1011]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 27 03:05:25.896236 initrd-setup-root-after-ignition[1016]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 27 03:05:25.892519 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 27 03:05:25.893917 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 27 03:05:25.895605 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 27 03:05:25.940383 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 27 03:05:25.940490 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 27 03:05:25.942460 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 27 03:05:25.944030 systemd[1]: Reached target initrd.target - Initrd Default Target. May 27 03:05:25.945532 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 27 03:05:25.946292 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 27 03:05:25.971971 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 27 03:05:25.973978 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 27 03:05:25.991464 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 27 03:05:25.992402 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 27 03:05:25.994106 systemd[1]: Stopped target timers.target - Timer Units. May 27 03:05:25.995605 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 27 03:05:25.995714 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 27 03:05:25.997912 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 27 03:05:25.999585 systemd[1]: Stopped target basic.target - Basic System. May 27 03:05:26.001024 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 27 03:05:26.002619 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 27 03:05:26.004268 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 27 03:05:26.005894 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 27 03:05:26.007500 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 27 03:05:26.009061 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 27 03:05:26.010633 systemd[1]: Stopped target sysinit.target - System Initialization. May 27 03:05:26.012434 systemd[1]: Stopped target local-fs.target - Local File Systems. May 27 03:05:26.013883 systemd[1]: Stopped target swap.target - Swaps. May 27 03:05:26.015166 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 27 03:05:26.015280 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 27 03:05:26.017352 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 27 03:05:26.019016 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 27 03:05:26.020423 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 27 03:05:26.020497 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 27 03:05:26.021918 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 27 03:05:26.022029 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 27 03:05:26.024046 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 27 03:05:26.024157 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 27 03:05:26.025606 systemd[1]: Stopped target paths.target - Path Units. May 27 03:05:26.026702 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 27 03:05:26.030809 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 27 03:05:26.031797 systemd[1]: Stopped target slices.target - Slice Units. May 27 03:05:26.033608 systemd[1]: Stopped target sockets.target - Socket Units. May 27 03:05:26.034920 systemd[1]: iscsid.socket: Deactivated successfully. May 27 03:05:26.034996 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 27 03:05:26.036283 systemd[1]: iscsiuio.socket: Deactivated successfully. May 27 03:05:26.036356 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 27 03:05:26.037705 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 27 03:05:26.037832 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 27 03:05:26.039280 systemd[1]: ignition-files.service: Deactivated successfully. May 27 03:05:26.039364 systemd[1]: Stopped ignition-files.service - Ignition (files). May 27 03:05:26.041395 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 27 03:05:26.043022 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 27 03:05:26.043136 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 27 03:05:26.063077 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 27 03:05:26.063698 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 27 03:05:26.063828 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 27 03:05:26.065385 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 27 03:05:26.065470 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 27 03:05:26.071603 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 27 03:05:26.072347 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 27 03:05:26.074850 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 27 03:05:26.077401 systemd[1]: sysroot-boot.service: Deactivated successfully. May 27 03:05:26.077498 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 27 03:05:26.080433 ignition[1038]: INFO : Ignition 2.21.0 May 27 03:05:26.080433 ignition[1038]: INFO : Stage: umount May 27 03:05:26.080433 ignition[1038]: INFO : no configs at "/usr/lib/ignition/base.d" May 27 03:05:26.080433 ignition[1038]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 03:05:26.080433 ignition[1038]: INFO : umount: umount passed May 27 03:05:26.080433 ignition[1038]: INFO : Ignition finished successfully May 27 03:05:26.081735 systemd[1]: ignition-mount.service: Deactivated successfully. May 27 03:05:26.081842 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 27 03:05:26.082799 systemd[1]: Stopped target network.target - Network. May 27 03:05:26.084034 systemd[1]: ignition-disks.service: Deactivated successfully. May 27 03:05:26.084084 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 27 03:05:26.085670 systemd[1]: ignition-kargs.service: Deactivated successfully. May 27 03:05:26.085708 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 27 03:05:26.086996 systemd[1]: ignition-setup.service: Deactivated successfully. May 27 03:05:26.087047 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 27 03:05:26.088404 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 27 03:05:26.088436 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 27 03:05:26.089913 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 27 03:05:26.089954 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 27 03:05:26.091514 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 27 03:05:26.092864 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 27 03:05:26.101685 systemd[1]: systemd-resolved.service: Deactivated successfully. May 27 03:05:26.101798 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 27 03:05:26.106480 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 27 03:05:26.107057 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 27 03:05:26.107117 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 03:05:26.110518 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. May 27 03:05:26.110728 systemd[1]: systemd-networkd.service: Deactivated successfully. May 27 03:05:26.110853 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 27 03:05:26.112727 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 27 03:05:26.113867 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 27 03:05:26.113907 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 27 03:05:26.116828 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 27 03:05:26.117685 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 27 03:05:26.117742 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 27 03:05:26.119846 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 27 03:05:26.119892 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 27 03:05:26.122534 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 27 03:05:26.122576 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 27 03:05:26.124627 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 03:05:26.136880 systemd[1]: network-cleanup.service: Deactivated successfully. May 27 03:05:26.136977 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 27 03:05:26.139691 systemd[1]: systemd-udevd.service: Deactivated successfully. May 27 03:05:26.141347 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 03:05:26.142749 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 27 03:05:26.142801 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 27 03:05:26.144626 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 27 03:05:26.144657 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 27 03:05:26.146163 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 27 03:05:26.146205 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 27 03:05:26.148264 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 27 03:05:26.148305 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 27 03:05:26.150505 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 27 03:05:26.150556 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 27 03:05:26.153553 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 27 03:05:26.155121 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 27 03:05:26.155183 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 27 03:05:26.157821 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 27 03:05:26.157866 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 03:05:26.160616 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 27 03:05:26.160662 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 27 03:05:26.171120 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 27 03:05:26.171251 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 27 03:05:26.173492 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 27 03:05:26.175703 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 27 03:05:26.195810 systemd[1]: Switching root. May 27 03:05:26.231095 systemd-journald[242]: Journal stopped May 27 03:05:26.945378 systemd-journald[242]: Received SIGTERM from PID 1 (systemd). May 27 03:05:26.945425 kernel: SELinux: policy capability network_peer_controls=1 May 27 03:05:26.945437 kernel: SELinux: policy capability open_perms=1 May 27 03:05:26.945449 kernel: SELinux: policy capability extended_socket_class=1 May 27 03:05:26.945459 kernel: SELinux: policy capability always_check_network=0 May 27 03:05:26.945468 kernel: SELinux: policy capability cgroup_seclabel=1 May 27 03:05:26.945477 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 27 03:05:26.945490 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 27 03:05:26.945499 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 27 03:05:26.945508 kernel: SELinux: policy capability userspace_initial_context=0 May 27 03:05:26.945519 kernel: audit: type=1403 audit(1748315126.379:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 27 03:05:26.945534 systemd[1]: Successfully loaded SELinux policy in 30.827ms. May 27 03:05:26.945551 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.435ms. May 27 03:05:26.945563 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 27 03:05:26.945575 systemd[1]: Detected virtualization kvm. May 27 03:05:26.945584 systemd[1]: Detected architecture arm64. May 27 03:05:26.945595 systemd[1]: Detected first boot. May 27 03:05:26.945604 systemd[1]: Initializing machine ID from VM UUID. May 27 03:05:26.945614 zram_generator::config[1085]: No configuration found. May 27 03:05:26.945626 kernel: NET: Registered PF_VSOCK protocol family May 27 03:05:26.945635 systemd[1]: Populated /etc with preset unit settings. May 27 03:05:26.945647 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 27 03:05:26.945658 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 27 03:05:26.945668 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 27 03:05:26.945678 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 27 03:05:26.945692 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 27 03:05:26.945704 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 27 03:05:26.945714 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 27 03:05:26.945725 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 27 03:05:26.945735 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 27 03:05:26.945745 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 27 03:05:26.945756 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 27 03:05:26.945830 systemd[1]: Created slice user.slice - User and Session Slice. May 27 03:05:26.945842 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 27 03:05:26.945853 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 27 03:05:26.945863 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 27 03:05:26.945875 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 27 03:05:26.945885 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 27 03:05:26.945895 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 27 03:05:26.945905 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... May 27 03:05:26.945915 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 27 03:05:26.945925 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 27 03:05:26.945935 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 27 03:05:26.945945 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 27 03:05:26.945960 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 27 03:05:26.945970 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 27 03:05:26.945980 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 27 03:05:26.945990 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 27 03:05:26.946006 systemd[1]: Reached target slices.target - Slice Units. May 27 03:05:26.946018 systemd[1]: Reached target swap.target - Swaps. May 27 03:05:26.946028 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 27 03:05:26.946039 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 27 03:05:26.946049 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 27 03:05:26.946061 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 27 03:05:26.946071 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 27 03:05:26.946081 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 27 03:05:26.946091 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 27 03:05:26.946101 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 27 03:05:26.946111 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 27 03:05:26.946121 systemd[1]: Mounting media.mount - External Media Directory... May 27 03:05:26.946131 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 27 03:05:26.946141 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 27 03:05:26.946153 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 27 03:05:26.946163 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 27 03:05:26.946173 systemd[1]: Reached target machines.target - Containers. May 27 03:05:26.946183 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 27 03:05:26.946193 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 03:05:26.946203 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 27 03:05:26.946214 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 27 03:05:26.946224 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 03:05:26.946234 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 27 03:05:26.946246 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 03:05:26.946256 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 27 03:05:26.946266 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 03:05:26.946277 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 27 03:05:26.946286 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 27 03:05:26.946296 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 27 03:05:26.946306 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 27 03:05:26.946316 systemd[1]: Stopped systemd-fsck-usr.service. May 27 03:05:26.946328 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 27 03:05:26.946338 systemd[1]: Starting systemd-journald.service - Journal Service... May 27 03:05:26.946348 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 27 03:05:26.946358 kernel: fuse: init (API version 7.41) May 27 03:05:26.946367 kernel: loop: module loaded May 27 03:05:26.946377 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 27 03:05:26.946387 kernel: ACPI: bus type drm_connector registered May 27 03:05:26.946396 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 27 03:05:26.946407 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 27 03:05:26.946418 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 27 03:05:26.946428 systemd[1]: verity-setup.service: Deactivated successfully. May 27 03:05:26.946438 systemd[1]: Stopped verity-setup.service. May 27 03:05:26.946449 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 27 03:05:26.946481 systemd-journald[1150]: Collecting audit messages is disabled. May 27 03:05:26.946505 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 27 03:05:26.946516 systemd-journald[1150]: Journal started May 27 03:05:26.946538 systemd-journald[1150]: Runtime Journal (/run/log/journal/dc0a1dfa5cea4a2d815702c897a99531) is 6M, max 48.5M, 42.4M free. May 27 03:05:26.948971 systemd[1]: Mounted media.mount - External Media Directory. May 27 03:05:26.746250 systemd[1]: Queued start job for default target multi-user.target. May 27 03:05:26.767654 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 27 03:05:26.768035 systemd[1]: systemd-journald.service: Deactivated successfully. May 27 03:05:26.951434 systemd[1]: Started systemd-journald.service - Journal Service. May 27 03:05:26.952204 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 27 03:05:26.953893 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 27 03:05:26.954859 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 27 03:05:26.957779 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 27 03:05:26.958962 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 27 03:05:26.960169 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 27 03:05:26.960334 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 27 03:05:26.961447 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 03:05:26.961606 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 03:05:26.962726 systemd[1]: modprobe@drm.service: Deactivated successfully. May 27 03:05:26.962913 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 27 03:05:26.964170 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 03:05:26.964358 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 03:05:26.965498 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 27 03:05:26.965668 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 27 03:05:26.966742 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 03:05:26.966917 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 03:05:26.969087 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 27 03:05:26.970479 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 27 03:05:26.972014 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 27 03:05:26.973497 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 27 03:05:26.985480 systemd[1]: Reached target network-pre.target - Preparation for Network. May 27 03:05:26.987951 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 27 03:05:26.992817 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 27 03:05:26.993891 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 27 03:05:26.993933 systemd[1]: Reached target local-fs.target - Local File Systems. May 27 03:05:26.995842 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 27 03:05:27.000669 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 27 03:05:27.001836 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 03:05:27.002857 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 27 03:05:27.004809 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 27 03:05:27.006065 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 03:05:27.013212 systemd-journald[1150]: Time spent on flushing to /var/log/journal/dc0a1dfa5cea4a2d815702c897a99531 is 23.053ms for 847 entries. May 27 03:05:27.013212 systemd-journald[1150]: System Journal (/var/log/journal/dc0a1dfa5cea4a2d815702c897a99531) is 8M, max 195.6M, 187.6M free. May 27 03:05:27.040394 systemd-journald[1150]: Received client request to flush runtime journal. May 27 03:05:27.009908 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 27 03:05:27.011044 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 03:05:27.012296 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 27 03:05:27.016006 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 27 03:05:27.020943 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 27 03:05:27.023715 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 27 03:05:27.025330 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 27 03:05:27.026786 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 27 03:05:27.037801 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 27 03:05:27.040268 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 27 03:05:27.042402 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 27 03:05:27.047481 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 27 03:05:27.052919 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 27 03:05:27.053951 kernel: loop0: detected capacity change from 0 to 138376 May 27 03:05:27.068829 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 27 03:05:27.080705 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 27 03:05:27.085594 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 27 03:05:27.087790 kernel: loop1: detected capacity change from 0 to 107312 May 27 03:05:27.100392 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 27 03:05:27.115017 kernel: loop2: detected capacity change from 0 to 138376 May 27 03:05:27.118429 systemd-tmpfiles[1217]: ACLs are not supported, ignoring. May 27 03:05:27.118445 systemd-tmpfiles[1217]: ACLs are not supported, ignoring. May 27 03:05:27.123532 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 03:05:27.124778 kernel: loop3: detected capacity change from 0 to 107312 May 27 03:05:27.128288 (sd-merge)[1223]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 27 03:05:27.128613 (sd-merge)[1223]: Merged extensions into '/usr'. May 27 03:05:27.131153 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 27 03:05:27.134023 systemd[1]: Starting ensure-sysext.service... May 27 03:05:27.136032 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 27 03:05:27.153176 systemd[1]: Reload requested from client PID 1226 ('systemctl') (unit ensure-sysext.service)... May 27 03:05:27.153191 systemd[1]: Reloading... May 27 03:05:27.163463 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 27 03:05:27.163491 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 27 03:05:27.163680 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 27 03:05:27.163878 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 27 03:05:27.164493 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 27 03:05:27.164687 systemd-tmpfiles[1227]: ACLs are not supported, ignoring. May 27 03:05:27.164728 systemd-tmpfiles[1227]: ACLs are not supported, ignoring. May 27 03:05:27.168199 systemd-tmpfiles[1227]: Detected autofs mount point /boot during canonicalization of boot. May 27 03:05:27.168314 systemd-tmpfiles[1227]: Skipping /boot May 27 03:05:27.180716 systemd-tmpfiles[1227]: Detected autofs mount point /boot during canonicalization of boot. May 27 03:05:27.181105 systemd-tmpfiles[1227]: Skipping /boot May 27 03:05:27.212787 zram_generator::config[1259]: No configuration found. May 27 03:05:27.292932 ldconfig[1196]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 27 03:05:27.299752 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 27 03:05:27.361262 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 27 03:05:27.361465 systemd[1]: Reloading finished in 207 ms. May 27 03:05:27.397555 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 27 03:05:27.399032 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 03:05:27.420982 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 27 03:05:27.423610 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 27 03:05:27.426161 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 27 03:05:27.429289 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 27 03:05:27.433983 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 27 03:05:27.437133 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 03:05:27.438184 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 03:05:27.439968 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 03:05:27.441780 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 03:05:27.442597 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 03:05:27.442707 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 27 03:05:27.443605 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 03:05:27.444792 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 03:05:27.447114 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 03:05:27.447294 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 03:05:27.448675 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 03:05:27.448840 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 03:05:27.453648 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 03:05:27.454935 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 03:05:27.469260 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 03:05:27.472556 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 03:05:27.474031 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 03:05:27.474153 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 27 03:05:27.477020 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 27 03:05:27.478876 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 03:05:27.479064 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 03:05:27.480656 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 03:05:27.486279 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 03:05:27.490944 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 27 03:05:27.493382 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 03:05:27.493568 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 03:05:27.504161 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 27 03:05:27.511603 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 03:05:27.513044 augenrules[1330]: No rules May 27 03:05:27.514012 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 03:05:27.517985 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 27 03:05:27.523624 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 03:05:27.525730 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 03:05:27.527087 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 03:05:27.527213 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 27 03:05:27.530074 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 03:05:27.532278 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 27 03:05:27.535252 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 27 03:05:27.536789 systemd[1]: audit-rules.service: Deactivated successfully. May 27 03:05:27.538804 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 27 03:05:27.540186 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 27 03:05:27.541596 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 27 03:05:27.543100 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 03:05:27.543249 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 03:05:27.544500 systemd[1]: modprobe@drm.service: Deactivated successfully. May 27 03:05:27.544648 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 27 03:05:27.546088 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 03:05:27.546246 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 03:05:27.547575 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 03:05:27.547723 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 03:05:27.549066 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 27 03:05:27.556010 systemd[1]: Finished ensure-sysext.service. May 27 03:05:27.560066 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 03:05:27.560143 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 03:05:27.562215 systemd-udevd[1344]: Using default interface naming scheme 'v255'. May 27 03:05:27.562232 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 27 03:05:27.563528 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 27 03:05:27.578678 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 03:05:27.581923 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 27 03:05:27.584519 systemd-resolved[1295]: Positive Trust Anchors: May 27 03:05:27.584535 systemd-resolved[1295]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 27 03:05:27.584568 systemd-resolved[1295]: 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 27 03:05:27.597830 systemd-resolved[1295]: Defaulting to hostname 'linux'. May 27 03:05:27.600596 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 27 03:05:27.601536 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 27 03:05:27.640877 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. May 27 03:05:27.697754 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 27 03:05:27.702941 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 27 03:05:27.703584 systemd-networkd[1362]: lo: Link UP May 27 03:05:27.703599 systemd-networkd[1362]: lo: Gained carrier May 27 03:05:27.705044 systemd-networkd[1362]: Enumeration completed May 27 03:05:27.705964 systemd-networkd[1362]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 03:05:27.705977 systemd-networkd[1362]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 27 03:05:27.706503 systemd[1]: Started systemd-networkd.service - Network Configuration. May 27 03:05:27.706657 systemd-networkd[1362]: eth0: Link UP May 27 03:05:27.707726 systemd[1]: Reached target network.target - Network. May 27 03:05:27.708645 systemd-networkd[1362]: eth0: Gained carrier May 27 03:05:27.708670 systemd-networkd[1362]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 03:05:27.716198 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 27 03:05:27.718273 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 27 03:05:27.719414 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 27 03:05:27.719844 systemd-networkd[1362]: eth0: DHCPv4 address 10.0.0.133/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 27 03:05:27.720331 systemd-timesyncd[1356]: Network configuration changed, trying to establish connection. May 27 03:05:27.720608 systemd[1]: Reached target sysinit.target - System Initialization. May 27 03:05:27.721873 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 27 03:05:27.722834 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 27 03:05:27.724033 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 27 03:05:27.725077 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 27 03:05:27.725108 systemd[1]: Reached target paths.target - Path Units. May 27 03:05:27.725737 systemd[1]: Reached target time-set.target - System Time Set. May 27 03:05:27.725839 systemd-timesyncd[1356]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 27 03:05:27.726151 systemd-timesyncd[1356]: Initial clock synchronization to Tue 2025-05-27 03:05:27.937477 UTC. May 27 03:05:27.726627 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 27 03:05:27.727488 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 27 03:05:27.728386 systemd[1]: Reached target timers.target - Timer Units. May 27 03:05:27.729884 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 27 03:05:27.732418 systemd[1]: Starting docker.socket - Docker Socket for the API... May 27 03:05:27.736055 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 27 03:05:27.737413 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 27 03:05:27.738621 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 27 03:05:27.741606 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 27 03:05:27.743230 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 27 03:05:27.745383 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 27 03:05:27.746901 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 27 03:05:27.748809 systemd[1]: Reached target sockets.target - Socket Units. May 27 03:05:27.750298 systemd[1]: Reached target basic.target - Basic System. May 27 03:05:27.751333 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 27 03:05:27.751366 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 27 03:05:27.754822 systemd[1]: Starting containerd.service - containerd container runtime... May 27 03:05:27.757918 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 27 03:05:27.760366 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 27 03:05:27.770708 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 27 03:05:27.773936 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 27 03:05:27.774692 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 27 03:05:27.775982 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 27 03:05:27.779595 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 27 03:05:27.782574 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 27 03:05:27.789043 systemd[1]: Starting systemd-logind.service - User Login Management... May 27 03:05:27.790677 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 27 03:05:27.791174 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 27 03:05:27.792880 systemd[1]: Starting update-engine.service - Update Engine... May 27 03:05:27.794547 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 27 03:05:27.796752 jq[1418]: false May 27 03:05:27.803821 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 27 03:05:27.807050 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 27 03:05:27.809059 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 27 03:05:27.809227 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 27 03:05:27.809471 systemd[1]: motdgen.service: Deactivated successfully. May 27 03:05:27.809633 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 27 03:05:27.810683 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 27 03:05:27.810872 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 27 03:05:27.817201 jq[1426]: true May 27 03:05:27.831026 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 03:05:27.840401 jq[1441]: true May 27 03:05:27.839482 (ntainerd)[1446]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 27 03:05:27.858152 extend-filesystems[1419]: Found loop2 May 27 03:05:27.859270 extend-filesystems[1419]: Found loop3 May 27 03:05:27.860277 extend-filesystems[1419]: Found vda May 27 03:05:27.860277 extend-filesystems[1419]: Found vda1 May 27 03:05:27.860277 extend-filesystems[1419]: Found vda2 May 27 03:05:27.860277 extend-filesystems[1419]: Found vda3 May 27 03:05:27.860277 extend-filesystems[1419]: Found usr May 27 03:05:27.860277 extend-filesystems[1419]: Found vda4 May 27 03:05:27.860277 extend-filesystems[1419]: Found vda6 May 27 03:05:27.860277 extend-filesystems[1419]: Found vda7 May 27 03:05:27.860277 extend-filesystems[1419]: Found vda9 May 27 03:05:27.860277 extend-filesystems[1419]: Checking size of /dev/vda9 May 27 03:05:27.872882 dbus-daemon[1406]: [system] SELinux support is enabled May 27 03:05:27.875098 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 27 03:05:27.881767 update_engine[1424]: I20250527 03:05:27.879637 1424 main.cc:92] Flatcar Update Engine starting May 27 03:05:27.880445 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 27 03:05:27.880475 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 27 03:05:27.882195 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 27 03:05:27.882220 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 27 03:05:27.890947 systemd[1]: Started update-engine.service - Update Engine. May 27 03:05:27.891089 update_engine[1424]: I20250527 03:05:27.891038 1424 update_check_scheduler.cc:74] Next update check in 2m1s May 27 03:05:27.895483 extend-filesystems[1419]: Old size kept for /dev/vda9 May 27 03:05:27.895730 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 27 03:05:27.897514 systemd[1]: extend-filesystems.service: Deactivated successfully. May 27 03:05:27.897716 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 27 03:05:27.933213 bash[1466]: Updated "/home/core/.ssh/authorized_keys" May 27 03:05:27.959779 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 27 03:05:27.961374 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 27 03:05:27.973659 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 27 03:05:27.991307 locksmithd[1469]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 27 03:05:28.024128 systemd-logind[1423]: Watching system buttons on /dev/input/event0 (Power Button) May 27 03:05:28.024355 systemd-logind[1423]: New seat seat0. May 27 03:05:28.026039 systemd[1]: Started systemd-logind.service - User Login Management. May 27 03:05:28.065531 containerd[1446]: time="2025-05-27T03:05:28Z" 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 27 03:05:28.066035 containerd[1446]: time="2025-05-27T03:05:28.066001412Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 27 03:05:28.075093 containerd[1446]: time="2025-05-27T03:05:28.075044906Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="586.579µs" May 27 03:05:28.075135 containerd[1446]: time="2025-05-27T03:05:28.075092457Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 27 03:05:28.075135 containerd[1446]: time="2025-05-27T03:05:28.075121857Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 27 03:05:28.075315 containerd[1446]: time="2025-05-27T03:05:28.075295593Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 27 03:05:28.075355 containerd[1446]: time="2025-05-27T03:05:28.075322859Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 27 03:05:28.075394 containerd[1446]: time="2025-05-27T03:05:28.075350083Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 27 03:05:28.075867 containerd[1446]: time="2025-05-27T03:05:28.075837865Z" 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 27 03:05:28.075893 containerd[1446]: time="2025-05-27T03:05:28.075866855Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 27 03:05:28.076116 containerd[1446]: time="2025-05-27T03:05:28.076091919Z" 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 27 03:05:28.076116 containerd[1446]: time="2025-05-27T03:05:28.076114504Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 03:05:28.076167 containerd[1446]: time="2025-05-27T03:05:28.076126658Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 03:05:28.076167 containerd[1446]: time="2025-05-27T03:05:28.076135035Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 27 03:05:28.076232 containerd[1446]: time="2025-05-27T03:05:28.076212150Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 27 03:05:28.076418 containerd[1446]: time="2025-05-27T03:05:28.076398739Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 27 03:05:28.076449 containerd[1446]: time="2025-05-27T03:05:28.076430808Z" 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 27 03:05:28.076449 containerd[1446]: time="2025-05-27T03:05:28.076440171Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 27 03:05:28.076484 containerd[1446]: time="2025-05-27T03:05:28.076472446Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 27 03:05:28.076719 containerd[1446]: time="2025-05-27T03:05:28.076691391Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 27 03:05:28.076810 containerd[1446]: time="2025-05-27T03:05:28.076793391Z" level=info msg="metadata content store policy set" policy=shared May 27 03:05:28.080148 containerd[1446]: time="2025-05-27T03:05:28.080117816Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 27 03:05:28.080194 containerd[1446]: time="2025-05-27T03:05:28.080176781Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 27 03:05:28.080215 containerd[1446]: time="2025-05-27T03:05:28.080193289Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 27 03:05:28.080215 containerd[1446]: time="2025-05-27T03:05:28.080205525Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080219363Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080264573Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080278042Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080289457Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080300339Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080309865Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080320377Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080332326Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080452886Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080480316Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080494852Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080505405Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080516410Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 27 03:05:28.080819 containerd[1446]: time="2025-05-27T03:05:28.080526840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080537516Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080547207Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080557965Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080568518Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080579646Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080761019Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080793541Z" level=info msg="Start snapshots syncer" May 27 03:05:28.081130 containerd[1446]: time="2025-05-27T03:05:28.080828198Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 27 03:05:28.081271 containerd[1446]: time="2025-05-27T03:05:28.081159614Z" 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 27 03:05:28.081271 containerd[1446]: time="2025-05-27T03:05:28.081212379Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 27 03:05:28.081370 containerd[1446]: time="2025-05-27T03:05:28.081290973Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 27 03:05:28.081570 containerd[1446]: time="2025-05-27T03:05:28.081528561Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 27 03:05:28.081570 containerd[1446]: time="2025-05-27T03:05:28.081565271Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 27 03:05:28.081625 containerd[1446]: time="2025-05-27T03:05:28.081576645Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 27 03:05:28.081625 containerd[1446]: time="2025-05-27T03:05:28.081587116Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 27 03:05:28.081625 containerd[1446]: time="2025-05-27T03:05:28.081599353Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 27 03:05:28.081625 containerd[1446]: time="2025-05-27T03:05:28.081609577Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 27 03:05:28.081625 containerd[1446]: time="2025-05-27T03:05:28.081619966Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 27 03:05:28.081721 containerd[1446]: time="2025-05-27T03:05:28.081644029Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 27 03:05:28.081721 containerd[1446]: time="2025-05-27T03:05:28.081655321Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 27 03:05:28.081721 containerd[1446]: time="2025-05-27T03:05:28.081673676Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 27 03:05:28.081721 containerd[1446]: time="2025-05-27T03:05:28.081713383Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 27 03:05:28.081805 containerd[1446]: time="2025-05-27T03:05:28.081727221Z" 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 27 03:05:28.081805 containerd[1446]: time="2025-05-27T03:05:28.081736337Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 27 03:05:28.081805 containerd[1446]: time="2025-05-27T03:05:28.081745700Z" 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 27 03:05:28.081805 containerd[1446]: time="2025-05-27T03:05:28.081753419Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 27 03:05:28.081805 containerd[1446]: time="2025-05-27T03:05:28.081763480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 27 03:05:28.081805 containerd[1446]: time="2025-05-27T03:05:28.081788281Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 27 03:05:28.081909 containerd[1446]: time="2025-05-27T03:05:28.081865808Z" level=info msg="runtime interface created" May 27 03:05:28.081909 containerd[1446]: time="2025-05-27T03:05:28.081871638Z" level=info msg="created NRI interface" May 27 03:05:28.081909 containerd[1446]: time="2025-05-27T03:05:28.081879399Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 27 03:05:28.081909 containerd[1446]: time="2025-05-27T03:05:28.081889829Z" level=info msg="Connect containerd service" May 27 03:05:28.081972 containerd[1446]: time="2025-05-27T03:05:28.081917505Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 27 03:05:28.082790 containerd[1446]: time="2025-05-27T03:05:28.082737976Z" 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 27 03:05:28.190342 containerd[1446]: time="2025-05-27T03:05:28.190283607Z" level=info msg="Start subscribing containerd event" May 27 03:05:28.190527 containerd[1446]: time="2025-05-27T03:05:28.190477546Z" level=info msg="Start recovering state" May 27 03:05:28.190737 containerd[1446]: time="2025-05-27T03:05:28.190720800Z" level=info msg="Start event monitor" May 27 03:05:28.190993 containerd[1446]: time="2025-05-27T03:05:28.190933053Z" level=info msg="Start cni network conf syncer for default" May 27 03:05:28.190993 containerd[1446]: time="2025-05-27T03:05:28.190948738Z" level=info msg="Start streaming server" May 27 03:05:28.190993 containerd[1446]: time="2025-05-27T03:05:28.190958429Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 27 03:05:28.190993 containerd[1446]: time="2025-05-27T03:05:28.190966560Z" level=info msg="runtime interface starting up..." May 27 03:05:28.190993 containerd[1446]: time="2025-05-27T03:05:28.190972842Z" level=info msg="starting plugins..." May 27 03:05:28.191305 containerd[1446]: time="2025-05-27T03:05:28.191284302Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 27 03:05:28.191502 containerd[1446]: time="2025-05-27T03:05:28.191473025Z" level=info msg=serving... address=/run/containerd/containerd.sock May 27 03:05:28.191623 containerd[1446]: time="2025-05-27T03:05:28.191361417Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 27 03:05:28.192312 containerd[1446]: time="2025-05-27T03:05:28.192286433Z" level=info msg="containerd successfully booted in 0.127267s" May 27 03:05:28.192387 systemd[1]: Started containerd.service - containerd container runtime. May 27 03:05:28.374299 sshd_keygen[1444]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 27 03:05:28.393453 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 27 03:05:28.396349 systemd[1]: Starting issuegen.service - Generate /run/issue... May 27 03:05:28.427466 systemd[1]: issuegen.service: Deactivated successfully. May 27 03:05:28.427753 systemd[1]: Finished issuegen.service - Generate /run/issue. May 27 03:05:28.430751 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 27 03:05:28.461846 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 27 03:05:28.464845 systemd[1]: Started getty@tty1.service - Getty on tty1. May 27 03:05:28.466919 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. May 27 03:05:28.468576 systemd[1]: Reached target getty.target - Login Prompts. May 27 03:05:29.558905 systemd-networkd[1362]: eth0: Gained IPv6LL May 27 03:05:29.564341 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 27 03:05:29.566066 systemd[1]: Reached target network-online.target - Network is Online. May 27 03:05:29.569426 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 27 03:05:29.571286 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 27 03:05:29.596683 systemd[1]: coreos-metadata.service: Deactivated successfully. May 27 03:05:29.596923 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 27 03:05:29.598310 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 27 03:05:29.600509 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 27 03:05:29.602156 systemd[1]: Reached target multi-user.target - Multi-User System. May 27 03:05:29.603516 systemd[1]: Startup finished in 2.076s (kernel) + 3.764s (initrd) + 3.261s (userspace) = 9.101s. May 27 03:05:35.244285 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 27 03:05:35.245352 systemd[1]: Started sshd@0-10.0.0.133:22-10.0.0.1:38820.service - OpenSSH per-connection server daemon (10.0.0.1:38820). May 27 03:05:35.332470 sshd[1540]: Accepted publickey for core from 10.0.0.1 port 38820 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:35.334032 sshd-session[1540]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:35.339812 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 27 03:05:35.340691 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 27 03:05:35.345787 systemd-logind[1423]: New session 1 of user core. May 27 03:05:35.363804 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 27 03:05:35.365975 systemd[1]: Starting user@500.service - User Manager for UID 500... May 27 03:05:35.380469 (systemd)[1544]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 27 03:05:35.382350 systemd-logind[1423]: New session c1 of user core. May 27 03:05:35.494165 systemd[1544]: Queued start job for default target default.target. May 27 03:05:35.517574 systemd[1544]: Created slice app.slice - User Application Slice. May 27 03:05:35.517602 systemd[1544]: Reached target paths.target - Paths. May 27 03:05:35.517633 systemd[1544]: Reached target timers.target - Timers. May 27 03:05:35.518739 systemd[1544]: Starting dbus.socket - D-Bus User Message Bus Socket... May 27 03:05:35.526699 systemd[1544]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 27 03:05:35.526754 systemd[1544]: Reached target sockets.target - Sockets. May 27 03:05:35.526811 systemd[1544]: Reached target basic.target - Basic System. May 27 03:05:35.526840 systemd[1544]: Reached target default.target - Main User Target. May 27 03:05:35.526863 systemd[1544]: Startup finished in 139ms. May 27 03:05:35.527009 systemd[1]: Started user@500.service - User Manager for UID 500. May 27 03:05:35.528106 systemd[1]: Started session-1.scope - Session 1 of User core. May 27 03:05:35.584745 systemd[1]: Started sshd@1-10.0.0.133:22-10.0.0.1:38822.service - OpenSSH per-connection server daemon (10.0.0.1:38822). May 27 03:05:35.639739 sshd[1556]: Accepted publickey for core from 10.0.0.1 port 38822 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:35.641043 sshd-session[1556]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:35.644749 systemd-logind[1423]: New session 2 of user core. May 27 03:05:35.652933 systemd[1]: Started session-2.scope - Session 2 of User core. May 27 03:05:35.704433 sshd[1558]: Connection closed by 10.0.0.1 port 38822 May 27 03:05:35.704305 sshd-session[1556]: pam_unix(sshd:session): session closed for user core May 27 03:05:35.726671 systemd[1]: sshd@1-10.0.0.133:22-10.0.0.1:38822.service: Deactivated successfully. May 27 03:05:35.729891 systemd[1]: session-2.scope: Deactivated successfully. May 27 03:05:35.730491 systemd-logind[1423]: Session 2 logged out. Waiting for processes to exit. May 27 03:05:35.732270 systemd[1]: Started sshd@2-10.0.0.133:22-10.0.0.1:38824.service - OpenSSH per-connection server daemon (10.0.0.1:38824). May 27 03:05:35.733218 systemd-logind[1423]: Removed session 2. May 27 03:05:35.788354 sshd[1564]: Accepted publickey for core from 10.0.0.1 port 38824 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:35.789650 sshd-session[1564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:35.793933 systemd-logind[1423]: New session 3 of user core. May 27 03:05:35.803984 systemd[1]: Started session-3.scope - Session 3 of User core. May 27 03:05:35.851964 sshd[1566]: Connection closed by 10.0.0.1 port 38824 May 27 03:05:35.852393 sshd-session[1564]: pam_unix(sshd:session): session closed for user core May 27 03:05:35.863741 systemd[1]: sshd@2-10.0.0.133:22-10.0.0.1:38824.service: Deactivated successfully. May 27 03:05:35.865090 systemd[1]: session-3.scope: Deactivated successfully. May 27 03:05:35.867620 systemd-logind[1423]: Session 3 logged out. Waiting for processes to exit. May 27 03:05:35.868855 systemd[1]: Started sshd@3-10.0.0.133:22-10.0.0.1:38838.service - OpenSSH per-connection server daemon (10.0.0.1:38838). May 27 03:05:35.869940 systemd-logind[1423]: Removed session 3. May 27 03:05:35.931855 sshd[1572]: Accepted publickey for core from 10.0.0.1 port 38838 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:35.933072 sshd-session[1572]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:35.937851 systemd-logind[1423]: New session 4 of user core. May 27 03:05:35.948949 systemd[1]: Started session-4.scope - Session 4 of User core. May 27 03:05:36.000058 sshd[1575]: Connection closed by 10.0.0.1 port 38838 May 27 03:05:36.000435 sshd-session[1572]: pam_unix(sshd:session): session closed for user core May 27 03:05:36.011802 systemd[1]: sshd@3-10.0.0.133:22-10.0.0.1:38838.service: Deactivated successfully. May 27 03:05:36.013105 systemd[1]: session-4.scope: Deactivated successfully. May 27 03:05:36.013767 systemd-logind[1423]: Session 4 logged out. Waiting for processes to exit. May 27 03:05:36.015834 systemd[1]: Started sshd@4-10.0.0.133:22-10.0.0.1:38852.service - OpenSSH per-connection server daemon (10.0.0.1:38852). May 27 03:05:36.016577 systemd-logind[1423]: Removed session 4. May 27 03:05:36.074151 sshd[1581]: Accepted publickey for core from 10.0.0.1 port 38852 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:36.074984 sshd-session[1581]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:36.078894 systemd-logind[1423]: New session 5 of user core. May 27 03:05:36.088939 systemd[1]: Started session-5.scope - Session 5 of User core. May 27 03:05:36.161863 sudo[1584]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 27 03:05:36.162129 sudo[1584]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 03:05:36.190311 sudo[1584]: pam_unix(sudo:session): session closed for user root May 27 03:05:36.191883 sshd[1583]: Connection closed by 10.0.0.1 port 38852 May 27 03:05:36.192250 sshd-session[1581]: pam_unix(sshd:session): session closed for user core May 27 03:05:36.208680 systemd[1]: sshd@4-10.0.0.133:22-10.0.0.1:38852.service: Deactivated successfully. May 27 03:05:36.210558 systemd[1]: session-5.scope: Deactivated successfully. May 27 03:05:36.211255 systemd-logind[1423]: Session 5 logged out. Waiting for processes to exit. May 27 03:05:36.213380 systemd[1]: Started sshd@5-10.0.0.133:22-10.0.0.1:38862.service - OpenSSH per-connection server daemon (10.0.0.1:38862). May 27 03:05:36.213995 systemd-logind[1423]: Removed session 5. May 27 03:05:36.272509 sshd[1590]: Accepted publickey for core from 10.0.0.1 port 38862 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:36.273717 sshd-session[1590]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:36.278209 systemd-logind[1423]: New session 6 of user core. May 27 03:05:36.289916 systemd[1]: Started session-6.scope - Session 6 of User core. May 27 03:05:36.340448 sudo[1594]: 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 27 03:05:36.341063 sudo[1594]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 03:05:36.345857 sudo[1594]: pam_unix(sudo:session): session closed for user root May 27 03:05:36.350139 sudo[1593]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 27 03:05:36.350415 sudo[1593]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 03:05:36.358358 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 27 03:05:36.395996 augenrules[1616]: No rules May 27 03:05:36.397144 systemd[1]: audit-rules.service: Deactivated successfully. May 27 03:05:36.398821 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 27 03:05:36.399666 sudo[1593]: pam_unix(sudo:session): session closed for user root May 27 03:05:36.400864 sshd[1592]: Connection closed by 10.0.0.1 port 38862 May 27 03:05:36.401155 sshd-session[1590]: pam_unix(sshd:session): session closed for user core May 27 03:05:36.415824 systemd[1]: sshd@5-10.0.0.133:22-10.0.0.1:38862.service: Deactivated successfully. May 27 03:05:36.418007 systemd[1]: session-6.scope: Deactivated successfully. May 27 03:05:36.418638 systemd-logind[1423]: Session 6 logged out. Waiting for processes to exit. May 27 03:05:36.420524 systemd[1]: Started sshd@6-10.0.0.133:22-10.0.0.1:38874.service - OpenSSH per-connection server daemon (10.0.0.1:38874). May 27 03:05:36.421063 systemd-logind[1423]: Removed session 6. May 27 03:05:36.482436 sshd[1625]: Accepted publickey for core from 10.0.0.1 port 38874 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:36.483501 sshd-session[1625]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:36.487678 systemd-logind[1423]: New session 7 of user core. May 27 03:05:36.502900 systemd[1]: Started session-7.scope - Session 7 of User core. May 27 03:05:36.557815 systemd[1]: Starting docker.service - Docker Application Container Engine... May 27 03:05:36.577025 (dockerd)[1629]: 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 27 03:05:36.827885 dockerd[1629]: time="2025-05-27T03:05:36.826937436Z" level=info msg="Starting up" May 27 03:05:36.829710 dockerd[1629]: time="2025-05-27T03:05:36.829677540Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 27 03:05:36.872611 dockerd[1629]: time="2025-05-27T03:05:36.872567684Z" level=info msg="Loading containers: start." May 27 03:05:36.881805 kernel: Initializing XFRM netlink socket May 27 03:05:37.070675 systemd-networkd[1362]: docker0: Link UP May 27 03:05:37.073988 dockerd[1629]: time="2025-05-27T03:05:37.073948249Z" level=info msg="Loading containers: done." May 27 03:05:37.088643 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2859089336-merged.mount: Deactivated successfully. May 27 03:05:37.090114 dockerd[1629]: time="2025-05-27T03:05:37.090074906Z" 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 27 03:05:37.090181 dockerd[1629]: time="2025-05-27T03:05:37.090147764Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 27 03:05:37.090274 dockerd[1629]: time="2025-05-27T03:05:37.090255537Z" level=info msg="Initializing buildkit" May 27 03:05:37.113463 dockerd[1629]: time="2025-05-27T03:05:37.113422700Z" level=info msg="Completed buildkit initialization" May 27 03:05:37.117961 dockerd[1629]: time="2025-05-27T03:05:37.117930698Z" level=info msg="Daemon has completed initialization" May 27 03:05:37.118017 dockerd[1629]: time="2025-05-27T03:05:37.117977953Z" level=info msg="API listen on /run/docker.sock" May 27 03:05:37.118196 systemd[1]: Started docker.service - Docker Application Container Engine. May 27 03:05:37.130108 sshd[1627]: Connection closed by 10.0.0.1 port 38874 May 27 03:05:37.129966 sshd-session[1625]: pam_unix(sshd:session): session closed for user core May 27 03:05:37.139635 systemd[1]: sshd@6-10.0.0.133:22-10.0.0.1:38874.service: Deactivated successfully. May 27 03:05:37.141036 systemd[1]: session-7.scope: Deactivated successfully. May 27 03:05:37.142362 systemd-logind[1423]: Session 7 logged out. Waiting for processes to exit. May 27 03:05:37.144029 systemd[1]: Started sshd@7-10.0.0.133:22-10.0.0.1:38886.service - OpenSSH per-connection server daemon (10.0.0.1:38886). May 27 03:05:37.144908 systemd-logind[1423]: Removed session 7. May 27 03:05:37.201121 sshd[1835]: Accepted publickey for core from 10.0.0.1 port 38886 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:37.202239 sshd-session[1835]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:37.206558 systemd-logind[1423]: New session 8 of user core. May 27 03:05:37.215933 systemd[1]: Started session-8.scope - Session 8 of User core. May 27 03:05:38.408423 systemd[1]: var-lib-docker-overlay2-135e2bbb378837f07d43862e469f834727e0a370b5b8171a597b26050f27fdac\x2dinit-merged.mount: Deactivated successfully. May 27 03:05:38.454434 containerd[1446]: time="2025-05-27T03:05:38.454367617Z" level=info msg="connecting to shim 13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2" address="unix:///run/containerd/s/1214dc70fc3b113f56513b20e4a465f8e5337a6e68e2760bc534fc1fb7333ec0" namespace=moby protocol=ttrpc version=3 May 27 03:05:38.482941 systemd[1]: Started docker-13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2.scope - libcontainer container 13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2. May 27 03:05:38.495264 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 03:05:38.511911 kernel: docker0: port 1(veth7ce9443) entered blocking state May 27 03:05:38.512020 kernel: docker0: port 1(veth7ce9443) entered disabled state May 27 03:05:38.512041 kernel: veth7ce9443: entered allmulticast mode May 27 03:05:38.512841 kernel: veth7ce9443: entered promiscuous mode May 27 03:05:38.513026 systemd-networkd[1362]: veth7ce9443: Link UP May 27 03:05:38.518790 kernel: eth0: renamed from veth4575bc3 May 27 03:05:38.521892 kernel: docker0: port 1(veth7ce9443) entered blocking state May 27 03:05:38.521949 kernel: docker0: port 1(veth7ce9443) entered forwarding state May 27 03:05:38.521788 systemd-networkd[1362]: veth7ce9443: Gained carrier May 27 03:05:38.522467 systemd-networkd[1362]: docker0: Gained carrier May 27 03:05:38.547540 sshd[1837]: Connection closed by 10.0.0.1 port 38886 May 27 03:05:38.548087 sshd-session[1835]: pam_unix(sshd:session): session closed for user core May 27 03:05:38.559591 systemd[1]: sshd@7-10.0.0.133:22-10.0.0.1:38886.service: Deactivated successfully. May 27 03:05:38.562004 systemd[1]: session-8.scope: Deactivated successfully. May 27 03:05:38.562624 systemd-logind[1423]: Session 8 logged out. Waiting for processes to exit. May 27 03:05:38.564657 systemd[1]: Started sshd@8-10.0.0.133:22-10.0.0.1:38902.service - OpenSSH per-connection server daemon (10.0.0.1:38902). May 27 03:05:38.565114 systemd-logind[1423]: Removed session 8. May 27 03:05:38.622774 sshd[1912]: Accepted publickey for core from 10.0.0.1 port 38902 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:38.624036 sshd-session[1912]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:38.627795 systemd-logind[1423]: New session 9 of user core. May 27 03:05:38.635929 systemd[1]: Started session-9.scope - Session 9 of User core. May 27 03:05:38.690290 sshd[1914]: Connection closed by 10.0.0.1 port 38902 May 27 03:05:38.690101 sshd-session[1912]: pam_unix(sshd:session): session closed for user core May 27 03:05:38.701868 systemd[1]: sshd@8-10.0.0.133:22-10.0.0.1:38902.service: Deactivated successfully. May 27 03:05:38.703216 systemd[1]: session-9.scope: Deactivated successfully. May 27 03:05:38.703842 systemd-logind[1423]: Session 9 logged out. Waiting for processes to exit. May 27 03:05:38.705738 systemd[1]: Started sshd@9-10.0.0.133:22-10.0.0.1:38904.service - OpenSSH per-connection server daemon (10.0.0.1:38904). May 27 03:05:38.706643 systemd-logind[1423]: Removed session 9. May 27 03:05:38.763258 sshd[1920]: Accepted publickey for core from 10.0.0.1 port 38904 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:38.764592 sshd-session[1920]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:38.768527 systemd-logind[1423]: New session 10 of user core. May 27 03:05:38.780928 systemd[1]: Started session-10.scope - Session 10 of User core. May 27 03:05:38.831617 sudo[1923]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1446 May 27 03:05:38.831917 sudo[1923]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 03:05:38.835345 sudo[1923]: pam_unix(sudo:session): session closed for user root May 27 03:05:38.835867 dockerd[1629]: time="2025-05-27T03:05:38.835514147Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 27 03:05:38.835867 dockerd[1629]: time="2025-05-27T03:05:38.835557045Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 27 03:05:38.836296 containerd[1446]: time="2025-05-27T03:05:38.836196604Z" level=info msg="Stop CRI service" May 27 03:05:38.836349 dockerd[1629]: time="2025-05-27T03:05:38.835740317Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 27 03:05:38.836374 dockerd[1629]: time="2025-05-27T03:05:38.836343584Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 27 03:05:38.836872 containerd[1446]: time="2025-05-27T03:05:38.836796688Z" level=info msg="Stop CRI service" May 27 03:05:38.836872 containerd[1446]: time="2025-05-27T03:05:38.836850703Z" level=info msg="Event monitor stopped" May 27 03:05:38.836872 containerd[1446]: time="2025-05-27T03:05:38.836857067Z" level=info msg="Stream server stopped" May 27 03:05:38.837807 sshd[1922]: Connection closed by 10.0.0.1 port 38904 May 27 03:05:38.838541 sshd-session[1920]: pam_unix(sshd:session): session closed for user core May 27 03:05:38.849605 systemd[1]: containerd.service: Deactivated successfully. May 27 03:05:38.849702 systemd[1]: containerd.service: Unit process 1862 (containerd-shim) remains running after unit stopped. May 27 03:05:38.850138 systemd[1]: containerd.service: Consumed 356ms CPU time, 136.1M memory peak. May 27 03:05:38.850619 systemd[1]: sshd@9-10.0.0.133:22-10.0.0.1:38904.service: Deactivated successfully. May 27 03:05:38.852239 systemd[1]: session-10.scope: Deactivated successfully. May 27 03:05:38.854792 systemd-logind[1423]: Session 10 logged out. Waiting for processes to exit. May 27 03:05:38.857223 systemd[1]: Started sshd@10-10.0.0.133:22-10.0.0.1:38910.service - OpenSSH per-connection server daemon (10.0.0.1:38910). May 27 03:05:38.857973 systemd-logind[1423]: Removed session 10. May 27 03:05:38.914887 sshd[1930]: Accepted publickey for core from 10.0.0.1 port 38910 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:38.916196 sshd-session[1930]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:38.920785 systemd-logind[1423]: New session 11 of user core. May 27 03:05:38.931937 systemd[1]: Started session-11.scope - Session 11 of User core. May 27 03:05:38.985982 sshd[1932]: Connection closed by 10.0.0.1 port 38910 May 27 03:05:38.986213 sshd-session[1930]: pam_unix(sshd:session): session closed for user core May 27 03:05:38.989379 systemd[1]: sshd@10-10.0.0.133:22-10.0.0.1:38910.service: Deactivated successfully. May 27 03:05:38.990824 systemd[1]: session-11.scope: Deactivated successfully. May 27 03:05:38.991439 systemd-logind[1423]: Session 11 logged out. Waiting for processes to exit. May 27 03:05:38.992316 systemd-logind[1423]: Removed session 11. May 27 03:05:39.606995 systemd-networkd[1362]: docker0: Gained IPv6LL May 27 03:05:39.797921 systemd-networkd[1362]: veth7ce9443: Gained IPv6LL May 27 03:05:44.100271 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. May 27 03:05:44.100606 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 27 03:05:44.101292 dockerd[1629]: time="2025-05-27T03:05:44.100790912Z" level=info msg="Processing signal 'terminated'" May 27 03:05:45.022533 systemd[1]: Started sshd@11-10.0.0.133:22-10.0.0.1:50360.service - OpenSSH per-connection server daemon (10.0.0.1:50360). May 27 03:05:45.067932 sshd[1938]: Accepted publickey for core from 10.0.0.1 port 50360 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:45.069294 sshd-session[1938]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:45.073158 systemd-logind[1423]: New session 12 of user core. May 27 03:05:45.086921 systemd[1]: Started session-12.scope - Session 12 of User core. May 27 03:05:45.140172 sshd[1940]: Connection closed by 10.0.0.1 port 50360 May 27 03:05:45.140634 sshd-session[1938]: pam_unix(sshd:session): session closed for user core May 27 03:05:45.143708 systemd[1]: sshd@11-10.0.0.133:22-10.0.0.1:50360.service: Deactivated successfully. May 27 03:05:45.146098 systemd[1]: session-12.scope: Deactivated successfully. May 27 03:05:45.146851 systemd-logind[1423]: Session 12 logged out. Waiting for processes to exit. May 27 03:05:45.148242 systemd-logind[1423]: Removed session 12. May 27 03:05:46.102414 dockerd[1629]: time="2025-05-27T03:05:46.102206952Z" level=error msg="Error sending stop (signal 15) to container" container=13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2 error="Cannot kill container 13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" May 27 03:05:46.102414 dockerd[1629]: time="2025-05-27T03:05:46.102256511Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2 May 27 03:05:51.168198 systemd[1]: Started sshd@12-10.0.0.133:22-10.0.0.1:50376.service - OpenSSH per-connection server daemon (10.0.0.1:50376). May 27 03:05:51.242217 sshd[1946]: Accepted publickey for core from 10.0.0.1 port 50376 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:51.243568 sshd-session[1946]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:51.247957 systemd-logind[1423]: New session 13 of user core. May 27 03:05:51.259920 systemd[1]: Started session-13.scope - Session 13 of User core. May 27 03:05:51.315806 sshd[1948]: Connection closed by 10.0.0.1 port 50376 May 27 03:05:51.315125 sshd-session[1946]: pam_unix(sshd:session): session closed for user core May 27 03:05:51.318427 systemd-logind[1423]: Session 13 logged out. Waiting for processes to exit. May 27 03:05:51.318610 systemd[1]: sshd@12-10.0.0.133:22-10.0.0.1:50376.service: Deactivated successfully. May 27 03:05:51.321019 systemd[1]: session-13.scope: Deactivated successfully. May 27 03:05:51.322586 systemd-logind[1423]: Removed session 13. May 27 03:05:56.102879 dockerd[1629]: time="2025-05-27T03:05:56.102787528Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2 error="context deadline exceeded" May 27 03:05:56.103615 systemd[1]: docker-13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2.scope: Deactivated successfully. May 27 03:05:57.336309 systemd[1]: Started sshd@13-10.0.0.133:22-10.0.0.1:35298.service - OpenSSH per-connection server daemon (10.0.0.1:35298). May 27 03:05:57.386987 sshd[1954]: Accepted publickey for core from 10.0.0.1 port 35298 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:05:57.388109 sshd-session[1954]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:05:57.392180 systemd-logind[1423]: New session 14 of user core. May 27 03:05:57.397903 systemd[1]: Started session-14.scope - Session 14 of User core. May 27 03:05:57.450364 sshd[1956]: Connection closed by 10.0.0.1 port 35298 May 27 03:05:57.450626 sshd-session[1954]: pam_unix(sshd:session): session closed for user core May 27 03:05:57.452881 systemd[1]: sshd@13-10.0.0.133:22-10.0.0.1:35298.service: Deactivated successfully. May 27 03:05:57.454204 systemd[1]: session-14.scope: Deactivated successfully. May 27 03:05:57.455843 systemd-logind[1423]: Session 14 logged out. Waiting for processes to exit. May 27 03:05:57.456744 systemd-logind[1423]: Removed session 14. May 27 03:05:59.101912 dockerd[1629]: time="2025-05-27T03:05:59.101850273Z" level=error msg="Force shutdown daemon" May 27 03:05:59.102287 dockerd[1629]: time="2025-05-27T03:05:59.102024867Z" level=info msg="Daemon shutdown complete" May 27 03:05:59.105436 systemd[1]: docker.service: Deactivated successfully. May 27 03:05:59.105742 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 27 03:05:59.105819 systemd[1]: docker.service: Consumed 777ms CPU time, 131.4M memory peak. May 27 03:05:59.106190 systemd[1]: docker.socket: Deactivated successfully. May 27 03:05:59.107146 systemd[1]: Closed docker.socket - Docker Socket for the API. May 27 03:05:59.107196 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 27 03:05:59.108651 systemd[1]: Starting docker.socket - Docker Socket for the API... May 27 03:05:59.108932 systemd[1]: containerd.service: Found left-over process 1862 (containerd-shim) in control group while starting unit. Ignoring. May 27 03:05:59.108943 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 27 03:05:59.122202 systemd[1]: Starting containerd.service - containerd container runtime... May 27 03:05:59.122467 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 27 03:05:59.132740 systemd[1]: containerd.service: Found left-over process 1862 (containerd-shim) in control group while starting unit. Ignoring. May 27 03:05:59.132751 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 27 03:05:59.136562 (ntainerd)[1967]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 27 03:05:59.148706 containerd[1967]: time="2025-05-27T03:05:59Z" 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 27 03:05:59.149221 containerd[1967]: time="2025-05-27T03:05:59.149187577Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 27 03:05:59.156826 containerd[1967]: time="2025-05-27T03:05:59.156708279Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.524µs" May 27 03:05:59.156919 containerd[1967]: time="2025-05-27T03:05:59.156748576Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 27 03:05:59.157099 containerd[1967]: time="2025-05-27T03:05:59.157064469Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 27 03:05:59.157147 containerd[1967]: time="2025-05-27T03:05:59.157132458Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 27 03:05:59.157170 containerd[1967]: time="2025-05-27T03:05:59.157149025Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 27 03:05:59.157374 containerd[1967]: time="2025-05-27T03:05:59.157350030Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 27 03:05:59.157407 containerd[1967]: time="2025-05-27T03:05:59.157383564Z" 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 27 03:05:59.157407 containerd[1967]: time="2025-05-27T03:05:59.157394369Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 27 03:05:59.157618 containerd[1967]: time="2025-05-27T03:05:59.157578607Z" 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 27 03:05:59.157618 containerd[1967]: time="2025-05-27T03:05:59.157599296Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 03:05:59.157618 containerd[1967]: time="2025-05-27T03:05:59.157609860Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 03:05:59.157618 containerd[1967]: time="2025-05-27T03:05:59.157617263Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 27 03:05:59.157717 containerd[1967]: time="2025-05-27T03:05:59.157635551Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 27 03:05:59.157717 containerd[1967]: time="2025-05-27T03:05:59.157712143Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 27 03:05:59.157825 containerd[1967]: time="2025-05-27T03:05:59.157731231Z" 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 27 03:05:59.157825 containerd[1967]: time="2025-05-27T03:05:59.157739475Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 27 03:05:59.157825 containerd[1967]: time="2025-05-27T03:05:59.157789856Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 27 03:05:59.157992 containerd[1967]: time="2025-05-27T03:05:59.157974894Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 27 03:05:59.158023 containerd[1967]: time="2025-05-27T03:05:59.157999465Z" level=info msg="metadata content store policy set" policy=shared May 27 03:05:59.158119 containerd[1967]: time="2025-05-27T03:05:59.158102348Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 27 03:05:59.158167 containerd[1967]: time="2025-05-27T03:05:59.158130840Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 27 03:05:59.158167 containerd[1967]: time="2025-05-27T03:05:59.158147487Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 27 03:05:59.158167 containerd[1967]: time="2025-05-27T03:05:59.158159132Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 27 03:05:59.158223 containerd[1967]: time="2025-05-27T03:05:59.158170457Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 27 03:05:59.158223 containerd[1967]: time="2025-05-27T03:05:59.158187784Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 27 03:05:59.158223 containerd[1967]: time="2025-05-27T03:05:59.158198389Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 27 03:05:59.158223 containerd[1967]: time="2025-05-27T03:05:59.158208793Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 27 03:05:59.158223 containerd[1967]: time="2025-05-27T03:05:59.158218718Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 27 03:05:59.158320 containerd[1967]: time="2025-05-27T03:05:59.158231883Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 27 03:05:59.158320 containerd[1967]: time="2025-05-27T03:05:59.158241007Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 27 03:05:59.158320 containerd[1967]: time="2025-05-27T03:05:59.158251852Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 27 03:05:59.158459 containerd[1967]: time="2025-05-27T03:05:59.158431728Z" level=info msg="connecting to shim 13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2" address="unix:///run/containerd/s/1214dc70fc3b113f56513b20e4a465f8e5337a6e68e2760bc534fc1fb7333ec0" namespace=moby protocol=ttrpc version=3 May 27 03:05:59.164705 containerd[1967]: time="2025-05-27T03:05:59.164675969Z" level=info msg="cleaning leaked shim process" id=13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2 namespace=moby May 27 03:05:59.172967 containerd[1967]: time="2025-05-27T03:05:59.172902489Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 27 03:05:59.173369 containerd[1967]: time="2025-05-27T03:05:59.173188490Z" level=info msg="shim disconnected" id=13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2 namespace=moby May 27 03:05:59.173369 containerd[1967]: time="2025-05-27T03:05:59.173216222Z" level=warning msg="cleaning up after shim disconnected" id=13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2 namespace=moby May 27 03:05:59.173369 containerd[1967]: time="2025-05-27T03:05:59.173246595Z" level=info msg="cleaning up dead shim" namespace=moby May 27 03:05:59.181901 containerd[1967]: time="2025-05-27T03:05:59.181843031Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 27 03:05:59.182042 containerd[1967]: time="2025-05-27T03:05:59.182008461Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 27 03:05:59.182075 containerd[1967]: time="2025-05-27T03:05:59.182049758Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 27 03:05:59.182075 containerd[1967]: time="2025-05-27T03:05:59.182068126Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 27 03:05:59.182114 containerd[1967]: time="2025-05-27T03:05:59.182079291Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 27 03:05:59.182114 containerd[1967]: time="2025-05-27T03:05:59.182090216Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 27 03:05:59.182114 containerd[1967]: time="2025-05-27T03:05:59.182101060Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 27 03:05:59.182173 containerd[1967]: time="2025-05-27T03:05:59.182113946Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 27 03:05:59.182173 containerd[1967]: time="2025-05-27T03:05:59.182124630Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 27 03:05:59.182173 containerd[1967]: time="2025-05-27T03:05:59.182136395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 27 03:05:59.182173 containerd[1967]: time="2025-05-27T03:05:59.182150881Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 27 03:05:59.182173 containerd[1967]: time="2025-05-27T03:05:59.182162006Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 27 03:05:59.182271 containerd[1967]: time="2025-05-27T03:05:59.182222632Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 27 03:05:59.182271 containerd[1967]: time="2025-05-27T03:05:59.182238718Z" level=info msg="Start snapshots syncer" May 27 03:05:59.182271 containerd[1967]: time="2025-05-27T03:05:59.182266610Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 27 03:05:59.182502 containerd[1967]: time="2025-05-27T03:05:59.182469736Z" 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 27 03:05:59.182596 containerd[1967]: time="2025-05-27T03:05:59.182519037Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 27 03:05:59.182628 containerd[1967]: time="2025-05-27T03:05:59.182598351Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 27 03:05:59.182693 containerd[1967]: time="2025-05-27T03:05:59.182646131Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 27 03:05:59.182693 containerd[1967]: time="2025-05-27T03:05:59.182671381Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 27 03:05:59.182739 containerd[1967]: time="2025-05-27T03:05:59.182700754Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 27 03:05:59.182739 containerd[1967]: time="2025-05-27T03:05:59.182712439Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 27 03:05:59.182739 containerd[1967]: time="2025-05-27T03:05:59.182724044Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 27 03:05:59.182739 containerd[1967]: time="2025-05-27T03:05:59.182733968Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 27 03:05:59.182835 containerd[1967]: time="2025-05-27T03:05:59.182755297Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 27 03:05:59.182835 containerd[1967]: time="2025-05-27T03:05:59.182804638Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 27 03:05:59.182835 containerd[1967]: time="2025-05-27T03:05:59.182823486Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 27 03:05:59.182890 containerd[1967]: time="2025-05-27T03:05:59.182836811Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 27 03:05:59.182890 containerd[1967]: time="2025-05-27T03:05:59.182874627Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 27 03:05:59.182926 containerd[1967]: time="2025-05-27T03:05:59.182889114Z" 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 27 03:05:59.182926 containerd[1967]: time="2025-05-27T03:05:59.182897637Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 27 03:05:59.182926 containerd[1967]: time="2025-05-27T03:05:59.182906881Z" 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 27 03:05:59.182926 containerd[1967]: time="2025-05-27T03:05:59.182914404Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 27 03:05:59.182926 containerd[1967]: time="2025-05-27T03:05:59.182922768Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 27 03:05:59.183011 containerd[1967]: time="2025-05-27T03:05:59.182934733Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 27 03:05:59.183011 containerd[1967]: time="2025-05-27T03:05:59.182950620Z" level=info msg="runtime interface created" May 27 03:05:59.183011 containerd[1967]: time="2025-05-27T03:05:59.182955542Z" level=info msg="created NRI interface" May 27 03:05:59.183011 containerd[1967]: time="2025-05-27T03:05:59.182970108Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 27 03:05:59.183011 containerd[1967]: time="2025-05-27T03:05:59.182981553Z" level=info msg="Connect containerd service" May 27 03:05:59.183011 containerd[1967]: time="2025-05-27T03:05:59.183007964Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 27 03:05:59.183502 containerd[1967]: time="2025-05-27T03:05:59.183475722Z" 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 27 03:05:59.191753 containerd[1967]: time="2025-05-27T03:05:59.191711085Z" level=info msg="Start subscribing containerd event" May 27 03:05:59.191841 containerd[1967]: time="2025-05-27T03:05:59.191771591Z" level=info msg="Start recovering state" May 27 03:05:59.191870 containerd[1967]: time="2025-05-27T03:05:59.191844822Z" level=info msg="Start event monitor" May 27 03:05:59.191870 containerd[1967]: time="2025-05-27T03:05:59.191858468Z" level=info msg="Start cni network conf syncer for default" May 27 03:05:59.191870 containerd[1967]: time="2025-05-27T03:05:59.191865631Z" level=info msg="Start streaming server" May 27 03:05:59.191922 containerd[1967]: time="2025-05-27T03:05:59.191874314Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 27 03:05:59.191922 containerd[1967]: time="2025-05-27T03:05:59.191881798Z" level=info msg="runtime interface starting up..." May 27 03:05:59.191922 containerd[1967]: time="2025-05-27T03:05:59.191887840Z" level=info msg="starting plugins..." May 27 03:05:59.191922 containerd[1967]: time="2025-05-27T03:05:59.191896924Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 27 03:05:59.191992 containerd[1967]: time="2025-05-27T03:05:59.191880477Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 27 03:05:59.192039 containerd[1967]: time="2025-05-27T03:05:59.192016054Z" level=info msg=serving... address=/run/containerd/containerd.sock May 27 03:05:59.192089 containerd[1967]: time="2025-05-27T03:05:59.192076360Z" level=info msg="containerd successfully booted in 0.043523s" May 27 03:05:59.192182 systemd[1]: Started containerd.service - containerd container runtime. May 27 03:05:59.193833 systemd[1]: Starting docker.service - Docker Application Container Engine... May 27 03:05:59.212079 (dockerd)[2014]: 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 27 03:05:59.236883 dockerd[2014]: time="2025-05-27T03:05:59.236832292Z" level=info msg="Starting up" May 27 03:05:59.237360 dockerd[2014]: time="2025-05-27T03:05:59.237331023Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 27 03:05:59.271391 dockerd[2014]: time="2025-05-27T03:05:59.271342451Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 27 03:05:59.279444 dockerd[2014]: time="2025-05-27T03:05:59.279412185Z" level=info msg="Loading containers: start." May 27 03:05:59.290173 systemd[1]: var-lib-docker-overlay2-135e2bbb378837f07d43862e469f834727e0a370b5b8171a597b26050f27fdac-merged.mount: Deactivated successfully. May 27 03:05:59.633770 systemd-networkd[1362]: veth7ce9443: Link DOWN May 27 03:05:59.633778 systemd-networkd[1362]: veth7ce9443: Lost carrier May 27 03:05:59.635055 kernel: docker0: port 1(veth7ce9443) entered disabled state May 27 03:05:59.635098 kernel: veth7ce9443 (unregistering): left allmulticast mode May 27 03:05:59.635114 kernel: veth7ce9443 (unregistering): left promiscuous mode May 27 03:05:59.636026 kernel: docker0: port 1(veth7ce9443) entered disabled state May 27 03:05:59.636870 systemd-networkd[1362]: docker0: Lost carrier May 27 03:05:59.638452 dockerd[2014]: time="2025-05-27T03:05:59.638373912Z" level=info msg="Removing stale sandbox 938463617d3dba263d938b0799d66593acaf03c67ad3c37c52b1d5b297e1e64c (13e5a6880b811383fbc47efdd2d600537a19a1bcbf289c6d8b60089fa855d5d2)" May 27 03:05:59.641220 dockerd[2014]: time="2025-05-27T03:05:59.641165292Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 27 03:05:59.641220 dockerd[2014]: time="2025-05-27T03:05:59.641204229Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 16234b6dfe068086fa9976c37044c50e2131ad3de8a78b1bb5224b83c1e31a21 88e2e2fc7f6dcf033ae68f587994cef6f82f4d4e50894b76c1153802af48c687], retrying...." May 27 03:05:59.800801 dockerd[2014]: time="2025-05-27T03:05:59.800707982Z" level=warning msg="error locating sandbox id 938463617d3dba263d938b0799d66593acaf03c67ad3c37c52b1d5b297e1e64c: sandbox 938463617d3dba263d938b0799d66593acaf03c67ad3c37c52b1d5b297e1e64c not found" May 27 03:05:59.801007 dockerd[2014]: time="2025-05-27T03:05:59.800883176Z" level=info msg="Loading containers: done." May 27 03:05:59.812381 dockerd[2014]: time="2025-05-27T03:05:59.812229456Z" 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 27 03:05:59.812381 dockerd[2014]: time="2025-05-27T03:05:59.812308449Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 27 03:05:59.812381 dockerd[2014]: time="2025-05-27T03:05:59.812348426Z" level=info msg="Initializing buildkit" May 27 03:05:59.825142 dockerd[2014]: time="2025-05-27T03:05:59.825039835Z" level=info msg="Completed buildkit initialization" May 27 03:05:59.832787 dockerd[2014]: time="2025-05-27T03:05:59.832717682Z" level=info msg="Daemon has completed initialization" May 27 03:05:59.833090 dockerd[2014]: time="2025-05-27T03:05:59.833033256Z" level=info msg="API listen on /run/docker.sock" May 27 03:05:59.833185 systemd[1]: Started docker.service - Docker Application Container Engine. May 27 03:06:00.257459 systemd[1]: run-docker-netns-938463617d3d.mount: Deactivated successfully. May 27 03:06:03.465629 systemd[1]: Started sshd@14-10.0.0.133:22-10.0.0.1:35274.service - OpenSSH per-connection server daemon (10.0.0.1:35274). May 27 03:06:03.518283 sshd[2238]: Accepted publickey for core from 10.0.0.1 port 35274 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:03.517237 sshd-session[2238]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:03.522405 systemd-logind[1423]: New session 15 of user core. May 27 03:06:03.538898 systemd[1]: Started session-15.scope - Session 15 of User core. May 27 03:06:03.595941 sshd[2240]: Connection closed by 10.0.0.1 port 35274 May 27 03:06:03.595101 sshd-session[2238]: pam_unix(sshd:session): session closed for user core May 27 03:06:03.609498 systemd[1]: sshd@14-10.0.0.133:22-10.0.0.1:35274.service: Deactivated successfully. May 27 03:06:03.615861 systemd[1]: session-15.scope: Deactivated successfully. May 27 03:06:03.619886 systemd-logind[1423]: Session 15 logged out. Waiting for processes to exit. May 27 03:06:03.623891 systemd[1]: Started sshd@15-10.0.0.133:22-10.0.0.1:35280.service - OpenSSH per-connection server daemon (10.0.0.1:35280). May 27 03:06:03.625412 systemd-logind[1423]: Removed session 15. May 27 03:06:03.698606 sshd[2246]: Accepted publickey for core from 10.0.0.1 port 35280 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:03.699680 sshd-session[2246]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:03.705831 systemd-logind[1423]: New session 16 of user core. May 27 03:06:03.713893 systemd[1]: Started session-16.scope - Session 16 of User core. May 27 03:06:03.768103 sshd[2248]: Connection closed by 10.0.0.1 port 35280 May 27 03:06:03.768936 sshd-session[2246]: pam_unix(sshd:session): session closed for user core May 27 03:06:03.775494 systemd[1]: sshd@15-10.0.0.133:22-10.0.0.1:35280.service: Deactivated successfully. May 27 03:06:03.776986 systemd[1]: session-16.scope: Deactivated successfully. May 27 03:06:03.778545 systemd-logind[1423]: Session 16 logged out. Waiting for processes to exit. May 27 03:06:03.782405 systemd[1]: Started sshd@16-10.0.0.133:22-10.0.0.1:35296.service - OpenSSH per-connection server daemon (10.0.0.1:35296). May 27 03:06:03.784401 systemd-logind[1423]: Removed session 16. May 27 03:06:03.835661 sshd[2254]: Accepted publickey for core from 10.0.0.1 port 35296 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:03.837291 sshd-session[2254]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:03.843178 systemd-logind[1423]: New session 17 of user core. May 27 03:06:03.856955 systemd[1]: Started session-17.scope - Session 17 of User core. May 27 03:06:03.915081 sshd[2256]: Connection closed by 10.0.0.1 port 35296 May 27 03:06:03.915535 sshd-session[2254]: pam_unix(sshd:session): session closed for user core May 27 03:06:03.922499 systemd[1]: sshd@16-10.0.0.133:22-10.0.0.1:35296.service: Deactivated successfully. May 27 03:06:03.925922 systemd[1]: session-17.scope: Deactivated successfully. May 27 03:06:03.926785 systemd-logind[1423]: Session 17 logged out. Waiting for processes to exit. May 27 03:06:03.928383 systemd[1]: Started sshd@17-10.0.0.133:22-10.0.0.1:35312.service - OpenSSH per-connection server daemon (10.0.0.1:35312). May 27 03:06:03.930455 systemd-logind[1423]: Removed session 17. May 27 03:06:03.978735 sshd[2269]: Accepted publickey for core from 10.0.0.1 port 35312 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:03.979867 sshd-session[2269]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:03.986588 systemd-logind[1423]: New session 18 of user core. May 27 03:06:04.004986 systemd[1]: Started session-18.scope - Session 18 of User core. May 27 03:06:04.107939 containerd[1967]: time="2025-05-27T03:06:04.107771959Z" level=info msg="connecting to shim 75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904" address="unix:///run/containerd/s/78fdeb892b066de13313b0c7b874a49e78702ed9e88c4499f9ce599141415eab" namespace=moby protocol=ttrpc version=3 May 27 03:06:04.142614 systemd[1]: Started docker-75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904.scope - libcontainer container 75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904. May 27 03:06:04.153823 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 03:06:04.169737 kernel: docker0: port 1(vethda7c4ec) entered blocking state May 27 03:06:04.169840 kernel: docker0: port 1(vethda7c4ec) entered disabled state May 27 03:06:04.169862 kernel: vethda7c4ec: entered allmulticast mode May 27 03:06:04.169877 kernel: vethda7c4ec: entered promiscuous mode May 27 03:06:04.173723 systemd-networkd[1362]: vethda7c4ec: Link UP May 27 03:06:04.178785 kernel: eth0: renamed from veth17c37a2 May 27 03:06:04.183310 kernel: docker0: port 1(vethda7c4ec) entered blocking state May 27 03:06:04.183361 kernel: docker0: port 1(vethda7c4ec) entered forwarding state May 27 03:06:04.180588 systemd-networkd[1362]: vethda7c4ec: Gained carrier May 27 03:06:04.183643 systemd-networkd[1362]: docker0: Gained carrier May 27 03:06:04.201559 sshd[2271]: Connection closed by 10.0.0.1 port 35312 May 27 03:06:04.200548 sshd-session[2269]: pam_unix(sshd:session): session closed for user core May 27 03:06:04.211598 systemd[1]: sshd@17-10.0.0.133:22-10.0.0.1:35312.service: Deactivated successfully. May 27 03:06:04.213608 systemd[1]: session-18.scope: Deactivated successfully. May 27 03:06:04.215982 systemd-logind[1423]: Session 18 logged out. Waiting for processes to exit. May 27 03:06:04.221145 systemd[1]: Started sshd@18-10.0.0.133:22-10.0.0.1:35326.service - OpenSSH per-connection server daemon (10.0.0.1:35326). May 27 03:06:04.221787 systemd-logind[1423]: Removed session 18. May 27 03:06:04.283446 sshd[2338]: Accepted publickey for core from 10.0.0.1 port 35326 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:04.284272 sshd-session[2338]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:04.288269 systemd-logind[1423]: New session 19 of user core. May 27 03:06:04.308932 systemd[1]: Started session-19.scope - Session 19 of User core. May 27 03:06:04.363046 sshd[2340]: Connection closed by 10.0.0.1 port 35326 May 27 03:06:04.363339 sshd-session[2338]: pam_unix(sshd:session): session closed for user core May 27 03:06:04.373564 systemd[1]: sshd@18-10.0.0.133:22-10.0.0.1:35326.service: Deactivated successfully. May 27 03:06:04.374988 systemd[1]: session-19.scope: Deactivated successfully. May 27 03:06:04.377737 systemd-logind[1423]: Session 19 logged out. Waiting for processes to exit. May 27 03:06:04.378497 systemd[1]: Started sshd@19-10.0.0.133:22-10.0.0.1:35334.service - OpenSSH per-connection server daemon (10.0.0.1:35334). May 27 03:06:04.379470 systemd-logind[1423]: Removed session 19. May 27 03:06:04.430585 sshd[2346]: Accepted publickey for core from 10.0.0.1 port 35334 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:04.429253 sshd-session[2346]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:04.434586 systemd-logind[1423]: New session 20 of user core. May 27 03:06:04.446914 systemd[1]: Started session-20.scope - Session 20 of User core. May 27 03:06:04.497228 sudo[2349]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1967 May 27 03:06:04.497487 sudo[2349]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 03:06:04.499978 sudo[2349]: pam_unix(sudo:session): session closed for user root May 27 03:06:04.504620 sshd[2348]: Connection closed by 10.0.0.1 port 35334 May 27 03:06:04.503983 systemd[1]: containerd.service: Deactivated successfully. May 27 03:06:04.505089 dockerd[2014]: time="2025-05-27T03:06:04.503065129Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 27 03:06:04.505089 dockerd[2014]: time="2025-05-27T03:06:04.503100380Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 27 03:06:04.505089 dockerd[2014]: time="2025-05-27T03:06:04.503187647Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 27 03:06:04.505089 dockerd[2014]: time="2025-05-27T03:06:04.503266032Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 27 03:06:04.502388 sshd-session[2346]: pam_unix(sshd:session): session closed for user core May 27 03:06:04.504070 systemd[1]: containerd.service: Unit process 2290 (containerd-shim) remains running after unit stopped. May 27 03:06:04.504306 systemd[1]: containerd.service: Consumed 139ms CPU time, 136.1M memory peak. May 27 03:06:04.525605 systemd[1]: sshd@19-10.0.0.133:22-10.0.0.1:35334.service: Deactivated successfully. May 27 03:06:04.527637 systemd[1]: session-20.scope: Deactivated successfully. May 27 03:06:04.528304 systemd-logind[1423]: Session 20 logged out. Waiting for processes to exit. May 27 03:06:04.530645 systemd[1]: Started sshd@20-10.0.0.133:22-10.0.0.1:35342.service - OpenSSH per-connection server daemon (10.0.0.1:35342). May 27 03:06:04.531801 systemd-logind[1423]: Removed session 20. May 27 03:06:04.586528 sshd[2356]: Accepted publickey for core from 10.0.0.1 port 35342 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:04.587235 sshd-session[2356]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:04.592195 systemd-logind[1423]: New session 21 of user core. May 27 03:06:04.596911 systemd[1]: Started session-21.scope - Session 21 of User core. May 27 03:06:04.648904 sshd[2358]: Connection closed by 10.0.0.1 port 35342 May 27 03:06:04.649113 sshd-session[2356]: pam_unix(sshd:session): session closed for user core May 27 03:06:04.652313 systemd[1]: sshd@20-10.0.0.133:22-10.0.0.1:35342.service: Deactivated successfully. May 27 03:06:04.653597 systemd[1]: session-21.scope: Deactivated successfully. May 27 03:06:04.655669 systemd-logind[1423]: Session 21 logged out. Waiting for processes to exit. May 27 03:06:04.660056 systemd-logind[1423]: Removed session 21. May 27 03:06:05.334031 systemd-networkd[1362]: vethda7c4ec: Gained IPv6LL May 27 03:06:09.710743 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. May 27 03:06:09.711130 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 27 03:06:09.711489 dockerd[2014]: time="2025-05-27T03:06:09.711399789Z" level=info msg="Processing signal 'terminated'" May 27 03:06:10.665733 systemd[1]: Started sshd@21-10.0.0.133:22-10.0.0.1:35352.service - OpenSSH per-connection server daemon (10.0.0.1:35352). May 27 03:06:10.713678 sshd[2364]: Accepted publickey for core from 10.0.0.1 port 35352 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:10.715521 sshd-session[2364]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:10.721365 systemd-logind[1423]: New session 22 of user core. May 27 03:06:10.727006 systemd[1]: Started session-22.scope - Session 22 of User core. May 27 03:06:10.779548 sshd[2366]: Connection closed by 10.0.0.1 port 35352 May 27 03:06:10.779835 sshd-session[2364]: pam_unix(sshd:session): session closed for user core May 27 03:06:10.782961 systemd[1]: sshd@21-10.0.0.133:22-10.0.0.1:35352.service: Deactivated successfully. May 27 03:06:10.784559 systemd[1]: session-22.scope: Deactivated successfully. May 27 03:06:10.786662 systemd-logind[1423]: Session 22 logged out. Waiting for processes to exit. May 27 03:06:10.787605 systemd-logind[1423]: Removed session 22. May 27 03:06:11.712090 dockerd[2014]: time="2025-05-27T03:06:11.712008378Z" level=error msg="Error sending stop (signal 15) to container" container=75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904 error="Cannot kill container 75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" May 27 03:06:11.712090 dockerd[2014]: time="2025-05-27T03:06:11.712080273Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904 May 27 03:06:13.504648 update_engine[1424]: I20250527 03:06:13.504556 1424 update_attempter.cc:509] Updating boot flags... May 27 03:06:16.795917 systemd[1]: Started sshd@22-10.0.0.133:22-10.0.0.1:53030.service - OpenSSH per-connection server daemon (10.0.0.1:53030). May 27 03:06:16.868584 sshd[2390]: Accepted publickey for core from 10.0.0.1 port 53030 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:16.870561 sshd-session[2390]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:16.874952 systemd-logind[1423]: New session 23 of user core. May 27 03:06:16.885953 systemd[1]: Started session-23.scope - Session 23 of User core. May 27 03:06:16.938044 sshd[2392]: Connection closed by 10.0.0.1 port 53030 May 27 03:06:16.937919 sshd-session[2390]: pam_unix(sshd:session): session closed for user core May 27 03:06:16.941122 systemd[1]: sshd@22-10.0.0.133:22-10.0.0.1:53030.service: Deactivated successfully. May 27 03:06:16.942542 systemd[1]: session-23.scope: Deactivated successfully. May 27 03:06:16.944634 systemd-logind[1423]: Session 23 logged out. Waiting for processes to exit. May 27 03:06:16.945519 systemd-logind[1423]: Removed session 23. May 27 03:06:21.713566 dockerd[2014]: time="2025-05-27T03:06:21.713312123Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904 error="context deadline exceeded" May 27 03:06:21.713917 systemd[1]: docker-75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904.scope: Deactivated successfully. May 27 03:06:22.949971 systemd[1]: Started sshd@23-10.0.0.133:22-10.0.0.1:59622.service - OpenSSH per-connection server daemon (10.0.0.1:59622). May 27 03:06:23.008455 sshd[2398]: Accepted publickey for core from 10.0.0.1 port 59622 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:23.009707 sshd-session[2398]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:23.014020 systemd-logind[1423]: New session 24 of user core. May 27 03:06:23.035917 systemd[1]: Started session-24.scope - Session 24 of User core. May 27 03:06:23.087357 sshd[2400]: Connection closed by 10.0.0.1 port 59622 May 27 03:06:23.087641 sshd-session[2398]: pam_unix(sshd:session): session closed for user core May 27 03:06:23.090058 systemd[1]: sshd@23-10.0.0.133:22-10.0.0.1:59622.service: Deactivated successfully. May 27 03:06:23.091467 systemd[1]: session-24.scope: Deactivated successfully. May 27 03:06:23.093571 systemd-logind[1423]: Session 24 logged out. Waiting for processes to exit. May 27 03:06:23.094401 systemd-logind[1423]: Removed session 24. May 27 03:06:24.711923 dockerd[2014]: time="2025-05-27T03:06:24.711795363Z" level=error msg="Force shutdown daemon" May 27 03:06:24.712562 dockerd[2014]: time="2025-05-27T03:06:24.712300462Z" level=info msg="Daemon shutdown complete" May 27 03:06:24.712562 dockerd[2014]: time="2025-05-27T03:06:24.712438439Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" May 27 03:06:24.712562 dockerd[2014]: time="2025-05-27T03:06:24.712467642Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby May 27 03:06:24.716789 systemd[1]: docker.service: Deactivated successfully. May 27 03:06:24.717855 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 27 03:06:24.718311 systemd[1]: docker.socket: Deactivated successfully. May 27 03:06:24.718595 systemd[1]: Closed docker.socket - Docker Socket for the API. May 27 03:06:24.718637 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 27 03:06:24.720122 systemd[1]: Starting docker.socket - Docker Socket for the API... May 27 03:06:24.720329 systemd[1]: containerd.service: Found left-over process 2290 (containerd-shim) in control group while starting unit. Ignoring. May 27 03:06:24.720339 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 27 03:06:24.726295 systemd[1]: Starting containerd.service - containerd container runtime... May 27 03:06:24.726563 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 27 03:06:24.736913 systemd[1]: containerd.service: Found left-over process 2290 (containerd-shim) in control group while starting unit. Ignoring. May 27 03:06:24.736926 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 27 03:06:24.740847 (ntainerd)[2411]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 27 03:06:24.753018 containerd[2411]: time="2025-05-27T03:06:24Z" 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 27 03:06:24.753550 containerd[2411]: time="2025-05-27T03:06:24.753515749Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 27 03:06:24.762473 containerd[2411]: time="2025-05-27T03:06:24.762433766Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.041µs" May 27 03:06:24.762473 containerd[2411]: time="2025-05-27T03:06:24.762467130Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 27 03:06:24.762539 containerd[2411]: time="2025-05-27T03:06:24.762484332Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 27 03:06:24.762539 containerd[2411]: time="2025-05-27T03:06:24.762518576Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 27 03:06:24.762539 containerd[2411]: time="2025-05-27T03:06:24.762530658Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 27 03:06:24.762730 containerd[2411]: time="2025-05-27T03:06:24.762701998Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 27 03:06:24.762757 containerd[2411]: time="2025-05-27T03:06:24.762734322Z" 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 27 03:06:24.762757 containerd[2411]: time="2025-05-27T03:06:24.762745403Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 27 03:06:24.763121 containerd[2411]: time="2025-05-27T03:06:24.763068722Z" 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 27 03:06:24.763543 containerd[2411]: time="2025-05-27T03:06:24.763502053Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 03:06:24.763570 containerd[2411]: time="2025-05-27T03:06:24.763550699Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 03:06:24.763595 containerd[2411]: time="2025-05-27T03:06:24.763569461Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 27 03:06:24.763788 containerd[2411]: time="2025-05-27T03:06:24.763639149Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 27 03:06:24.763894 containerd[2411]: time="2025-05-27T03:06:24.763879498Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 27 03:06:24.763920 containerd[2411]: time="2025-05-27T03:06:24.763909101Z" 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 27 03:06:24.763941 containerd[2411]: time="2025-05-27T03:06:24.763919262Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 27 03:06:24.763968 containerd[2411]: time="2025-05-27T03:06:24.763946346Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 27 03:06:24.764168 containerd[2411]: time="2025-05-27T03:06:24.764139288Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 27 03:06:24.764168 containerd[2411]: time="2025-05-27T03:06:24.764164011Z" level=info msg="metadata content store policy set" policy=shared May 27 03:06:24.764294 containerd[2411]: time="2025-05-27T03:06:24.764278585Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 27 03:06:24.764325 containerd[2411]: time="2025-05-27T03:06:24.764312669Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 27 03:06:24.764347 containerd[2411]: time="2025-05-27T03:06:24.764328631Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 27 03:06:24.764347 containerd[2411]: time="2025-05-27T03:06:24.764341272Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 27 03:06:24.764397 containerd[2411]: time="2025-05-27T03:06:24.764357354Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 27 03:06:24.764397 containerd[2411]: time="2025-05-27T03:06:24.764376717Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 27 03:06:24.764397 containerd[2411]: time="2025-05-27T03:06:24.764388958Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 27 03:06:24.764456 containerd[2411]: time="2025-05-27T03:06:24.764399959Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 27 03:06:24.764456 containerd[2411]: time="2025-05-27T03:06:24.764411481Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 27 03:06:24.764456 containerd[2411]: time="2025-05-27T03:06:24.764421522Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 27 03:06:24.764456 containerd[2411]: time="2025-05-27T03:06:24.764430843Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 27 03:06:24.764456 containerd[2411]: time="2025-05-27T03:06:24.764443084Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 27 03:06:24.764667 containerd[2411]: time="2025-05-27T03:06:24.764649469Z" level=info msg="connecting to shim 75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904" address="unix:///run/containerd/s/78fdeb892b066de13313b0c7b874a49e78702ed9e88c4499f9ce599141415eab" namespace=moby protocol=ttrpc version=3 May 27 03:06:24.771812 containerd[2411]: time="2025-05-27T03:06:24.771779154Z" level=info msg="cleaning leaked shim process" id=75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904 namespace=moby May 27 03:06:24.780295 containerd[2411]: time="2025-05-27T03:06:24.780248838Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 27 03:06:24.780717 containerd[2411]: time="2025-05-27T03:06:24.780642245Z" level=info msg="shim disconnected" id=75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904 namespace=moby May 27 03:06:24.780717 containerd[2411]: time="2025-05-27T03:06:24.780708573Z" level=warning msg="cleaning up after shim disconnected" id=75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904 namespace=moby May 27 03:06:24.780717 containerd[2411]: time="2025-05-27T03:06:24.780717174Z" level=info msg="cleaning up dead shim" namespace=moby May 27 03:06:24.789746 containerd[2411]: time="2025-05-27T03:06:24.789688278Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/6: file already closed" namespace=moby May 27 03:06:24.789881 containerd[2411]: time="2025-05-27T03:06:24.789850857Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 27 03:06:24.789919 containerd[2411]: time="2025-05-27T03:06:24.789891262Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 27 03:06:24.789919 containerd[2411]: time="2025-05-27T03:06:24.789909424Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 27 03:06:24.789919 containerd[2411]: time="2025-05-27T03:06:24.789920825Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 27 03:06:24.789988 containerd[2411]: time="2025-05-27T03:06:24.789932186Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 27 03:06:24.789988 containerd[2411]: time="2025-05-27T03:06:24.789945068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 27 03:06:24.789988 containerd[2411]: time="2025-05-27T03:06:24.789957069Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 27 03:06:24.789988 containerd[2411]: time="2025-05-27T03:06:24.789968351Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 27 03:06:24.789988 containerd[2411]: time="2025-05-27T03:06:24.789979992Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 27 03:06:24.790076 containerd[2411]: time="2025-05-27T03:06:24.789990793Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 27 03:06:24.790076 containerd[2411]: time="2025-05-27T03:06:24.790001755Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 27 03:06:24.790076 containerd[2411]: time="2025-05-27T03:06:24.790065402Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 27 03:06:24.790132 containerd[2411]: time="2025-05-27T03:06:24.790079844Z" level=info msg="Start snapshots syncer" May 27 03:06:24.790132 containerd[2411]: time="2025-05-27T03:06:24.790110408Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 27 03:06:24.790340 containerd[2411]: time="2025-05-27T03:06:24.790308631Z" 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 27 03:06:24.790440 containerd[2411]: time="2025-05-27T03:06:24.790356837Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 27 03:06:24.790440 containerd[2411]: time="2025-05-27T03:06:24.790434766Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 27 03:06:24.790497 containerd[2411]: time="2025-05-27T03:06:24.790478971Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 27 03:06:24.790525 containerd[2411]: time="2025-05-27T03:06:24.790516096Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 27 03:06:24.790550 containerd[2411]: time="2025-05-27T03:06:24.790528937Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 27 03:06:24.790550 containerd[2411]: time="2025-05-27T03:06:24.790539819Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 27 03:06:24.790604 containerd[2411]: time="2025-05-27T03:06:24.790553540Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 27 03:06:24.790604 containerd[2411]: time="2025-05-27T03:06:24.790565942Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 27 03:06:24.790604 containerd[2411]: time="2025-05-27T03:06:24.790576183Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 27 03:06:24.790604 containerd[2411]: time="2025-05-27T03:06:24.790602986Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790614187Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790625629Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790665873Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790681195Z" 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 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790689676Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790699157Z" 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 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790721560Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790731121Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 27 03:06:24.790755 containerd[2411]: time="2025-05-27T03:06:24.790743083Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 27 03:06:24.790984 containerd[2411]: time="2025-05-27T03:06:24.790788688Z" level=info msg="runtime interface created" May 27 03:06:24.790984 containerd[2411]: time="2025-05-27T03:06:24.790796449Z" level=info msg="created NRI interface" May 27 03:06:24.790984 containerd[2411]: time="2025-05-27T03:06:24.790805170Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 27 03:06:24.790984 containerd[2411]: time="2025-05-27T03:06:24.790816011Z" level=info msg="Connect containerd service" May 27 03:06:24.790984 containerd[2411]: time="2025-05-27T03:06:24.790841654Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 27 03:06:24.792007 containerd[2411]: time="2025-05-27T03:06:24.791969108Z" 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 27 03:06:24.800449 containerd[2411]: time="2025-05-27T03:06:24.800401428Z" level=info msg="Start subscribing containerd event" May 27 03:06:24.800556 containerd[2411]: time="2025-05-27T03:06:24.800520762Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 27 03:06:24.800608 containerd[2411]: time="2025-05-27T03:06:24.800581329Z" level=info msg=serving... address=/run/containerd/containerd.sock May 27 03:06:24.800657 containerd[2411]: time="2025-05-27T03:06:24.800643176Z" level=info msg="Start recovering state" May 27 03:06:24.800792 containerd[2411]: time="2025-05-27T03:06:24.800778512Z" level=info msg="Start event monitor" May 27 03:06:24.800914 containerd[2411]: time="2025-05-27T03:06:24.800854961Z" level=info msg="Start cni network conf syncer for default" May 27 03:06:24.800914 containerd[2411]: time="2025-05-27T03:06:24.800868123Z" level=info msg="Start streaming server" May 27 03:06:24.800914 containerd[2411]: time="2025-05-27T03:06:24.800878484Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 27 03:06:24.800914 containerd[2411]: time="2025-05-27T03:06:24.800885725Z" level=info msg="runtime interface starting up..." May 27 03:06:24.800914 containerd[2411]: time="2025-05-27T03:06:24.800891206Z" level=info msg="starting plugins..." May 27 03:06:24.801057 containerd[2411]: time="2025-05-27T03:06:24.800901287Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 27 03:06:24.801325 containerd[2411]: time="2025-05-27T03:06:24.801308135Z" level=info msg="containerd successfully booted in 0.048441s" May 27 03:06:24.801414 systemd[1]: Started containerd.service - containerd container runtime. May 27 03:06:24.803491 systemd[1]: Starting docker.service - Docker Application Container Engine... May 27 03:06:24.819075 (dockerd)[2459]: 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 27 03:06:24.843753 dockerd[2459]: time="2025-05-27T03:06:24.843693840Z" level=info msg="Starting up" May 27 03:06:24.844288 dockerd[2459]: time="2025-05-27T03:06:24.844259708Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 27 03:06:24.870680 dockerd[2459]: time="2025-05-27T03:06:24.870434011Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 27 03:06:24.871106 systemd[1]: var-lib-docker-overlay2-metacopy\x2dcheck1870227662-merged.mount: Deactivated successfully. May 27 03:06:24.879477 dockerd[2459]: time="2025-05-27T03:06:24.879435718Z" level=info msg="Loading containers: start." May 27 03:06:24.891380 systemd[1]: var-lib-docker-overlay2-dee544586f7f9e5925a0c3aa945fc301cc867cf531a7266a03f287f6e81d9361-merged.mount: Deactivated successfully. May 27 03:06:25.241378 systemd-networkd[1362]: vethda7c4ec: Link DOWN May 27 03:06:25.241383 systemd-networkd[1362]: vethda7c4ec: Lost carrier May 27 03:06:25.243184 kernel: docker0: port 1(vethda7c4ec) entered disabled state May 27 03:06:25.243220 kernel: vethda7c4ec (unregistering): left allmulticast mode May 27 03:06:25.243236 kernel: vethda7c4ec (unregistering): left promiscuous mode May 27 03:06:25.244136 kernel: docker0: port 1(vethda7c4ec) entered disabled state May 27 03:06:25.245275 systemd-networkd[1362]: docker0: Lost carrier May 27 03:06:25.245771 dockerd[2459]: time="2025-05-27T03:06:25.245519379Z" level=info msg="Removing stale sandbox 74282f1f67a7241b7259fce3021decdef2c6d7d89e923e3c4070bdbd7542638a (75782ef78ef33c4860de07bd7c47e945ef1f141a56019d4974fdeb64a2543904)" May 27 03:06:25.249636 dockerd[2459]: time="2025-05-27T03:06:25.249599884Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 27 03:06:25.249705 dockerd[2459]: time="2025-05-27T03:06:25.249645489Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint b930cb65c2ccd1711733d41df3f38161d7d192521dcec8894debf56230925f92 8564fe19e0c5c36c632996cfd9e6ff0ed5dff0fdd146bc31607d9fb4f3316cfc], retrying...." May 27 03:06:25.389453 dockerd[2459]: time="2025-05-27T03:06:25.389401126Z" level=warning msg="error locating sandbox id 74282f1f67a7241b7259fce3021decdef2c6d7d89e923e3c4070bdbd7542638a: sandbox 74282f1f67a7241b7259fce3021decdef2c6d7d89e923e3c4070bdbd7542638a not found" May 27 03:06:25.389453 dockerd[2459]: time="2025-05-27T03:06:25.389450532Z" level=warning msg="error locating sandbox id 938463617d3dba263d938b0799d66593acaf03c67ad3c37c52b1d5b297e1e64c: sandbox 938463617d3dba263d938b0799d66593acaf03c67ad3c37c52b1d5b297e1e64c not found" May 27 03:06:25.389583 dockerd[2459]: time="2025-05-27T03:06:25.389535662Z" level=info msg="Loading containers: done." May 27 03:06:25.398967 dockerd[2459]: time="2025-05-27T03:06:25.398922771Z" 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 27 03:06:25.399106 dockerd[2459]: time="2025-05-27T03:06:25.398996139Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 27 03:06:25.399106 dockerd[2459]: time="2025-05-27T03:06:25.399035184Z" level=info msg="Initializing buildkit" May 27 03:06:25.410209 dockerd[2459]: time="2025-05-27T03:06:25.410180173Z" level=info msg="Completed buildkit initialization" May 27 03:06:25.417493 dockerd[2459]: time="2025-05-27T03:06:25.417434279Z" level=info msg="Daemon has completed initialization" May 27 03:06:25.417493 dockerd[2459]: time="2025-05-27T03:06:25.417528690Z" level=info msg="API listen on /run/docker.sock" May 27 03:06:25.417676 systemd[1]: Started docker.service - Docker Application Container Engine. May 27 03:06:25.859973 systemd[1]: run-docker-netns-74282f1f67a7.mount: Deactivated successfully. May 27 03:06:29.103083 systemd[1]: Started sshd@24-10.0.0.133:22-10.0.0.1:59632.service - OpenSSH per-connection server daemon (10.0.0.1:59632). May 27 03:06:29.153932 sshd[2682]: Accepted publickey for core from 10.0.0.1 port 59632 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:29.152683 sshd-session[2682]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:29.158167 systemd-logind[1423]: New session 25 of user core. May 27 03:06:29.169980 systemd[1]: Started session-25.scope - Session 25 of User core. May 27 03:06:29.228502 sshd[2684]: Connection closed by 10.0.0.1 port 59632 May 27 03:06:29.229092 sshd-session[2682]: pam_unix(sshd:session): session closed for user core May 27 03:06:29.242225 systemd[1]: sshd@24-10.0.0.133:22-10.0.0.1:59632.service: Deactivated successfully. May 27 03:06:29.244982 systemd[1]: session-25.scope: Deactivated successfully. May 27 03:06:29.245721 systemd-logind[1423]: Session 25 logged out. Waiting for processes to exit. May 27 03:06:29.249210 systemd[1]: Started sshd@25-10.0.0.133:22-10.0.0.1:59640.service - OpenSSH per-connection server daemon (10.0.0.1:59640). May 27 03:06:29.249735 systemd-logind[1423]: Removed session 25. May 27 03:06:29.304728 sshd[2690]: Accepted publickey for core from 10.0.0.1 port 59640 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:29.307653 sshd-session[2690]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:29.312709 systemd-logind[1423]: New session 26 of user core. May 27 03:06:29.321958 systemd[1]: Started session-26.scope - Session 26 of User core. May 27 03:06:29.376402 sshd[2692]: Connection closed by 10.0.0.1 port 59640 May 27 03:06:29.376447 sshd-session[2690]: pam_unix(sshd:session): session closed for user core May 27 03:06:29.389826 systemd[1]: sshd@25-10.0.0.133:22-10.0.0.1:59640.service: Deactivated successfully. May 27 03:06:29.392095 systemd[1]: session-26.scope: Deactivated successfully. May 27 03:06:29.392843 systemd-logind[1423]: Session 26 logged out. Waiting for processes to exit. May 27 03:06:29.394995 systemd[1]: Started sshd@26-10.0.0.133:22-10.0.0.1:59656.service - OpenSSH per-connection server daemon (10.0.0.1:59656). May 27 03:06:29.396294 systemd-logind[1423]: Removed session 26. May 27 03:06:29.453363 sshd[2698]: Accepted publickey for core from 10.0.0.1 port 59656 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:29.476527 sshd-session[2698]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:29.480854 systemd-logind[1423]: New session 27 of user core. May 27 03:06:29.490159 systemd[1]: Started session-27.scope - Session 27 of User core. May 27 03:06:29.547321 sshd[2700]: Connection closed by 10.0.0.1 port 59656 May 27 03:06:29.548933 sshd-session[2698]: pam_unix(sshd:session): session closed for user core May 27 03:06:29.557945 systemd[1]: sshd@26-10.0.0.133:22-10.0.0.1:59656.service: Deactivated successfully. May 27 03:06:29.560159 systemd[1]: session-27.scope: Deactivated successfully. May 27 03:06:29.560875 systemd-logind[1423]: Session 27 logged out. Waiting for processes to exit. May 27 03:06:29.563223 systemd[1]: Started sshd@27-10.0.0.133:22-10.0.0.1:59672.service - OpenSSH per-connection server daemon (10.0.0.1:59672). May 27 03:06:29.564442 systemd-logind[1423]: Removed session 27. May 27 03:06:29.621140 sshd[2713]: Accepted publickey for core from 10.0.0.1 port 59672 ssh2: RSA SHA256:SbE+pbEGsQ3+BBFd86hKUXv5mFEyG6MA7PyvB6kMiX8 May 27 03:06:29.622452 sshd-session[2713]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 03:06:29.627102 systemd-logind[1423]: New session 28 of user core. May 27 03:06:29.632931 systemd[1]: Started session-28.scope - Session 28 of User core. May 27 03:06:29.728628 containerd[2411]: time="2025-05-27T03:06:29.728586172Z" level=info msg="connecting to shim f0f2e52e2a20ffbd24fd9692d08d0719887f75a203643634bd5e2c552d6a5888" address="unix:///run/containerd/s/57f1c2b5feca8e0d26861ba5455ddfcefc614c1baa1d1ffedc99cca76e2ee6c0" namespace=moby protocol=ttrpc version=3 May 27 03:06:29.748986 systemd[1]: Started docker-f0f2e52e2a20ffbd24fd9692d08d0719887f75a203643634bd5e2c552d6a5888.scope - libcontainer container f0f2e52e2a20ffbd24fd9692d08d0719887f75a203643634bd5e2c552d6a5888. May 27 03:06:29.759480 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 03:06:29.774814 kernel: docker0: port 1(veth0d81215) entered blocking state May 27 03:06:29.774902 kernel: docker0: port 1(veth0d81215) entered disabled state May 27 03:06:29.774922 kernel: veth0d81215: entered allmulticast mode May 27 03:06:29.775786 kernel: veth0d81215: entered promiscuous mode May 27 03:06:29.775779 systemd-networkd[1362]: veth0d81215: Link UP May 27 03:06:29.779791 kernel: eth0: renamed from veth0648628 May 27 03:06:29.781451 systemd-networkd[1362]: veth0d81215: Gained carrier May 27 03:06:29.781823 kernel: docker0: port 1(veth0d81215) entered blocking state May 27 03:06:29.781879 kernel: docker0: port 1(veth0d81215) entered forwarding state May 27 03:06:29.783461 systemd-networkd[1362]: docker0: Gained carrier May 27 03:06:29.799830 sshd[2715]: Connection closed by 10.0.0.1 port 59672 May 27 03:06:29.799663 sshd-session[2713]: pam_unix(sshd:session): session closed for user core May 27 03:06:29.803004 systemd-logind[1423]: Session 28 logged out. Waiting for processes to exit. May 27 03:06:29.803170 systemd[1]: sshd@27-10.0.0.133:22-10.0.0.1:59672.service: Deactivated successfully. May 27 03:06:29.806369 systemd[1]: session-28.scope: Deactivated successfully. May 27 03:06:29.807819 systemd-logind[1423]: Removed session 28.