May 16 16:05:01.831478 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 16 16:05:01.831507 kernel: Linux version 6.12.20-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 Fri May 16 14:51:29 -00 2025 May 16 16:05:01.831517 kernel: KASLR enabled May 16 16:05:01.831522 kernel: efi: EFI v2.7 by EDK II May 16 16:05:01.831528 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 May 16 16:05:01.831548 kernel: random: crng init done May 16 16:05:01.831555 kernel: secureboot: Secure boot disabled May 16 16:05:01.831560 kernel: ACPI: Early table checksum verification disabled May 16 16:05:01.831566 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) May 16 16:05:01.831573 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) May 16 16:05:01.831579 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831585 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831590 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831596 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831603 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831610 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831616 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831622 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831628 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 16 16:05:01.831634 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 16 16:05:01.831640 kernel: ACPI: Use ACPI SPCR as default console: Yes May 16 16:05:01.831646 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 16 16:05:01.831652 kernel: NODE_DATA(0) allocated [mem 0xdc965dc0-0xdc96cfff] May 16 16:05:01.831658 kernel: Zone ranges: May 16 16:05:01.831664 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 16 16:05:01.831671 kernel: DMA32 empty May 16 16:05:01.831677 kernel: Normal empty May 16 16:05:01.831683 kernel: Device empty May 16 16:05:01.831689 kernel: Movable zone start for each node May 16 16:05:01.831695 kernel: Early memory node ranges May 16 16:05:01.831701 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] May 16 16:05:01.831707 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] May 16 16:05:01.831713 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] May 16 16:05:01.831719 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] May 16 16:05:01.831725 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] May 16 16:05:01.831846 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] May 16 16:05:01.831853 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] May 16 16:05:01.831862 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] May 16 16:05:01.831869 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] May 16 16:05:01.831875 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] May 16 16:05:01.831884 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] May 16 16:05:01.831891 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] May 16 16:05:01.831897 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] May 16 16:05:01.831905 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 16 16:05:01.831912 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 16 16:05:01.831922 kernel: psci: probing for conduit method from ACPI. May 16 16:05:01.831928 kernel: psci: PSCIv1.1 detected in firmware. May 16 16:05:01.831935 kernel: psci: Using standard PSCI v0.2 function IDs May 16 16:05:01.831941 kernel: psci: Trusted OS migration not required May 16 16:05:01.831947 kernel: psci: SMC Calling Convention v1.1 May 16 16:05:01.831954 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 16 16:05:01.831960 kernel: percpu: Embedded 33 pages/cpu s98136 r8192 d28840 u135168 May 16 16:05:01.831966 kernel: pcpu-alloc: s98136 r8192 d28840 u135168 alloc=33*4096 May 16 16:05:01.831974 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 16 16:05:01.831981 kernel: Detected PIPT I-cache on CPU0 May 16 16:05:01.831987 kernel: CPU features: detected: GIC system register CPU interface May 16 16:05:01.831994 kernel: CPU features: detected: Spectre-v4 May 16 16:05:01.832000 kernel: CPU features: detected: Spectre-BHB May 16 16:05:01.832007 kernel: CPU features: kernel page table isolation forced ON by KASLR May 16 16:05:01.832013 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 16 16:05:01.832019 kernel: CPU features: detected: ARM erratum 1418040 May 16 16:05:01.832026 kernel: CPU features: detected: SSBS not fully self-synchronizing May 16 16:05:01.832032 kernel: alternatives: applying boot alternatives May 16 16:05:01.832040 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=a0bb4243d79ba36a710f39399156a0a3ffb1b3c5e7037b80b74649cdc67b3731 May 16 16:05:01.832049 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 16 16:05:01.832055 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 16 16:05:01.832062 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 16 16:05:01.832068 kernel: Fallback order for Node 0: 0 May 16 16:05:01.832075 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 May 16 16:05:01.832081 kernel: Policy zone: DMA May 16 16:05:01.832087 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 16 16:05:01.832094 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB May 16 16:05:01.832101 kernel: software IO TLB: area num 4. May 16 16:05:01.832107 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB May 16 16:05:01.832114 kernel: software IO TLB: mapped [mem 0x00000000d8c00000-0x00000000d9000000] (4MB) May 16 16:05:01.832122 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 16 16:05:01.832130 kernel: rcu: Preemptible hierarchical RCU implementation. May 16 16:05:01.832137 kernel: rcu: RCU event tracing is enabled. May 16 16:05:01.832144 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 16 16:05:01.832151 kernel: Trampoline variant of Tasks RCU enabled. May 16 16:05:01.832157 kernel: Tracing variant of Tasks RCU enabled. May 16 16:05:01.832164 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 16 16:05:01.832170 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 16 16:05:01.832177 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 16 16:05:01.832183 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 16 16:05:01.832190 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 16 16:05:01.832196 kernel: GICv3: 256 SPIs implemented May 16 16:05:01.832204 kernel: GICv3: 0 Extended SPIs implemented May 16 16:05:01.832211 kernel: Root IRQ handler: gic_handle_irq May 16 16:05:01.832217 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI May 16 16:05:01.832223 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 May 16 16:05:01.832230 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 16 16:05:01.832236 kernel: ITS [mem 0x08080000-0x0809ffff] May 16 16:05:01.832243 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400e0000 (indirect, esz 8, psz 64K, shr 1) May 16 16:05:01.832249 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400f0000 (flat, esz 8, psz 64K, shr 1) May 16 16:05:01.832256 kernel: GICv3: using LPI property table @0x0000000040100000 May 16 16:05:01.832262 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040110000 May 16 16:05:01.832269 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 16 16:05:01.832275 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 16:05:01.832283 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 16 16:05:01.832290 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 16 16:05:01.832296 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 16 16:05:01.832303 kernel: arm-pv: using stolen time PV May 16 16:05:01.832309 kernel: Console: colour dummy device 80x25 May 16 16:05:01.832316 kernel: ACPI: Core revision 20240827 May 16 16:05:01.832323 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 16 16:05:01.832329 kernel: pid_max: default: 32768 minimum: 301 May 16 16:05:01.832336 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 16 16:05:01.832352 kernel: landlock: Up and running. May 16 16:05:01.832360 kernel: SELinux: Initializing. May 16 16:05:01.832366 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 16 16:05:01.832373 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 16 16:05:01.832380 kernel: rcu: Hierarchical SRCU implementation. May 16 16:05:01.832386 kernel: rcu: Max phase no-delay instances is 400. May 16 16:05:01.832393 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 16 16:05:01.832400 kernel: Remapping and enabling EFI services. May 16 16:05:01.832406 kernel: smp: Bringing up secondary CPUs ... May 16 16:05:01.832413 kernel: Detected PIPT I-cache on CPU1 May 16 16:05:01.832426 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 16 16:05:01.832433 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040120000 May 16 16:05:01.832441 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 16:05:01.832448 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 16 16:05:01.832455 kernel: Detected PIPT I-cache on CPU2 May 16 16:05:01.832462 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 16 16:05:01.832469 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040130000 May 16 16:05:01.832477 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 16:05:01.832484 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 16 16:05:01.832491 kernel: Detected PIPT I-cache on CPU3 May 16 16:05:01.832498 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 16 16:05:01.832505 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040140000 May 16 16:05:01.832512 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 16:05:01.832519 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 16 16:05:01.832526 kernel: smp: Brought up 1 node, 4 CPUs May 16 16:05:01.832533 kernel: SMP: Total of 4 processors activated. May 16 16:05:01.832540 kernel: CPU: All CPU(s) started at EL1 May 16 16:05:01.832548 kernel: CPU features: detected: 32-bit EL0 Support May 16 16:05:01.832555 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 16 16:05:01.832562 kernel: CPU features: detected: Common not Private translations May 16 16:05:01.832581 kernel: CPU features: detected: CRC32 instructions May 16 16:05:01.832588 kernel: CPU features: detected: Enhanced Virtualization Traps May 16 16:05:01.832595 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 16 16:05:01.832602 kernel: CPU features: detected: LSE atomic instructions May 16 16:05:01.832609 kernel: CPU features: detected: Privileged Access Never May 16 16:05:01.832616 kernel: CPU features: detected: RAS Extension Support May 16 16:05:01.832624 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 16 16:05:01.832631 kernel: alternatives: applying system-wide alternatives May 16 16:05:01.832638 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 May 16 16:05:01.832646 kernel: Memory: 2440984K/2572288K available (11072K kernel code, 2276K rwdata, 8928K rodata, 39424K init, 1034K bss, 125536K reserved, 0K cma-reserved) May 16 16:05:01.832653 kernel: devtmpfs: initialized May 16 16:05:01.832660 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 16 16:05:01.832667 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 16 16:05:01.832674 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL May 16 16:05:01.832680 kernel: 0 pages in range for non-PLT usage May 16 16:05:01.832689 kernel: 508544 pages in range for PLT usage May 16 16:05:01.832695 kernel: pinctrl core: initialized pinctrl subsystem May 16 16:05:01.832702 kernel: SMBIOS 3.0.0 present. May 16 16:05:01.832709 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 May 16 16:05:01.832716 kernel: DMI: Memory slots populated: 1/1 May 16 16:05:01.832723 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 16 16:05:01.832740 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 16 16:05:01.832759 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 16 16:05:01.832768 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 16 16:05:01.832777 kernel: audit: initializing netlink subsys (disabled) May 16 16:05:01.832784 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 May 16 16:05:01.832791 kernel: thermal_sys: Registered thermal governor 'step_wise' May 16 16:05:01.832799 kernel: cpuidle: using governor menu May 16 16:05:01.832806 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 16 16:05:01.832813 kernel: ASID allocator initialised with 32768 entries May 16 16:05:01.832820 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 16 16:05:01.832827 kernel: Serial: AMBA PL011 UART driver May 16 16:05:01.832834 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 16 16:05:01.832843 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 16 16:05:01.832850 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 16 16:05:01.832857 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 16 16:05:01.832864 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 16 16:05:01.832871 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 16 16:05:01.832878 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 16 16:05:01.832885 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 16 16:05:01.832892 kernel: ACPI: Added _OSI(Module Device) May 16 16:05:01.832899 kernel: ACPI: Added _OSI(Processor Device) May 16 16:05:01.832907 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 16 16:05:01.832914 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 16 16:05:01.832921 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 16 16:05:01.832928 kernel: ACPI: Interpreter enabled May 16 16:05:01.832935 kernel: ACPI: Using GIC for interrupt routing May 16 16:05:01.832942 kernel: ACPI: MCFG table detected, 1 entries May 16 16:05:01.832949 kernel: ACPI: CPU0 has been hot-added May 16 16:05:01.832956 kernel: ACPI: CPU1 has been hot-added May 16 16:05:01.832963 kernel: ACPI: CPU2 has been hot-added May 16 16:05:01.832971 kernel: ACPI: CPU3 has been hot-added May 16 16:05:01.832978 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 16 16:05:01.832985 kernel: printk: legacy console [ttyAMA0] enabled May 16 16:05:01.832992 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 16 16:05:01.833129 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 16 16:05:01.833194 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 16 16:05:01.833254 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 16 16:05:01.833310 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 16 16:05:01.833388 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 16 16:05:01.833399 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 16 16:05:01.833406 kernel: PCI host bridge to bus 0000:00 May 16 16:05:01.833470 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 16 16:05:01.833527 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 16 16:05:01.833579 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 16 16:05:01.833631 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 16 16:05:01.833708 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint May 16 16:05:01.833804 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint May 16 16:05:01.833878 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] May 16 16:05:01.833942 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] May 16 16:05:01.834002 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] May 16 16:05:01.834060 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned May 16 16:05:01.834120 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned May 16 16:05:01.834179 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned May 16 16:05:01.834233 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 16 16:05:01.834286 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 16 16:05:01.834337 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 16 16:05:01.834352 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 16 16:05:01.834360 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 16 16:05:01.834367 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 16 16:05:01.834376 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 16 16:05:01.834383 kernel: iommu: Default domain type: Translated May 16 16:05:01.834390 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 16 16:05:01.834397 kernel: efivars: Registered efivars operations May 16 16:05:01.834404 kernel: vgaarb: loaded May 16 16:05:01.834411 kernel: clocksource: Switched to clocksource arch_sys_counter May 16 16:05:01.834418 kernel: VFS: Disk quotas dquot_6.6.0 May 16 16:05:01.834425 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 16 16:05:01.834432 kernel: pnp: PnP ACPI init May 16 16:05:01.834500 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 16 16:05:01.834510 kernel: pnp: PnP ACPI: found 1 devices May 16 16:05:01.834517 kernel: NET: Registered PF_INET protocol family May 16 16:05:01.834524 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 16 16:05:01.834531 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 16 16:05:01.834538 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 16 16:05:01.834545 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 16 16:05:01.834552 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 16 16:05:01.834561 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 16 16:05:01.834568 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 16 16:05:01.834575 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 16 16:05:01.834582 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 16 16:05:01.834589 kernel: PCI: CLS 0 bytes, default 64 May 16 16:05:01.834596 kernel: kvm [1]: HYP mode not available May 16 16:05:01.834603 kernel: Initialise system trusted keyrings May 16 16:05:01.834609 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 16 16:05:01.834616 kernel: Key type asymmetric registered May 16 16:05:01.834625 kernel: Asymmetric key parser 'x509' registered May 16 16:05:01.834632 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) May 16 16:05:01.834638 kernel: io scheduler mq-deadline registered May 16 16:05:01.834645 kernel: io scheduler kyber registered May 16 16:05:01.834652 kernel: io scheduler bfq registered May 16 16:05:01.834659 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 16 16:05:01.834666 kernel: ACPI: button: Power Button [PWRB] May 16 16:05:01.834673 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 16 16:05:01.834759 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 16 16:05:01.834773 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 16 16:05:01.834780 kernel: thunder_xcv, ver 1.0 May 16 16:05:01.834787 kernel: thunder_bgx, ver 1.0 May 16 16:05:01.834794 kernel: nicpf, ver 1.0 May 16 16:05:01.834801 kernel: nicvf, ver 1.0 May 16 16:05:01.834882 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 16 16:05:01.834940 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-16T16:05:01 UTC (1747411501) May 16 16:05:01.834949 kernel: hid: raw HID events driver (C) Jiri Kosina May 16 16:05:01.834958 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available May 16 16:05:01.834965 kernel: watchdog: NMI not fully supported May 16 16:05:01.834972 kernel: watchdog: Hard watchdog permanently disabled May 16 16:05:01.834979 kernel: NET: Registered PF_INET6 protocol family May 16 16:05:01.834986 kernel: Segment Routing with IPv6 May 16 16:05:01.834993 kernel: In-situ OAM (IOAM) with IPv6 May 16 16:05:01.834999 kernel: NET: Registered PF_PACKET protocol family May 16 16:05:01.835006 kernel: Key type dns_resolver registered May 16 16:05:01.835013 kernel: registered taskstats version 1 May 16 16:05:01.835021 kernel: Loading compiled-in X.509 certificates May 16 16:05:01.835029 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.20-flatcar: 27b8347ec414bf9dcd45b3eefdd645a09d039333' May 16 16:05:01.835036 kernel: Demotion targets for Node 0: null May 16 16:05:01.835043 kernel: Key type .fscrypt registered May 16 16:05:01.835049 kernel: Key type fscrypt-provisioning registered May 16 16:05:01.835056 kernel: ima: No TPM chip found, activating TPM-bypass! May 16 16:05:01.835063 kernel: ima: Allocated hash algorithm: sha1 May 16 16:05:01.835070 kernel: ima: No architecture policies found May 16 16:05:01.835077 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 16 16:05:01.835085 kernel: clk: Disabling unused clocks May 16 16:05:01.835092 kernel: PM: genpd: Disabling unused power domains May 16 16:05:01.835099 kernel: Warning: unable to open an initial console. May 16 16:05:01.835106 kernel: Freeing unused kernel memory: 39424K May 16 16:05:01.835113 kernel: Run /init as init process May 16 16:05:01.835120 kernel: with arguments: May 16 16:05:01.835127 kernel: /init May 16 16:05:01.835133 kernel: with environment: May 16 16:05:01.835140 kernel: HOME=/ May 16 16:05:01.835148 kernel: TERM=linux May 16 16:05:01.835155 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 16 16:05:01.835163 systemd[1]: Successfully made /usr/ read-only. May 16 16:05:01.835173 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 16 16:05:01.835180 systemd[1]: Detected virtualization kvm. May 16 16:05:01.835188 systemd[1]: Detected architecture arm64. May 16 16:05:01.835195 systemd[1]: Running in initrd. May 16 16:05:01.835203 systemd[1]: No hostname configured, using default hostname. May 16 16:05:01.835211 systemd[1]: Hostname set to . May 16 16:05:01.835218 systemd[1]: Initializing machine ID from VM UUID. May 16 16:05:01.835226 systemd[1]: Queued start job for default target initrd.target. May 16 16:05:01.835233 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 16:05:01.835241 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 16:05:01.835248 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 16 16:05:01.835256 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 16 16:05:01.835265 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 16 16:05:01.835273 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 16 16:05:01.835281 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 16 16:05:01.835289 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 16 16:05:01.835297 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 16:05:01.835304 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 16 16:05:01.835312 systemd[1]: Reached target paths.target - Path Units. May 16 16:05:01.835321 systemd[1]: Reached target slices.target - Slice Units. May 16 16:05:01.835328 systemd[1]: Reached target swap.target - Swaps. May 16 16:05:01.835336 systemd[1]: Reached target timers.target - Timer Units. May 16 16:05:01.835343 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 16 16:05:01.835360 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 16 16:05:01.835368 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 16 16:05:01.835375 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 16 16:05:01.835382 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 16 16:05:01.835390 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 16 16:05:01.835400 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 16 16:05:01.835407 systemd[1]: Reached target sockets.target - Socket Units. May 16 16:05:01.835415 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 16 16:05:01.835422 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 16 16:05:01.835429 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 16 16:05:01.835437 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 16 16:05:01.835445 systemd[1]: Starting systemd-fsck-usr.service... May 16 16:05:01.835452 systemd[1]: Starting systemd-journald.service - Journal Service... May 16 16:05:01.835460 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 16 16:05:01.835468 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 16:05:01.835475 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 16 16:05:01.835483 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 16 16:05:01.835493 systemd[1]: Finished systemd-fsck-usr.service. May 16 16:05:01.835502 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 16 16:05:01.835526 systemd-journald[243]: Collecting audit messages is disabled. May 16 16:05:01.835546 systemd-journald[243]: Journal started May 16 16:05:01.835565 systemd-journald[243]: Runtime Journal (/run/log/journal/99ca52a95e6f43dfa125b416284b28f6) is 6M, max 48.5M, 42.4M free. May 16 16:05:01.828292 systemd-modules-load[246]: Inserted module 'overlay' May 16 16:05:01.843500 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 16:05:01.843520 systemd[1]: Started systemd-journald.service - Journal Service. May 16 16:05:01.843531 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 16 16:05:01.845212 systemd-modules-load[246]: Inserted module 'br_netfilter' May 16 16:05:01.846280 kernel: Bridge firewalling registered May 16 16:05:01.847790 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 16 16:05:01.850054 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 16 16:05:01.852409 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 16:05:01.855605 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 16 16:05:01.866328 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 16 16:05:01.869804 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 16 16:05:01.874107 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 16 16:05:01.877859 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 16:05:01.878559 systemd-tmpfiles[272]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 16 16:05:01.882977 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 16:05:01.884215 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 16:05:01.887263 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 16 16:05:01.889595 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 16 16:05:01.914077 dracut-cmdline[287]: 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=a0bb4243d79ba36a710f39399156a0a3ffb1b3c5e7037b80b74649cdc67b3731 May 16 16:05:01.930531 systemd-resolved[288]: Positive Trust Anchors: May 16 16:05:01.930548 systemd-resolved[288]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 16 16:05:01.930580 systemd-resolved[288]: 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 16 16:05:01.935384 systemd-resolved[288]: Defaulting to hostname 'linux'. May 16 16:05:01.936317 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 16 16:05:01.940083 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 16 16:05:01.990751 kernel: SCSI subsystem initialized May 16 16:05:01.994768 kernel: Loading iSCSI transport class v2.0-870. May 16 16:05:02.002771 kernel: iscsi: registered transport (tcp) May 16 16:05:02.015763 kernel: iscsi: registered transport (qla4xxx) May 16 16:05:02.015781 kernel: QLogic iSCSI HBA Driver May 16 16:05:02.033602 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 16 16:05:02.052797 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 16 16:05:02.054851 systemd[1]: Reached target network-pre.target - Preparation for Network. May 16 16:05:02.096107 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 16 16:05:02.098316 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 16 16:05:02.162757 kernel: raid6: neonx8 gen() 15745 MB/s May 16 16:05:02.179759 kernel: raid6: neonx4 gen() 15786 MB/s May 16 16:05:02.196753 kernel: raid6: neonx2 gen() 13097 MB/s May 16 16:05:02.213760 kernel: raid6: neonx1 gen() 10429 MB/s May 16 16:05:02.230749 kernel: raid6: int64x8 gen() 6859 MB/s May 16 16:05:02.247750 kernel: raid6: int64x4 gen() 7312 MB/s May 16 16:05:02.264750 kernel: raid6: int64x2 gen() 6074 MB/s May 16 16:05:02.281846 kernel: raid6: int64x1 gen() 5008 MB/s May 16 16:05:02.281868 kernel: raid6: using algorithm neonx4 gen() 15786 MB/s May 16 16:05:02.299822 kernel: raid6: .... xor() 12260 MB/s, rmw enabled May 16 16:05:02.299837 kernel: raid6: using neon recovery algorithm May 16 16:05:02.304788 kernel: xor: measuring software checksum speed May 16 16:05:02.306044 kernel: 8regs : 17811 MB/sec May 16 16:05:02.306061 kernel: 32regs : 21670 MB/sec May 16 16:05:02.307274 kernel: arm64_neon : 27889 MB/sec May 16 16:05:02.307289 kernel: xor: using function: arm64_neon (27889 MB/sec) May 16 16:05:02.363755 kernel: Btrfs loaded, zoned=no, fsverity=no May 16 16:05:02.370001 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 16 16:05:02.372367 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 16:05:02.399275 systemd-udevd[498]: Using default interface naming scheme 'v255'. May 16 16:05:02.403290 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 16:05:02.405597 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 16 16:05:02.432706 dracut-pre-trigger[507]: rd.md=0: removing MD RAID activation May 16 16:05:02.453031 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 16 16:05:02.455132 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 16 16:05:02.508924 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 16 16:05:02.512887 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 16 16:05:02.553392 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues May 16 16:05:02.557408 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 16 16:05:02.557504 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 16:05:02.564565 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 16:05:02.564637 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 16:05:02.566834 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 16 16:05:02.569843 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 16:05:02.584354 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 16 16:05:02.595460 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 16 16:05:02.596696 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 16:05:02.607161 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 16 16:05:02.617537 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 16 16:05:02.618739 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 16 16:05:02.627284 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 16 16:05:02.628485 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 16 16:05:02.630546 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 16:05:02.632624 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 16 16:05:02.635219 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 16 16:05:02.637018 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 16 16:05:02.654992 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 16:05:02.660359 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 16 16:05:03.667407 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 16:05:03.667467 disk-uuid[593]: The operation has completed successfully. May 16 16:05:03.691418 systemd[1]: disk-uuid.service: Deactivated successfully. May 16 16:05:03.691517 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 16 16:05:03.716234 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 16 16:05:03.736321 sh[610]: Success May 16 16:05:03.751498 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 16 16:05:03.751542 kernel: device-mapper: uevent: version 1.0.3 May 16 16:05:03.753180 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 16 16:05:03.763762 kernel: device-mapper: verity: sha256 using shash "sha256-ce" May 16 16:05:03.795521 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 16 16:05:03.798201 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 16 16:05:03.809406 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 16 16:05:03.817417 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' May 16 16:05:03.817448 kernel: BTRFS: device fsid 87f734d5-e9e0-4da0-9e65-ee17bdaa6a26 devid 1 transid 41 /dev/mapper/usr (253:0) scanned by mount (622) May 16 16:05:03.818776 kernel: BTRFS info (device dm-0): first mount of filesystem 87f734d5-e9e0-4da0-9e65-ee17bdaa6a26 May 16 16:05:03.818797 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 16 16:05:03.820334 kernel: BTRFS info (device dm-0): using free-space-tree May 16 16:05:03.823991 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 16 16:05:03.825135 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 16 16:05:03.826471 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 16 16:05:03.827159 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 16 16:05:03.828557 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 16 16:05:03.847743 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (654) May 16 16:05:03.850774 kernel: BTRFS info (device vda6): first mount of filesystem 2ff0c403-fbe0-45df-941b-f7dd331fa2eb May 16 16:05:03.850811 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 16 16:05:03.850822 kernel: BTRFS info (device vda6): using free-space-tree May 16 16:05:03.857749 kernel: BTRFS info (device vda6): last unmount of filesystem 2ff0c403-fbe0-45df-941b-f7dd331fa2eb May 16 16:05:03.857883 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 16 16:05:03.859754 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 16 16:05:03.916627 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 16 16:05:03.920918 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 16 16:05:03.954569 systemd-networkd[794]: lo: Link UP May 16 16:05:03.954582 systemd-networkd[794]: lo: Gained carrier May 16 16:05:03.955326 systemd-networkd[794]: Enumeration completed May 16 16:05:03.955872 systemd-networkd[794]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 16:05:03.955876 systemd-networkd[794]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 16 16:05:03.956419 systemd-networkd[794]: eth0: Link UP May 16 16:05:03.956422 systemd-networkd[794]: eth0: Gained carrier May 16 16:05:03.956430 systemd-networkd[794]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 16:05:03.956680 systemd[1]: Started systemd-networkd.service - Network Configuration. May 16 16:05:03.957997 systemd[1]: Reached target network.target - Network. May 16 16:05:03.972791 systemd-networkd[794]: eth0: DHCPv4 address 10.0.0.36/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 16 16:05:03.988068 ignition[704]: Ignition 2.21.0 May 16 16:05:03.988080 ignition[704]: Stage: fetch-offline May 16 16:05:03.988113 ignition[704]: no configs at "/usr/lib/ignition/base.d" May 16 16:05:03.988121 ignition[704]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 16:05:03.988290 ignition[704]: parsed url from cmdline: "" May 16 16:05:03.988293 ignition[704]: no config URL provided May 16 16:05:03.988297 ignition[704]: reading system config file "/usr/lib/ignition/user.ign" May 16 16:05:03.988303 ignition[704]: no config at "/usr/lib/ignition/user.ign" May 16 16:05:03.988319 ignition[704]: op(1): [started] loading QEMU firmware config module May 16 16:05:03.988323 ignition[704]: op(1): executing: "modprobe" "qemu_fw_cfg" May 16 16:05:04.000545 ignition[704]: op(1): [finished] loading QEMU firmware config module May 16 16:05:04.003533 ignition[704]: parsing config with SHA512: 936391f2c9ea411614e2549047ecb6ee4df4c994ad615cbd63d1c8430a1b009b78f902988410804b9a0f748b62b7da87696735e682d38c6d9c647c25c3c18c37 May 16 16:05:04.009287 unknown[704]: fetched base config from "system" May 16 16:05:04.009299 unknown[704]: fetched user config from "qemu" May 16 16:05:04.009468 ignition[704]: fetch-offline: fetch-offline passed May 16 16:05:04.009545 ignition[704]: Ignition finished successfully May 16 16:05:04.011936 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 16 16:05:04.013746 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 16 16:05:04.014581 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 16 16:05:04.039998 ignition[808]: Ignition 2.21.0 May 16 16:05:04.040014 ignition[808]: Stage: kargs May 16 16:05:04.040150 ignition[808]: no configs at "/usr/lib/ignition/base.d" May 16 16:05:04.040160 ignition[808]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 16:05:04.041331 ignition[808]: kargs: kargs passed May 16 16:05:04.041400 ignition[808]: Ignition finished successfully May 16 16:05:04.046263 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 16 16:05:04.048039 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 16 16:05:04.071610 ignition[816]: Ignition 2.21.0 May 16 16:05:04.071626 ignition[816]: Stage: disks May 16 16:05:04.071781 ignition[816]: no configs at "/usr/lib/ignition/base.d" May 16 16:05:04.071790 ignition[816]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 16:05:04.072939 ignition[816]: disks: disks passed May 16 16:05:04.074448 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 16 16:05:04.073009 ignition[816]: Ignition finished successfully May 16 16:05:04.075801 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 16 16:05:04.077833 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 16 16:05:04.078921 systemd[1]: Reached target local-fs.target - Local File Systems. May 16 16:05:04.080489 systemd[1]: Reached target sysinit.target - System Initialization. May 16 16:05:04.081937 systemd[1]: Reached target basic.target - Basic System. May 16 16:05:04.084271 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 16 16:05:04.107432 systemd-fsck[826]: ROOT: clean, 15/553520 files, 52789/553472 blocks May 16 16:05:04.111405 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 16 16:05:04.113674 systemd[1]: Mounting sysroot.mount - /sysroot... May 16 16:05:04.177641 systemd[1]: Mounted sysroot.mount - /sysroot. May 16 16:05:04.179228 kernel: EXT4-fs (vda9): mounted filesystem 0ada590e-bc2d-44be-b1f0-1b069cf0a0c5 r/w with ordered data mode. Quota mode: none. May 16 16:05:04.178832 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 16 16:05:04.181853 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 16 16:05:04.183998 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 16 16:05:04.184875 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 16 16:05:04.184912 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 16 16:05:04.184937 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 16 16:05:04.196785 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 16 16:05:04.199194 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 16 16:05:04.203748 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (834) May 16 16:05:04.203783 kernel: BTRFS info (device vda6): first mount of filesystem 2ff0c403-fbe0-45df-941b-f7dd331fa2eb May 16 16:05:04.205789 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 16 16:05:04.205806 kernel: BTRFS info (device vda6): using free-space-tree May 16 16:05:04.208826 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 16 16:05:04.242111 initrd-setup-root[859]: cut: /sysroot/etc/passwd: No such file or directory May 16 16:05:04.245821 initrd-setup-root[866]: cut: /sysroot/etc/group: No such file or directory May 16 16:05:04.248607 initrd-setup-root[873]: cut: /sysroot/etc/shadow: No such file or directory May 16 16:05:04.251277 initrd-setup-root[880]: cut: /sysroot/etc/gshadow: No such file or directory May 16 16:05:04.319102 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 16 16:05:04.322792 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 16 16:05:04.334854 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 16 16:05:04.339738 kernel: BTRFS info (device vda6): last unmount of filesystem 2ff0c403-fbe0-45df-941b-f7dd331fa2eb May 16 16:05:04.354341 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 16 16:05:04.355936 ignition[949]: INFO : Ignition 2.21.0 May 16 16:05:04.355936 ignition[949]: INFO : Stage: mount May 16 16:05:04.355936 ignition[949]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 16:05:04.355936 ignition[949]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 16:05:04.355936 ignition[949]: INFO : mount: mount passed May 16 16:05:04.355936 ignition[949]: INFO : Ignition finished successfully May 16 16:05:04.357898 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 16 16:05:04.359788 systemd[1]: Starting ignition-files.service - Ignition (files)... May 16 16:05:04.824954 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 16 16:05:04.826383 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 16 16:05:04.852393 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (963) May 16 16:05:04.852423 kernel: BTRFS info (device vda6): first mount of filesystem 2ff0c403-fbe0-45df-941b-f7dd331fa2eb May 16 16:05:04.853352 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 16 16:05:04.853367 kernel: BTRFS info (device vda6): using free-space-tree May 16 16:05:04.856546 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 16 16:05:04.887939 ignition[981]: INFO : Ignition 2.21.0 May 16 16:05:04.887939 ignition[981]: INFO : Stage: files May 16 16:05:04.889429 ignition[981]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 16:05:04.889429 ignition[981]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 16:05:04.892481 ignition[981]: DEBUG : files: compiled without relabeling support, skipping May 16 16:05:04.895131 ignition[981]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 16 16:05:04.895131 ignition[981]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 16 16:05:04.897936 ignition[981]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 16 16:05:04.897936 ignition[981]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 16 16:05:04.897936 ignition[981]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 16 16:05:04.897175 unknown[981]: wrote ssh authorized keys file for user: core May 16 16:05:04.903007 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 16 16:05:04.903007 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 16 16:05:04.903007 ignition[981]: INFO : files: op(4): [started] processing unit "docker.service" May 16 16:05:04.903007 ignition[981]: INFO : files: op(4): [finished] processing unit "docker.service" May 16 16:05:04.903007 ignition[981]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" May 16 16:05:04.903007 ignition[981]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 16 16:05:04.911963 ignition[981]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 16 16:05:04.911963 ignition[981]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" May 16 16:05:04.911963 ignition[981]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" May 16 16:05:04.916910 ignition[981]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" May 16 16:05:04.919353 ignition[981]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 16 16:05:04.920705 ignition[981]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" May 16 16:05:04.920705 ignition[981]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" May 16 16:05:04.920705 ignition[981]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" May 16 16:05:04.920705 ignition[981]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 16 16:05:04.920705 ignition[981]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 16 16:05:04.920705 ignition[981]: INFO : files: files passed May 16 16:05:04.920705 ignition[981]: INFO : Ignition finished successfully May 16 16:05:04.921096 systemd[1]: Finished ignition-files.service - Ignition (files). May 16 16:05:04.923461 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 16 16:05:04.925199 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 16 16:05:04.939785 systemd[1]: ignition-quench.service: Deactivated successfully. May 16 16:05:04.940861 initrd-setup-root-after-ignition[1009]: grep: /sysroot/oem/oem-release: No such file or directory May 16 16:05:04.941772 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 16 16:05:04.944460 initrd-setup-root-after-ignition[1011]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 16 16:05:04.944460 initrd-setup-root-after-ignition[1011]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 16 16:05:04.947562 initrd-setup-root-after-ignition[1015]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 16 16:05:04.948369 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 16 16:05:04.950111 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 16 16:05:04.952485 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 16 16:05:04.980525 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 16 16:05:04.980630 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 16 16:05:04.982630 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 16 16:05:04.984388 systemd[1]: Reached target initrd.target - Initrd Default Target. May 16 16:05:04.986004 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 16 16:05:04.986685 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 16 16:05:05.017174 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 16 16:05:05.019219 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 16 16:05:05.035857 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 16 16:05:05.036873 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 16:05:05.038642 systemd[1]: Stopped target timers.target - Timer Units. May 16 16:05:05.040227 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 16 16:05:05.040340 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 16 16:05:05.042543 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 16 16:05:05.043531 systemd[1]: Stopped target basic.target - Basic System. May 16 16:05:05.045148 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 16 16:05:05.046624 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 16 16:05:05.048186 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 16 16:05:05.049761 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 16 16:05:05.051539 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 16 16:05:05.053135 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 16 16:05:05.054802 systemd[1]: Stopped target sysinit.target - System Initialization. May 16 16:05:05.056479 systemd[1]: Stopped target local-fs.target - Local File Systems. May 16 16:05:05.058290 systemd[1]: Stopped target swap.target - Swaps. May 16 16:05:05.059573 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 16 16:05:05.059690 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 16 16:05:05.061717 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 16 16:05:05.063409 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 16:05:05.065032 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 16 16:05:05.065790 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 16:05:05.067769 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 16 16:05:05.067875 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 16 16:05:05.070500 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 16 16:05:05.070616 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 16 16:05:05.072306 systemd[1]: Stopped target paths.target - Path Units. May 16 16:05:05.073590 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 16 16:05:05.073688 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 16:05:05.075468 systemd[1]: Stopped target slices.target - Slice Units. May 16 16:05:05.076999 systemd[1]: Stopped target sockets.target - Socket Units. May 16 16:05:05.078363 systemd[1]: iscsid.socket: Deactivated successfully. May 16 16:05:05.078440 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 16 16:05:05.079861 systemd[1]: iscsiuio.socket: Deactivated successfully. May 16 16:05:05.079932 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 16 16:05:05.081661 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 16 16:05:05.081780 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 16 16:05:05.083318 systemd[1]: ignition-files.service: Deactivated successfully. May 16 16:05:05.083423 systemd[1]: Stopped ignition-files.service - Ignition (files). May 16 16:05:05.085370 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 16 16:05:05.087310 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 16 16:05:05.088054 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 16 16:05:05.088177 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 16 16:05:05.089829 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 16 16:05:05.089924 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 16 16:05:05.096744 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 16 16:05:05.097614 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 16 16:05:05.098905 systemd-networkd[794]: eth0: Gained IPv6LL May 16 16:05:05.102679 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 16 16:05:05.107465 systemd[1]: sysroot-boot.service: Deactivated successfully. May 16 16:05:05.107580 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 16 16:05:05.109962 ignition[1036]: INFO : Ignition 2.21.0 May 16 16:05:05.109962 ignition[1036]: INFO : Stage: umount May 16 16:05:05.109962 ignition[1036]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 16:05:05.109962 ignition[1036]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 16:05:05.109962 ignition[1036]: INFO : umount: umount passed May 16 16:05:05.109962 ignition[1036]: INFO : Ignition finished successfully May 16 16:05:05.111350 systemd[1]: ignition-mount.service: Deactivated successfully. May 16 16:05:05.112760 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 16 16:05:05.114313 systemd[1]: Stopped target network.target - Network. May 16 16:05:05.115591 systemd[1]: ignition-disks.service: Deactivated successfully. May 16 16:05:05.115645 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 16 16:05:05.117182 systemd[1]: ignition-kargs.service: Deactivated successfully. May 16 16:05:05.117227 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 16 16:05:05.118611 systemd[1]: ignition-setup.service: Deactivated successfully. May 16 16:05:05.118660 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 16 16:05:05.120154 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 16 16:05:05.120195 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 16 16:05:05.121631 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 16 16:05:05.121679 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 16 16:05:05.123314 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 16 16:05:05.124851 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 16 16:05:05.132944 systemd[1]: systemd-resolved.service: Deactivated successfully. May 16 16:05:05.133077 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 16 16:05:05.136001 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 16 16:05:05.136182 systemd[1]: systemd-networkd.service: Deactivated successfully. May 16 16:05:05.136266 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 16 16:05:05.139423 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. May 16 16:05:05.139982 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 16 16:05:05.141573 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 16 16:05:05.141610 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 16 16:05:05.144238 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 16 16:05:05.145007 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 16 16:05:05.145057 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 16 16:05:05.146721 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 16 16:05:05.146777 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 16 16:05:05.149357 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 16 16:05:05.149401 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 16 16:05:05.151043 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 16 16:05:05.151084 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 16:05:05.153672 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 16:05:05.176389 systemd[1]: network-cleanup.service: Deactivated successfully. May 16 16:05:05.176504 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 16 16:05:05.179243 systemd[1]: systemd-udevd.service: Deactivated successfully. May 16 16:05:05.179395 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 16:05:05.183042 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 16 16:05:05.183078 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 16 16:05:05.184714 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 16 16:05:05.184807 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 16 16:05:05.186375 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 16 16:05:05.186419 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 16 16:05:05.188704 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 16 16:05:05.188797 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 16 16:05:05.191100 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 16 16:05:05.191145 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 16:05:05.194100 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 16 16:05:05.195297 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 16 16:05:05.195356 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 16 16:05:05.198076 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 16 16:05:05.198118 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 16:05:05.200874 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 16 16:05:05.200913 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 16 16:05:05.203803 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 16 16:05:05.203843 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 16 16:05:05.205833 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 16:05:05.205874 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 16:05:05.209206 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 16 16:05:05.209299 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 16 16:05:05.210951 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 16 16:05:05.213072 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 16 16:05:05.229884 systemd[1]: Switching root. May 16 16:05:05.258758 systemd-journald[243]: Received SIGTERM from PID 1 (systemd). May 16 16:05:05.258803 systemd-journald[243]: Journal stopped May 16 16:05:05.920878 kernel: SELinux: policy capability network_peer_controls=1 May 16 16:05:05.920925 kernel: SELinux: policy capability open_perms=1 May 16 16:05:05.920936 kernel: SELinux: policy capability extended_socket_class=1 May 16 16:05:05.920946 kernel: SELinux: policy capability always_check_network=0 May 16 16:05:05.920954 kernel: SELinux: policy capability cgroup_seclabel=1 May 16 16:05:05.920963 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 16 16:05:05.920975 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 16 16:05:05.920985 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 16 16:05:05.920998 kernel: SELinux: policy capability userspace_initial_context=0 May 16 16:05:05.921014 systemd[1]: Successfully loaded SELinux policy in 49.103ms. May 16 16:05:05.921030 kernel: audit: type=1403 audit(1747411505.344:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 16 16:05:05.921040 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.359ms. May 16 16:05:05.921050 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 16 16:05:05.921061 systemd[1]: Detected virtualization kvm. May 16 16:05:05.921071 systemd[1]: Detected architecture arm64. May 16 16:05:05.921080 systemd[1]: Detected first boot. May 16 16:05:05.921091 systemd[1]: Initializing machine ID from VM UUID. May 16 16:05:05.921101 zram_generator::config[1081]: No configuration found. May 16 16:05:05.921111 kernel: NET: Registered PF_VSOCK protocol family May 16 16:05:05.921121 systemd[1]: Populated /etc with preset unit settings. May 16 16:05:05.921131 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 16 16:05:05.921144 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 16 16:05:05.921157 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 16 16:05:05.921167 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 16 16:05:05.921177 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 16 16:05:05.921188 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 16 16:05:05.921198 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 16 16:05:05.921208 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 16 16:05:05.921217 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 16 16:05:05.921228 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 16 16:05:05.921239 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 16 16:05:05.921248 systemd[1]: Created slice user.slice - User and Session Slice. May 16 16:05:05.921258 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 16:05:05.921269 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 16:05:05.921279 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 16 16:05:05.921289 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 16 16:05:05.921299 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 16 16:05:05.921308 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 16 16:05:05.921318 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... May 16 16:05:05.921341 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 16:05:05.921354 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 16 16:05:05.921363 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 16 16:05:05.921373 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 16 16:05:05.921383 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 16 16:05:05.921392 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 16 16:05:05.921402 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 16:05:05.921413 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 16 16:05:05.921425 systemd[1]: Reached target slices.target - Slice Units. May 16 16:05:05.921435 systemd[1]: Reached target swap.target - Swaps. May 16 16:05:05.921445 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 16 16:05:05.921454 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 16 16:05:05.921464 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 16 16:05:05.921473 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 16 16:05:05.921483 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 16 16:05:05.921493 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 16 16:05:05.921502 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 16 16:05:05.921514 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 16 16:05:05.921523 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 16 16:05:05.921533 systemd[1]: Mounting media.mount - External Media Directory... May 16 16:05:05.921543 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 16 16:05:05.921553 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 16 16:05:05.921563 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 16 16:05:05.921573 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 16 16:05:05.921582 systemd[1]: Reached target machines.target - Containers. May 16 16:05:05.921593 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 16 16:05:05.921603 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 16:05:05.921612 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 16 16:05:05.921623 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 16 16:05:05.921633 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 16:05:05.921643 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 16 16:05:05.921653 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 16:05:05.921662 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 16 16:05:05.921672 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 16:05:05.921684 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 16 16:05:05.921693 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 16 16:05:05.921703 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 16 16:05:05.921713 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 16 16:05:05.921722 systemd[1]: Stopped systemd-fsck-usr.service. May 16 16:05:05.921747 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 16 16:05:05.921758 kernel: fuse: init (API version 7.41) May 16 16:05:05.921767 systemd[1]: Starting systemd-journald.service - Journal Service... May 16 16:05:05.921779 kernel: loop: module loaded May 16 16:05:05.921789 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 16 16:05:05.921798 kernel: ACPI: bus type drm_connector registered May 16 16:05:05.921807 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 16 16:05:05.921818 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 16 16:05:05.921827 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 16 16:05:05.921837 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 16 16:05:05.921848 systemd[1]: verity-setup.service: Deactivated successfully. May 16 16:05:05.921857 systemd[1]: Stopped verity-setup.service. May 16 16:05:05.921867 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 16 16:05:05.921876 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 16 16:05:05.921903 systemd-journald[1154]: Collecting audit messages is disabled. May 16 16:05:05.921927 systemd-journald[1154]: Journal started May 16 16:05:05.921946 systemd-journald[1154]: Runtime Journal (/run/log/journal/99ca52a95e6f43dfa125b416284b28f6) is 6M, max 48.5M, 42.4M free. May 16 16:05:05.715568 systemd[1]: Queued start job for default target multi-user.target. May 16 16:05:05.734540 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 16 16:05:05.734884 systemd[1]: systemd-journald.service: Deactivated successfully. May 16 16:05:05.922753 systemd[1]: Mounted media.mount - External Media Directory. May 16 16:05:05.926072 systemd[1]: Started systemd-journald.service - Journal Service. May 16 16:05:05.926709 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 16 16:05:05.927767 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 16 16:05:05.928826 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 16 16:05:05.930816 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 16 16:05:05.932048 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 16 16:05:05.933372 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 16 16:05:05.933540 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 16 16:05:05.935848 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 16:05:05.936064 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 16:05:05.937226 systemd[1]: modprobe@drm.service: Deactivated successfully. May 16 16:05:05.937379 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 16 16:05:05.938555 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 16:05:05.938703 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 16:05:05.940040 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 16 16:05:05.940185 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 16 16:05:05.941313 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 16:05:05.941473 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 16:05:05.942800 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 16 16:05:05.943944 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 16 16:05:05.945210 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 16 16:05:05.946492 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 16 16:05:05.956499 systemd[1]: Reached target network-pre.target - Preparation for Network. May 16 16:05:05.958776 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 16 16:05:05.960533 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 16 16:05:05.961607 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 16 16:05:05.961635 systemd[1]: Reached target local-fs.target - Local File Systems. May 16 16:05:05.963427 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 16 16:05:05.970418 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 16 16:05:05.971638 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 16:05:05.973008 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 16 16:05:05.974705 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 16 16:05:05.975708 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 16 16:05:05.976851 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 16 16:05:05.977927 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 16 16:05:05.979627 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 16 16:05:05.982958 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 16 16:05:05.985498 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 16 16:05:05.986068 systemd-journald[1154]: Time spent on flushing to /var/log/journal/99ca52a95e6f43dfa125b416284b28f6 is 21.350ms for 854 entries. May 16 16:05:05.986068 systemd-journald[1154]: System Journal (/var/log/journal/99ca52a95e6f43dfa125b416284b28f6) is 8M, max 195.6M, 187.6M free. May 16 16:05:06.012930 systemd-journald[1154]: Received client request to flush runtime journal. May 16 16:05:06.012976 kernel: loop0: detected capacity change from 0 to 138376 May 16 16:05:05.991801 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 16 16:05:05.992973 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 16 16:05:05.995823 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 16 16:05:06.005004 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 16 16:05:06.007058 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 16 16:05:06.009973 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 16 16:05:06.022963 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 16 16:05:06.024754 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 16 16:05:06.025385 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 16 16:05:06.035789 systemd-tmpfiles[1198]: ACLs are not supported, ignoring. May 16 16:05:06.035805 systemd-tmpfiles[1198]: ACLs are not supported, ignoring. May 16 16:05:06.038899 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 16 16:05:06.040300 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 16 16:05:06.043942 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 16 16:05:06.047781 kernel: loop1: detected capacity change from 0 to 107312 May 16 16:05:06.069206 kernel: loop2: detected capacity change from 0 to 138376 May 16 16:05:06.075737 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 16 16:05:06.080937 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 16 16:05:06.084839 kernel: loop3: detected capacity change from 0 to 107312 May 16 16:05:06.088444 (sd-merge)[1218]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 16 16:05:06.088775 (sd-merge)[1218]: Merged extensions into '/usr'. May 16 16:05:06.091891 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 16 16:05:06.094842 systemd[1]: Starting ensure-sysext.service... May 16 16:05:06.097875 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 16 16:05:06.105741 systemd-tmpfiles[1220]: ACLs are not supported, ignoring. May 16 16:05:06.105986 systemd-tmpfiles[1220]: ACLs are not supported, ignoring. May 16 16:05:06.109932 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 16:05:06.119879 systemd[1]: Reload requested from client PID 1223 ('systemctl') (unit ensure-sysext.service)... May 16 16:05:06.119904 systemd[1]: Reloading... May 16 16:05:06.121980 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 16 16:05:06.122122 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 16 16:05:06.122324 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 16 16:05:06.122521 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 16 16:05:06.123272 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 16 16:05:06.123513 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. May 16 16:05:06.123564 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. May 16 16:05:06.126158 systemd-tmpfiles[1224]: Detected autofs mount point /boot during canonicalization of boot. May 16 16:05:06.126168 systemd-tmpfiles[1224]: Skipping /boot May 16 16:05:06.134435 systemd-tmpfiles[1224]: Detected autofs mount point /boot during canonicalization of boot. May 16 16:05:06.134448 systemd-tmpfiles[1224]: Skipping /boot May 16 16:05:06.175825 zram_generator::config[1250]: No configuration found. May 16 16:05:06.250886 ldconfig[1192]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 16 16:05:06.258593 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 16 16:05:06.319213 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 16 16:05:06.319296 systemd[1]: Reloading finished in 198 ms. May 16 16:05:06.350030 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 16 16:05:06.362765 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 16:05:06.369740 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 16:05:06.371672 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 16 16:05:06.382940 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 16 16:05:06.395850 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 16 16:05:06.400005 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 16 16:05:06.405280 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 16:05:06.406262 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 16:05:06.408567 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 16:05:06.418715 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 16:05:06.419720 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 16:05:06.419842 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 16 16:05:06.424782 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 16 16:05:06.426802 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 16 16:05:06.428474 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 16 16:05:06.430049 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 16:05:06.436095 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 16:05:06.437681 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 16:05:06.437916 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 16:05:06.439536 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 16:05:06.439665 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 16:05:06.441405 augenrules[1317]: No rules May 16 16:05:06.444923 systemd[1]: audit-rules.service: Deactivated successfully. May 16 16:05:06.445102 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 16:05:06.452844 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 16:05:06.454112 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 16:05:06.457953 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 16:05:06.463816 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 16:05:06.464717 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 16:05:06.464885 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 16 16:05:06.465033 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 16 16:05:06.466395 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 16:05:06.466571 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 16:05:06.468373 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 16:05:06.468503 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 16:05:06.470113 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 16:05:06.470245 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 16:05:06.473054 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 16 16:05:06.476197 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 16 16:05:06.481870 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 16 16:05:06.498825 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 16:05:06.499679 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 16:05:06.500705 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 16:05:06.502593 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 16 16:05:06.505628 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 16:05:06.507913 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 16:05:06.510179 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 16:05:06.510294 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 16 16:05:06.511521 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 16:05:06.513487 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 16 16:05:06.514661 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 16 16:05:06.516431 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 16:05:06.516583 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 16:05:06.519297 systemd[1]: modprobe@drm.service: Deactivated successfully. May 16 16:05:06.519785 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 16 16:05:06.521927 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 16:05:06.522069 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 16:05:06.523444 augenrules[1341]: /sbin/augenrules: No change May 16 16:05:06.524017 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 16:05:06.524153 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 16:05:06.525919 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 16 16:05:06.530696 systemd[1]: Finished ensure-sysext.service. May 16 16:05:06.533507 augenrules[1367]: No rules May 16 16:05:06.535357 systemd[1]: audit-rules.service: Deactivated successfully. May 16 16:05:06.536770 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 16:05:06.539650 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 16 16:05:06.539724 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 16 16:05:06.541539 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 16 16:05:06.546941 systemd-udevd[1353]: Using default interface naming scheme 'v255'. May 16 16:05:06.562151 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 16:05:06.563598 systemd-resolved[1298]: Positive Trust Anchors: May 16 16:05:06.563609 systemd-resolved[1298]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 16 16:05:06.563640 systemd-resolved[1298]: 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 16 16:05:06.566879 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 16 16:05:06.572917 systemd-resolved[1298]: Defaulting to hostname 'linux'. May 16 16:05:06.574803 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 16 16:05:06.576406 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 16 16:05:06.621837 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. May 16 16:05:06.640259 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 16 16:05:06.642538 systemd[1]: Reached target sysinit.target - System Initialization. May 16 16:05:06.644849 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 16 16:05:06.646102 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 16 16:05:06.647198 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 16 16:05:06.648281 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 16 16:05:06.648312 systemd[1]: Reached target paths.target - Path Units. May 16 16:05:06.649449 systemd[1]: Reached target time-set.target - System Time Set. May 16 16:05:06.650509 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 16 16:05:06.651870 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 16 16:05:06.653232 systemd[1]: Reached target timers.target - Timer Units. May 16 16:05:06.655315 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 16 16:05:06.657517 systemd[1]: Starting docker.socket - Docker Socket for the API... May 16 16:05:06.661117 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 16 16:05:06.662793 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 16 16:05:06.664873 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 16 16:05:06.669600 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 16 16:05:06.670976 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 16 16:05:06.672568 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 16 16:05:06.679453 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 16 16:05:06.680827 systemd[1]: Reached target sockets.target - Socket Units. May 16 16:05:06.681982 systemd[1]: Reached target basic.target - Basic System. May 16 16:05:06.682943 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 16 16:05:06.682972 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 16 16:05:06.684128 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 16 16:05:06.687716 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 16 16:05:06.689881 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 16 16:05:06.691848 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 16 16:05:06.693795 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 16 16:05:06.699099 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 16 16:05:06.700936 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 16 16:05:06.706177 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 16 16:05:06.711885 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 16 16:05:06.713831 jq[1419]: false May 16 16:05:06.726433 systemd[1]: Starting systemd-logind.service - User Login Management... May 16 16:05:06.729593 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 16 16:05:06.729993 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 16 16:05:06.734657 systemd-networkd[1386]: lo: Link UP May 16 16:05:06.734877 extend-filesystems[1420]: Found loop2 May 16 16:05:06.734877 extend-filesystems[1420]: Found loop3 May 16 16:05:06.734877 extend-filesystems[1420]: Found vda May 16 16:05:06.734877 extend-filesystems[1420]: Found vda1 May 16 16:05:06.734877 extend-filesystems[1420]: Found vda2 May 16 16:05:06.734877 extend-filesystems[1420]: Found vda3 May 16 16:05:06.734877 extend-filesystems[1420]: Found usr May 16 16:05:06.734877 extend-filesystems[1420]: Found vda4 May 16 16:05:06.746657 extend-filesystems[1420]: Found vda6 May 16 16:05:06.746657 extend-filesystems[1420]: Found vda7 May 16 16:05:06.746657 extend-filesystems[1420]: Found vda9 May 16 16:05:06.746657 extend-filesystems[1420]: Checking size of /dev/vda9 May 16 16:05:06.746657 extend-filesystems[1420]: Old size kept for /dev/vda9 May 16 16:05:06.734926 systemd[1]: Starting update-engine.service - Update Engine... May 16 16:05:06.735028 systemd-networkd[1386]: lo: Gained carrier May 16 16:05:06.738696 systemd-networkd[1386]: Enumeration completed May 16 16:05:06.758946 jq[1439]: true May 16 16:05:06.738765 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 16 16:05:06.739201 systemd-networkd[1386]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 16:05:06.739205 systemd-networkd[1386]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 16 16:05:06.742056 systemd-networkd[1386]: eth0: Link UP May 16 16:05:06.742152 systemd-networkd[1386]: eth0: Gained carrier May 16 16:05:06.742166 systemd-networkd[1386]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 16:05:06.742309 systemd[1]: Started systemd-networkd.service - Network Configuration. May 16 16:05:06.745092 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 16 16:05:06.754216 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 16 16:05:06.755765 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 16 16:05:06.756001 systemd[1]: extend-filesystems.service: Deactivated successfully. May 16 16:05:06.756148 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 16 16:05:06.760422 systemd[1]: motdgen.service: Deactivated successfully. May 16 16:05:06.761786 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 16 16:05:06.762941 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 16 16:05:06.763147 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 16 16:05:06.764754 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 16 16:05:06.766284 systemd-networkd[1386]: eth0: DHCPv4 address 10.0.0.36/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 16 16:05:06.771176 systemd-timesyncd[1377]: Network configuration changed, trying to establish connection. May 16 16:05:06.772704 systemd[1]: Reached target network.target - Network. May 16 16:05:06.773504 systemd-timesyncd[1377]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 16 16:05:06.773547 systemd-timesyncd[1377]: Initial clock synchronization to Fri 2025-05-16 16:05:06.992618 UTC. May 16 16:05:06.783261 jq[1455]: true May 16 16:05:06.782667 systemd[1]: Starting containerd.service - containerd container runtime... May 16 16:05:06.784821 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 16 16:05:06.790505 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 16 16:05:06.810670 (ntainerd)[1472]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 16 16:05:06.813016 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 16:05:06.818043 dbus-daemon[1417]: [system] SELinux support is enabled May 16 16:05:06.818432 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 16 16:05:06.820128 update_engine[1433]: I20250516 16:05:06.815660 1433 main.cc:92] Flatcar Update Engine starting May 16 16:05:06.823637 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 16 16:05:06.823665 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 16 16:05:06.825808 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 16 16:05:06.825830 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 16 16:05:06.830314 systemd[1]: Started update-engine.service - Update Engine. May 16 16:05:06.831473 update_engine[1433]: I20250516 16:05:06.831413 1433 update_check_scheduler.cc:74] Next update check in 8m1s May 16 16:05:06.840982 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 16 16:05:06.843457 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 16 16:05:06.873827 bash[1490]: Updated "/home/core/.ssh/authorized_keys" May 16 16:05:06.875769 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 16 16:05:06.877671 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 16 16:05:06.899493 systemd-logind[1432]: Watching system buttons on /dev/input/event0 (Power Button) May 16 16:05:06.901883 systemd-logind[1432]: New seat seat0. May 16 16:05:06.902423 systemd[1]: Started systemd-logind.service - User Login Management. May 16 16:05:06.951783 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 16:05:06.968518 locksmithd[1489]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 16 16:05:06.992449 sshd_keygen[1443]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 16 16:05:07.011799 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 16 16:05:07.017551 systemd[1]: Starting issuegen.service - Generate /run/issue... May 16 16:05:07.029240 containerd[1472]: time="2025-05-16T16:05:07Z" 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 16 16:05:07.031242 containerd[1472]: time="2025-05-16T16:05:07.031186907Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 16 16:05:07.034147 systemd[1]: issuegen.service: Deactivated successfully. May 16 16:05:07.034367 systemd[1]: Finished issuegen.service - Generate /run/issue. May 16 16:05:07.037535 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 16 16:05:07.042049 containerd[1472]: time="2025-05-16T16:05:07.042008192Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.918µs" May 16 16:05:07.042049 containerd[1472]: time="2025-05-16T16:05:07.042038438Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 16 16:05:07.042118 containerd[1472]: time="2025-05-16T16:05:07.042056479Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 16 16:05:07.042221 containerd[1472]: time="2025-05-16T16:05:07.042190452Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 16 16:05:07.042221 containerd[1472]: time="2025-05-16T16:05:07.042210917Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 16 16:05:07.042266 containerd[1472]: time="2025-05-16T16:05:07.042233602Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 16 16:05:07.042295 containerd[1472]: time="2025-05-16T16:05:07.042280739Z" 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 16 16:05:07.042321 containerd[1472]: time="2025-05-16T16:05:07.042295164Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 16 16:05:07.042520 containerd[1472]: time="2025-05-16T16:05:07.042484575Z" 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 16 16:05:07.042520 containerd[1472]: time="2025-05-16T16:05:07.042510671Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 16 16:05:07.042560 containerd[1472]: time="2025-05-16T16:05:07.042522959Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 16 16:05:07.042560 containerd[1472]: time="2025-05-16T16:05:07.042535657Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 16 16:05:07.042623 containerd[1472]: time="2025-05-16T16:05:07.042607657Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 16 16:05:07.042841 containerd[1472]: time="2025-05-16T16:05:07.042822547Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 16 16:05:07.042875 containerd[1472]: time="2025-05-16T16:05:07.042857356Z" 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 16 16:05:07.042897 containerd[1472]: time="2025-05-16T16:05:07.042871904Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 16 16:05:07.042922 containerd[1472]: time="2025-05-16T16:05:07.042904657Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 16 16:05:07.043532 containerd[1472]: time="2025-05-16T16:05:07.043475602Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 16 16:05:07.043604 containerd[1472]: time="2025-05-16T16:05:07.043582903Z" level=info msg="metadata content store policy set" policy=shared May 16 16:05:07.047669 containerd[1472]: time="2025-05-16T16:05:07.047595628Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 16 16:05:07.047669 containerd[1472]: time="2025-05-16T16:05:07.047647039Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 16 16:05:07.047669 containerd[1472]: time="2025-05-16T16:05:07.047662286Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 16 16:05:07.047669 containerd[1472]: time="2025-05-16T16:05:07.047675149Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047688423Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047700053Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047712423Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047723971Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047735601Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047746039Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047767327Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047781300Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047885396Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 16 16:05:07.047918 containerd[1472]: time="2025-05-16T16:05:07.047912067Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047926122Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047937875Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047948108Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047958711Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047969519Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047979259Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.047990354Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.048000587Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 16 16:05:07.048072 containerd[1472]: time="2025-05-16T16:05:07.048010943Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 16 16:05:07.048220 containerd[1472]: time="2025-05-16T16:05:07.048191395Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 16 16:05:07.048220 containerd[1472]: time="2025-05-16T16:05:07.048206724Z" level=info msg="Start snapshots syncer" May 16 16:05:07.048278 containerd[1472]: time="2025-05-16T16:05:07.048235532Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 16 16:05:07.048470 containerd[1472]: time="2025-05-16T16:05:07.048436080Z" 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 16 16:05:07.048571 containerd[1472]: time="2025-05-16T16:05:07.048482971Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 16 16:05:07.048571 containerd[1472]: time="2025-05-16T16:05:07.048559286Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 16 16:05:07.048690 containerd[1472]: time="2025-05-16T16:05:07.048669587Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 16 16:05:07.048720 containerd[1472]: time="2025-05-16T16:05:07.048700162Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 16 16:05:07.048720 containerd[1472]: time="2025-05-16T16:05:07.048712491Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 16 16:05:07.048767 containerd[1472]: time="2025-05-16T16:05:07.048722930Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 16 16:05:07.048767 containerd[1472]: time="2025-05-16T16:05:07.048734806Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 16 16:05:07.048767 containerd[1472]: time="2025-05-16T16:05:07.048745861Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 16 16:05:07.048827 containerd[1472]: time="2025-05-16T16:05:07.048766121Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 16 16:05:07.048827 containerd[1472]: time="2025-05-16T16:05:07.048793820Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 16 16:05:07.048827 containerd[1472]: time="2025-05-16T16:05:07.048805450Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 16 16:05:07.048827 containerd[1472]: time="2025-05-16T16:05:07.048815436Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 16 16:05:07.048890 containerd[1472]: time="2025-05-16T16:05:07.048851601Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 16 16:05:07.048890 containerd[1472]: time="2025-05-16T16:05:07.048868491Z" 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 16 16:05:07.048890 containerd[1472]: time="2025-05-16T16:05:07.048877327Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 16 16:05:07.048890 containerd[1472]: time="2025-05-16T16:05:07.048886286Z" 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 16 16:05:07.048958 containerd[1472]: time="2025-05-16T16:05:07.048893765Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 16 16:05:07.048958 containerd[1472]: time="2025-05-16T16:05:07.048903464Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 16 16:05:07.048958 containerd[1472]: time="2025-05-16T16:05:07.048913203Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 16 16:05:07.049006 containerd[1472]: time="2025-05-16T16:05:07.048991861Z" level=info msg="runtime interface created" May 16 16:05:07.049006 containerd[1472]: time="2025-05-16T16:05:07.048997039Z" level=info msg="created NRI interface" May 16 16:05:07.049040 containerd[1472]: time="2025-05-16T16:05:07.049005546Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 16 16:05:07.049040 containerd[1472]: time="2025-05-16T16:05:07.049016313Z" level=info msg="Connect containerd service" May 16 16:05:07.049073 containerd[1472]: time="2025-05-16T16:05:07.049039656Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 16 16:05:07.049667 containerd[1472]: time="2025-05-16T16:05:07.049617957Z" 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 16 16:05:07.059284 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 16 16:05:07.062354 systemd[1]: Started getty@tty1.service - Getty on tty1. May 16 16:05:07.064506 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. May 16 16:05:07.065912 systemd[1]: Reached target getty.target - Login Prompts. May 16 16:05:07.148306 containerd[1472]: time="2025-05-16T16:05:07.148221193Z" level=info msg="Start subscribing containerd event" May 16 16:05:07.148306 containerd[1472]: time="2025-05-16T16:05:07.148306837Z" level=info msg="Start recovering state" May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148382576Z" level=info msg="Start event monitor" May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148395152Z" level=info msg="Start cni network conf syncer for default" May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148407809Z" level=info msg="Start streaming server" May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148416480Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148423713Z" level=info msg="runtime interface starting up..." May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148429384Z" level=info msg="starting plugins..." May 16 16:05:07.148438 containerd[1472]: time="2025-05-16T16:05:07.148441056Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 16 16:05:07.148780 containerd[1472]: time="2025-05-16T16:05:07.148691371Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 16 16:05:07.148780 containerd[1472]: time="2025-05-16T16:05:07.148731521Z" level=info msg=serving... address=/run/containerd/containerd.sock May 16 16:05:07.148848 containerd[1472]: time="2025-05-16T16:05:07.148788809Z" level=info msg="containerd successfully booted in 0.119876s" May 16 16:05:07.148890 systemd[1]: Started containerd.service - containerd container runtime. May 16 16:05:08.746992 systemd-networkd[1386]: eth0: Gained IPv6LL May 16 16:05:08.750147 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 16 16:05:08.752007 systemd[1]: Reached target network-online.target - Network is Online. May 16 16:05:08.756175 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 16 16:05:08.758041 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 16 16:05:08.787009 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 16 16:05:08.789068 systemd[1]: coreos-metadata.service: Deactivated successfully. May 16 16:05:08.789234 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 16 16:05:08.790926 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 16 16:05:08.791101 systemd[1]: Reached target multi-user.target - Multi-User System. May 16 16:05:08.793861 systemd[1]: Startup finished in 2.143s (kernel) + 3.713s (initrd) + 3.502s (userspace) = 9.359s. May 16 16:05:15.151111 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 16 16:05:15.152190 systemd[1]: Started sshd@0-10.0.0.36:22-10.0.0.1:50020.service - OpenSSH per-connection server daemon (10.0.0.1:50020). May 16 16:05:15.222404 sshd[1564]: Accepted publickey for core from 10.0.0.1 port 50020 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:15.224005 sshd-session[1564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:15.231599 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 16 16:05:15.232497 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 16 16:05:15.237507 systemd-logind[1432]: New session 1 of user core. May 16 16:05:15.253440 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 16 16:05:15.255828 systemd[1]: Starting user@500.service - User Manager for UID 500... May 16 16:05:15.272644 (systemd)[1568]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 16 16:05:15.274825 systemd-logind[1432]: New session c1 of user core. May 16 16:05:15.383730 systemd[1568]: Queued start job for default target default.target. May 16 16:05:15.399647 systemd[1568]: Created slice app.slice - User Application Slice. May 16 16:05:15.399677 systemd[1568]: Reached target paths.target - Paths. May 16 16:05:15.399718 systemd[1568]: Reached target timers.target - Timers. May 16 16:05:15.400907 systemd[1568]: Starting dbus.socket - D-Bus User Message Bus Socket... May 16 16:05:15.409540 systemd[1568]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 16 16:05:15.409604 systemd[1568]: Reached target sockets.target - Sockets. May 16 16:05:15.409638 systemd[1568]: Reached target basic.target - Basic System. May 16 16:05:15.409664 systemd[1568]: Reached target default.target - Main User Target. May 16 16:05:15.409695 systemd[1568]: Startup finished in 128ms. May 16 16:05:15.409954 systemd[1]: Started user@500.service - User Manager for UID 500. May 16 16:05:15.411300 systemd[1]: Started session-1.scope - Session 1 of User core. May 16 16:05:15.479293 systemd[1]: Started sshd@1-10.0.0.36:22-10.0.0.1:50034.service - OpenSSH per-connection server daemon (10.0.0.1:50034). May 16 16:05:15.522833 sshd[1579]: Accepted publickey for core from 10.0.0.1 port 50034 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:15.524047 sshd-session[1579]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:15.528793 systemd-logind[1432]: New session 2 of user core. May 16 16:05:15.542915 systemd[1]: Started session-2.scope - Session 2 of User core. May 16 16:05:15.594207 sshd[1581]: Connection closed by 10.0.0.1 port 50034 May 16 16:05:15.594514 sshd-session[1579]: pam_unix(sshd:session): session closed for user core May 16 16:05:15.608988 systemd[1]: sshd@1-10.0.0.36:22-10.0.0.1:50034.service: Deactivated successfully. May 16 16:05:15.610484 systemd[1]: session-2.scope: Deactivated successfully. May 16 16:05:15.611228 systemd-logind[1432]: Session 2 logged out. Waiting for processes to exit. May 16 16:05:15.613968 systemd[1]: Started sshd@2-10.0.0.36:22-10.0.0.1:50036.service - OpenSSH per-connection server daemon (10.0.0.1:50036). May 16 16:05:15.614718 systemd-logind[1432]: Removed session 2. May 16 16:05:15.671621 sshd[1587]: Accepted publickey for core from 10.0.0.1 port 50036 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:15.673083 sshd-session[1587]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:15.676896 systemd-logind[1432]: New session 3 of user core. May 16 16:05:15.682892 systemd[1]: Started session-3.scope - Session 3 of User core. May 16 16:05:15.730831 sshd[1589]: Connection closed by 10.0.0.1 port 50036 May 16 16:05:15.731606 sshd-session[1587]: pam_unix(sshd:session): session closed for user core May 16 16:05:15.751804 systemd[1]: sshd@2-10.0.0.36:22-10.0.0.1:50036.service: Deactivated successfully. May 16 16:05:15.753235 systemd[1]: session-3.scope: Deactivated successfully. May 16 16:05:15.753900 systemd-logind[1432]: Session 3 logged out. Waiting for processes to exit. May 16 16:05:15.755940 systemd[1]: Started sshd@3-10.0.0.36:22-10.0.0.1:50052.service - OpenSSH per-connection server daemon (10.0.0.1:50052). May 16 16:05:15.756684 systemd-logind[1432]: Removed session 3. May 16 16:05:15.806505 sshd[1595]: Accepted publickey for core from 10.0.0.1 port 50052 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:15.807821 sshd-session[1595]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:15.811862 systemd-logind[1432]: New session 4 of user core. May 16 16:05:15.823993 systemd[1]: Started session-4.scope - Session 4 of User core. May 16 16:05:15.875006 sshd[1597]: Connection closed by 10.0.0.1 port 50052 May 16 16:05:15.875309 sshd-session[1595]: pam_unix(sshd:session): session closed for user core May 16 16:05:15.894391 systemd[1]: sshd@3-10.0.0.36:22-10.0.0.1:50052.service: Deactivated successfully. May 16 16:05:15.895959 systemd[1]: session-4.scope: Deactivated successfully. May 16 16:05:15.896706 systemd-logind[1432]: Session 4 logged out. Waiting for processes to exit. May 16 16:05:15.899090 systemd[1]: Started sshd@4-10.0.0.36:22-10.0.0.1:50056.service - OpenSSH per-connection server daemon (10.0.0.1:50056). May 16 16:05:15.899783 systemd-logind[1432]: Removed session 4. May 16 16:05:15.956932 sshd[1603]: Accepted publickey for core from 10.0.0.1 port 50056 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:15.958082 sshd-session[1603]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:15.963301 systemd-logind[1432]: New session 5 of user core. May 16 16:05:15.973980 systemd[1]: Started session-5.scope - Session 5 of User core. May 16 16:05:16.036216 sudo[1606]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 16 16:05:16.036857 sudo[1606]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 16:05:16.049346 sudo[1606]: pam_unix(sudo:session): session closed for user root May 16 16:05:16.050805 sshd[1605]: Connection closed by 10.0.0.1 port 50056 May 16 16:05:16.051132 sshd-session[1603]: pam_unix(sshd:session): session closed for user core May 16 16:05:16.068948 systemd[1]: sshd@4-10.0.0.36:22-10.0.0.1:50056.service: Deactivated successfully. May 16 16:05:16.070334 systemd[1]: session-5.scope: Deactivated successfully. May 16 16:05:16.072410 systemd-logind[1432]: Session 5 logged out. Waiting for processes to exit. May 16 16:05:16.074875 systemd[1]: Started sshd@5-10.0.0.36:22-10.0.0.1:50066.service - OpenSSH per-connection server daemon (10.0.0.1:50066). May 16 16:05:16.075555 systemd-logind[1432]: Removed session 5. May 16 16:05:16.140107 sshd[1612]: Accepted publickey for core from 10.0.0.1 port 50066 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:16.141416 sshd-session[1612]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:16.145801 systemd-logind[1432]: New session 6 of user core. May 16 16:05:16.156899 systemd[1]: Started session-6.scope - Session 6 of User core. May 16 16:05:16.207564 sudo[1616]: 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 16 16:05:16.207884 sudo[1616]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 16:05:16.212712 sudo[1616]: pam_unix(sudo:session): session closed for user root May 16 16:05:16.217136 sudo[1615]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 16 16:05:16.217390 sudo[1615]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 16:05:16.225361 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 16:05:16.271324 augenrules[1638]: No rules May 16 16:05:16.272526 systemd[1]: audit-rules.service: Deactivated successfully. May 16 16:05:16.272774 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 16:05:16.273730 sudo[1615]: pam_unix(sudo:session): session closed for user root May 16 16:05:16.275255 sshd[1614]: Connection closed by 10.0.0.1 port 50066 May 16 16:05:16.275515 sshd-session[1612]: pam_unix(sshd:session): session closed for user core May 16 16:05:16.284646 systemd[1]: sshd@5-10.0.0.36:22-10.0.0.1:50066.service: Deactivated successfully. May 16 16:05:16.287249 systemd[1]: session-6.scope: Deactivated successfully. May 16 16:05:16.288062 systemd-logind[1432]: Session 6 logged out. Waiting for processes to exit. May 16 16:05:16.290602 systemd[1]: Started sshd@6-10.0.0.36:22-10.0.0.1:50070.service - OpenSSH per-connection server daemon (10.0.0.1:50070). May 16 16:05:16.291370 systemd-logind[1432]: Removed session 6. May 16 16:05:16.347529 sshd[1647]: Accepted publickey for core from 10.0.0.1 port 50070 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:16.348884 sshd-session[1647]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:16.353695 systemd-logind[1432]: New session 7 of user core. May 16 16:05:16.366930 systemd[1]: Started session-7.scope - Session 7 of User core. May 16 16:05:16.425996 systemd[1]: Starting docker.service - Docker Application Container Engine... May 16 16:05:16.439032 (dockerd)[1651]: 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 16 16:05:16.716909 dockerd[1651]: time="2025-05-16T16:05:16.716849353Z" level=info msg="Starting up" May 16 16:05:16.718204 dockerd[1651]: time="2025-05-16T16:05:16.718174701Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 16 16:05:16.747672 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport891728262-merged.mount: Deactivated successfully. May 16 16:05:16.760401 systemd[1]: var-lib-docker-metacopy\x2dcheck1217473870-merged.mount: Deactivated successfully. May 16 16:05:16.770788 dockerd[1651]: time="2025-05-16T16:05:16.770742491Z" level=info msg="Loading containers: start." May 16 16:05:16.780844 kernel: Initializing XFRM netlink socket May 16 16:05:16.987717 systemd-networkd[1386]: docker0: Link UP May 16 16:05:16.992518 dockerd[1651]: time="2025-05-16T16:05:16.992474079Z" level=info msg="Loading containers: done." May 16 16:05:17.006824 dockerd[1651]: time="2025-05-16T16:05:17.006774810Z" 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 16 16:05:17.007011 dockerd[1651]: time="2025-05-16T16:05:17.006854823Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 16 16:05:17.007011 dockerd[1651]: time="2025-05-16T16:05:17.006952361Z" level=info msg="Initializing buildkit" May 16 16:05:17.036398 dockerd[1651]: time="2025-05-16T16:05:17.036344609Z" level=info msg="Completed buildkit initialization" May 16 16:05:17.041856 dockerd[1651]: time="2025-05-16T16:05:17.041489626Z" level=info msg="Daemon has completed initialization" May 16 16:05:17.041856 dockerd[1651]: time="2025-05-16T16:05:17.041579026Z" level=info msg="API listen on /run/docker.sock" May 16 16:05:17.041973 systemd[1]: Started docker.service - Docker Application Container Engine. May 16 16:05:17.050180 sshd[1649]: Connection closed by 10.0.0.1 port 50070 May 16 16:05:17.050599 sshd-session[1647]: pam_unix(sshd:session): session closed for user core May 16 16:05:17.065934 systemd[1]: sshd@6-10.0.0.36:22-10.0.0.1:50070.service: Deactivated successfully. May 16 16:05:17.067382 systemd[1]: session-7.scope: Deactivated successfully. May 16 16:05:17.068089 systemd-logind[1432]: Session 7 logged out. Waiting for processes to exit. May 16 16:05:17.070445 systemd[1]: Started sshd@7-10.0.0.36:22-10.0.0.1:50072.service - OpenSSH per-connection server daemon (10.0.0.1:50072). May 16 16:05:17.070965 systemd-logind[1432]: Removed session 7. May 16 16:05:17.131130 sshd[1857]: Accepted publickey for core from 10.0.0.1 port 50072 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:17.132462 sshd-session[1857]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:17.136813 systemd-logind[1432]: New session 8 of user core. May 16 16:05:17.146924 systemd[1]: Started session-8.scope - Session 8 of User core. May 16 16:05:18.723591 systemd[1]: var-lib-docker-overlay2-3a6660cc5af6f968ac28fc9408ff0d015949cc827a6b7f0bfcbfcf5cb05d774a\x2dinit-merged.mount: Deactivated successfully. May 16 16:05:18.778477 containerd[1472]: time="2025-05-16T16:05:18.778427561Z" level=info msg="connecting to shim 39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334" address="unix:///run/containerd/s/b70a63d120f70ed7dbfca4623d123f99c587b53e440ab44b972411d218d43f3e" namespace=moby protocol=ttrpc version=3 May 16 16:05:18.799920 systemd[1]: Started docker-39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334.scope - libcontainer container 39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334. May 16 16:05:18.812432 systemd-resolved[1298]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 16 16:05:18.831466 kernel: docker0: port 1(vethb6e2af2) entered blocking state May 16 16:05:18.831553 kernel: docker0: port 1(vethb6e2af2) entered disabled state May 16 16:05:18.831570 kernel: vethb6e2af2: entered allmulticast mode May 16 16:05:18.832267 kernel: vethb6e2af2: entered promiscuous mode May 16 16:05:18.832648 systemd-networkd[1386]: vethb6e2af2: Link UP May 16 16:05:18.844758 kernel: eth0: renamed from veth8380258 May 16 16:05:18.847478 kernel: docker0: port 1(vethb6e2af2) entered blocking state May 16 16:05:18.848043 kernel: docker0: port 1(vethb6e2af2) entered forwarding state May 16 16:05:18.847582 systemd-networkd[1386]: vethb6e2af2: Gained carrier May 16 16:05:18.847863 systemd-networkd[1386]: docker0: Gained carrier May 16 16:05:18.875189 sshd[1859]: Connection closed by 10.0.0.1 port 50072 May 16 16:05:18.875891 sshd-session[1857]: pam_unix(sshd:session): session closed for user core May 16 16:05:18.885794 systemd[1]: sshd@7-10.0.0.36:22-10.0.0.1:50072.service: Deactivated successfully. May 16 16:05:18.887207 systemd[1]: session-8.scope: Deactivated successfully. May 16 16:05:18.888056 systemd-logind[1432]: Session 8 logged out. Waiting for processes to exit. May 16 16:05:18.890484 systemd[1]: Started sshd@8-10.0.0.36:22-10.0.0.1:50086.service - OpenSSH per-connection server daemon (10.0.0.1:50086). May 16 16:05:18.891164 systemd-logind[1432]: Removed session 8. May 16 16:05:18.944715 sshd[1932]: Accepted publickey for core from 10.0.0.1 port 50086 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:18.945955 sshd-session[1932]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:18.950350 systemd-logind[1432]: New session 9 of user core. May 16 16:05:18.962900 systemd[1]: Started session-9.scope - Session 9 of User core. May 16 16:05:19.016718 sshd[1934]: Connection closed by 10.0.0.1 port 50086 May 16 16:05:19.016900 sshd-session[1932]: pam_unix(sshd:session): session closed for user core May 16 16:05:19.027653 systemd[1]: sshd@8-10.0.0.36:22-10.0.0.1:50086.service: Deactivated successfully. May 16 16:05:19.029394 systemd[1]: session-9.scope: Deactivated successfully. May 16 16:05:19.031347 systemd-logind[1432]: Session 9 logged out. Waiting for processes to exit. May 16 16:05:19.033644 systemd[1]: Started sshd@9-10.0.0.36:22-10.0.0.1:50100.service - OpenSSH per-connection server daemon (10.0.0.1:50100). May 16 16:05:19.034281 systemd-logind[1432]: Removed session 9. May 16 16:05:19.090514 sshd[1940]: Accepted publickey for core from 10.0.0.1 port 50100 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:19.091667 sshd-session[1940]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:19.096126 systemd-logind[1432]: New session 10 of user core. May 16 16:05:19.101875 systemd[1]: Started session-10.scope - Session 10 of User core. May 16 16:05:19.151595 sudo[1943]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1472 May 16 16:05:19.151871 sudo[1943]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 16:05:19.154863 sudo[1943]: pam_unix(sudo:session): session closed for user root May 16 16:05:19.155062 containerd[1472]: time="2025-05-16T16:05:19.155006958Z" level=info msg="Stop CRI service" May 16 16:05:19.155616 dockerd[1651]: time="2025-05-16T16:05:19.155265779Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 16 16:05:19.155616 dockerd[1651]: time="2025-05-16T16:05:19.155307608Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 16 16:05:19.155616 dockerd[1651]: time="2025-05-16T16:05:19.155421875Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 16 16:05:19.155616 dockerd[1651]: time="2025-05-16T16:05:19.155447938Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 16 16:05:19.156099 containerd[1472]: time="2025-05-16T16:05:19.155879024Z" level=info msg="Stop CRI service" May 16 16:05:19.156099 containerd[1472]: time="2025-05-16T16:05:19.155939918Z" level=info msg="Event monitor stopped" May 16 16:05:19.156099 containerd[1472]: time="2025-05-16T16:05:19.155947279Z" level=info msg="Stream server stopped" May 16 16:05:19.156462 sshd[1942]: Connection closed by 10.0.0.1 port 50100 May 16 16:05:19.157615 systemd[1]: containerd.service: Deactivated successfully. May 16 16:05:19.157712 systemd[1]: containerd.service: Unit process 1882 (containerd-shim) remains running after unit stopped. May 16 16:05:19.157629 sshd-session[1940]: pam_unix(sshd:session): session closed for user core May 16 16:05:19.157942 systemd[1]: containerd.service: Consumed 355ms CPU time, 136.5M memory peak. May 16 16:05:19.168584 systemd[1]: sshd@9-10.0.0.36:22-10.0.0.1:50100.service: Deactivated successfully. May 16 16:05:19.170091 systemd[1]: session-10.scope: Deactivated successfully. May 16 16:05:19.170788 systemd-logind[1432]: Session 10 logged out. Waiting for processes to exit. May 16 16:05:19.173057 systemd[1]: Started sshd@10-10.0.0.36:22-10.0.0.1:50116.service - OpenSSH per-connection server daemon (10.0.0.1:50116). May 16 16:05:19.174027 systemd-logind[1432]: Removed session 10. May 16 16:05:19.227466 sshd[1950]: Accepted publickey for core from 10.0.0.1 port 50116 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:19.228956 sshd-session[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:19.233573 systemd-logind[1432]: New session 11 of user core. May 16 16:05:19.246896 systemd[1]: Started session-11.scope - Session 11 of User core. May 16 16:05:19.300976 sshd[1952]: Connection closed by 10.0.0.1 port 50116 May 16 16:05:19.301228 sshd-session[1950]: pam_unix(sshd:session): session closed for user core May 16 16:05:19.304953 systemd[1]: sshd@10-10.0.0.36:22-10.0.0.1:50116.service: Deactivated successfully. May 16 16:05:19.308204 systemd[1]: session-11.scope: Deactivated successfully. May 16 16:05:19.310339 systemd-logind[1432]: Session 11 logged out. Waiting for processes to exit. May 16 16:05:19.311226 systemd-logind[1432]: Removed session 11. May 16 16:05:20.586244 systemd-networkd[1386]: vethb6e2af2: Gained IPv6LL May 16 16:05:20.586534 systemd-networkd[1386]: docker0: Gained IPv6LL May 16 16:05:24.408231 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. May 16 16:05:24.408664 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 16 16:05:24.408814 dockerd[1651]: time="2025-05-16T16:05:24.408645007Z" level=info msg="Processing signal 'terminated'" May 16 16:05:25.335793 systemd[1]: Started sshd@11-10.0.0.36:22-10.0.0.1:56096.service - OpenSSH per-connection server daemon (10.0.0.1:56096). May 16 16:05:25.382145 sshd[1958]: Accepted publickey for core from 10.0.0.1 port 56096 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:25.383242 sshd-session[1958]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:25.386843 systemd-logind[1432]: New session 12 of user core. May 16 16:05:25.395890 systemd[1]: Started session-12.scope - Session 12 of User core. May 16 16:05:25.448776 sshd[1960]: Connection closed by 10.0.0.1 port 56096 May 16 16:05:25.449951 sshd-session[1958]: pam_unix(sshd:session): session closed for user core May 16 16:05:25.452276 systemd[1]: sshd@11-10.0.0.36:22-10.0.0.1:56096.service: Deactivated successfully. May 16 16:05:25.453859 systemd[1]: session-12.scope: Deactivated successfully. May 16 16:05:25.458354 systemd-logind[1432]: Session 12 logged out. Waiting for processes to exit. May 16 16:05:25.459485 systemd-logind[1432]: Removed session 12. May 16 16:05:26.410037 dockerd[1651]: time="2025-05-16T16:05:26.409955466Z" level=error msg="Error sending stop (signal 15) to container" container=39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334 error="Cannot kill container 39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" May 16 16:05:26.410037 dockerd[1651]: time="2025-05-16T16:05:26.410007699Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334 May 16 16:05:31.477156 systemd[1]: Started sshd@12-10.0.0.36:22-10.0.0.1:56110.service - OpenSSH per-connection server daemon (10.0.0.1:56110). May 16 16:05:31.519161 sshd[1966]: Accepted publickey for core from 10.0.0.1 port 56110 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:31.520269 sshd-session[1966]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:31.523993 systemd-logind[1432]: New session 13 of user core. May 16 16:05:31.530904 systemd[1]: Started session-13.scope - Session 13 of User core. May 16 16:05:31.587367 sshd[1968]: Connection closed by 10.0.0.1 port 56110 May 16 16:05:31.587748 sshd-session[1966]: pam_unix(sshd:session): session closed for user core May 16 16:05:31.590583 systemd[1]: sshd@12-10.0.0.36:22-10.0.0.1:56110.service: Deactivated successfully. May 16 16:05:31.594062 systemd[1]: session-13.scope: Deactivated successfully. May 16 16:05:31.594702 systemd-logind[1432]: Session 13 logged out. Waiting for processes to exit. May 16 16:05:31.595663 systemd-logind[1432]: Removed session 13. May 16 16:05:36.410941 dockerd[1651]: time="2025-05-16T16:05:36.410718389Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334 error="context deadline exceeded" May 16 16:05:36.411621 systemd[1]: docker-39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334.scope: Deactivated successfully. May 16 16:05:37.606749 systemd[1]: Started sshd@13-10.0.0.36:22-10.0.0.1:55304.service - OpenSSH per-connection server daemon (10.0.0.1:55304). May 16 16:05:37.654704 sshd[1974]: Accepted publickey for core from 10.0.0.1 port 55304 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:37.656063 sshd-session[1974]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:37.659923 systemd-logind[1432]: New session 14 of user core. May 16 16:05:37.667912 systemd[1]: Started session-14.scope - Session 14 of User core. May 16 16:05:37.721871 sshd[1976]: Connection closed by 10.0.0.1 port 55304 May 16 16:05:37.721038 sshd-session[1974]: pam_unix(sshd:session): session closed for user core May 16 16:05:37.725624 systemd[1]: sshd@13-10.0.0.36:22-10.0.0.1:55304.service: Deactivated successfully. May 16 16:05:37.726970 systemd[1]: session-14.scope: Deactivated successfully. May 16 16:05:37.728574 systemd-logind[1432]: Session 14 logged out. Waiting for processes to exit. May 16 16:05:37.729864 systemd-logind[1432]: Removed session 14. May 16 16:05:39.410030 dockerd[1651]: time="2025-05-16T16:05:39.409944688Z" level=error msg="Force shutdown daemon" May 16 16:05:39.410334 dockerd[1651]: time="2025-05-16T16:05:39.410103112Z" level=info msg="Daemon shutdown complete" May 16 16:05:39.412831 systemd[1]: docker.service: Deactivated successfully. May 16 16:05:39.413127 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 16 16:05:39.413186 systemd[1]: docker.service: Consumed 791ms CPU time, 130.6M memory peak. May 16 16:05:39.414122 systemd[1]: docker.socket: Deactivated successfully. May 16 16:05:39.414428 systemd[1]: Closed docker.socket - Docker Socket for the API. May 16 16:05:39.414468 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 16 16:05:39.415943 systemd[1]: Starting docker.socket - Docker Socket for the API... May 16 16:05:39.416109 systemd[1]: containerd.service: Found left-over process 1882 (containerd-shim) in control group while starting unit. Ignoring. May 16 16:05:39.416117 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 16 16:05:39.422213 systemd[1]: Starting containerd.service - containerd container runtime... May 16 16:05:39.422598 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 16 16:05:39.432244 systemd[1]: containerd.service: Found left-over process 1882 (containerd-shim) in control group while starting unit. Ignoring. May 16 16:05:39.432257 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 16 16:05:39.436367 (ntainerd)[1987]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 16 16:05:39.448333 containerd[1987]: time="2025-05-16T16:05:39Z" 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 16 16:05:39.448827 containerd[1987]: time="2025-05-16T16:05:39.448800816Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 16 16:05:39.458718 containerd[1987]: time="2025-05-16T16:05:39.458437436Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.964µs" May 16 16:05:39.458718 containerd[1987]: time="2025-05-16T16:05:39.458474772Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 16 16:05:39.458718 containerd[1987]: time="2025-05-16T16:05:39.458498742Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 16 16:05:39.458718 containerd[1987]: time="2025-05-16T16:05:39.458542680Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 16 16:05:39.458718 containerd[1987]: time="2025-05-16T16:05:39.458556765Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 16 16:05:39.458904 containerd[1987]: time="2025-05-16T16:05:39.458774374Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 16 16:05:39.458904 containerd[1987]: time="2025-05-16T16:05:39.458806908Z" 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 16 16:05:39.458904 containerd[1987]: time="2025-05-16T16:05:39.458820633Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 16 16:05:39.459063 containerd[1987]: time="2025-05-16T16:05:39.459032160Z" 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 16 16:05:39.459063 containerd[1987]: time="2025-05-16T16:05:39.459059411Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 16 16:05:39.459104 containerd[1987]: time="2025-05-16T16:05:39.459076538Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 16 16:05:39.459104 containerd[1987]: time="2025-05-16T16:05:39.459086142Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 16 16:05:39.459141 containerd[1987]: time="2025-05-16T16:05:39.459110712Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 16 16:05:39.459220 containerd[1987]: time="2025-05-16T16:05:39.459200148Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 16 16:05:39.459243 containerd[1987]: time="2025-05-16T16:05:39.459230481Z" 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 16 16:05:39.459261 containerd[1987]: time="2025-05-16T16:05:39.459244607Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 16 16:05:39.459293 containerd[1987]: time="2025-05-16T16:05:39.459278660Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459530924Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459559095Z" level=info msg="metadata content store policy set" policy=shared May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459682786Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459715719Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459749573Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459767060Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459782627Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459795832Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459810678Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459825644Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459839690Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459851455Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459864100Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 16 16:05:39.459935 containerd[1987]: time="2025-05-16T16:05:39.459879026Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 16 16:05:39.460215 containerd[1987]: time="2025-05-16T16:05:39.460112121Z" level=info msg="connecting to shim 39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334" address="unix:///run/containerd/s/b70a63d120f70ed7dbfca4623d123f99c587b53e440ab44b972411d218d43f3e" namespace=moby protocol=ttrpc version=3 May 16 16:05:39.466332 containerd[1987]: time="2025-05-16T16:05:39.466307495Z" level=info msg="cleaning leaked shim process" id=39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334 namespace=moby May 16 16:05:39.475817 containerd[1987]: time="2025-05-16T16:05:39.475764241Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 16 16:05:39.476148 containerd[1987]: time="2025-05-16T16:05:39.476111463Z" level=info msg="shim disconnected" id=39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334 namespace=moby May 16 16:05:39.476201 containerd[1987]: time="2025-05-16T16:05:39.476140915Z" level=warning msg="cleaning up after shim disconnected" id=39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334 namespace=moby May 16 16:05:39.476201 containerd[1987]: time="2025-05-16T16:05:39.476172328Z" level=info msg="cleaning up dead shim" namespace=moby May 16 16:05:39.488167 containerd[1987]: time="2025-05-16T16:05:39.488105688Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 16 16:05:39.488242 containerd[1987]: time="2025-05-16T16:05:39.488221735Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 16 16:05:39.488262 containerd[1987]: time="2025-05-16T16:05:39.488245025Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 16 16:05:39.488281 containerd[1987]: time="2025-05-16T16:05:39.488262432Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 16 16:05:39.488281 containerd[1987]: time="2025-05-16T16:05:39.488275637Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 16 16:05:39.488323 containerd[1987]: time="2025-05-16T16:05:39.488286362Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 16 16:05:39.488323 containerd[1987]: time="2025-05-16T16:05:39.488297246Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 16 16:05:39.488323 containerd[1987]: time="2025-05-16T16:05:39.488308291Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 16 16:05:39.488323 containerd[1987]: time="2025-05-16T16:05:39.488320216Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 16 16:05:39.488388 containerd[1987]: time="2025-05-16T16:05:39.488332020Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 16 16:05:39.488388 containerd[1987]: time="2025-05-16T16:05:39.488342665Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 16 16:05:39.488388 containerd[1987]: time="2025-05-16T16:05:39.488353749Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 16 16:05:39.488439 containerd[1987]: time="2025-05-16T16:05:39.488422497Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 16 16:05:39.488439 containerd[1987]: time="2025-05-16T16:05:39.488437264Z" level=info msg="Start snapshots syncer" May 16 16:05:39.488472 containerd[1987]: time="2025-05-16T16:05:39.488458472Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 16 16:05:39.488717 containerd[1987]: time="2025-05-16T16:05:39.488676481Z" 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 16 16:05:39.488823 containerd[1987]: time="2025-05-16T16:05:39.488762637Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 16 16:05:39.488850 containerd[1987]: time="2025-05-16T16:05:39.488838668Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 16 16:05:39.488910 containerd[1987]: time="2025-05-16T16:05:39.488886727Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 16 16:05:39.488938 containerd[1987]: time="2025-05-16T16:05:39.488922982Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 16 16:05:39.488957 containerd[1987]: time="2025-05-16T16:05:39.488936348Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 16 16:05:39.488957 containerd[1987]: time="2025-05-16T16:05:39.488947152Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 16 16:05:39.488995 containerd[1987]: time="2025-05-16T16:05:39.488959117Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 16 16:05:39.488995 containerd[1987]: time="2025-05-16T16:05:39.488976524Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 16 16:05:39.488995 containerd[1987]: time="2025-05-16T16:05:39.488987448Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 16 16:05:39.489045 containerd[1987]: time="2025-05-16T16:05:39.489020142Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 16 16:05:39.489045 containerd[1987]: time="2025-05-16T16:05:39.489031587Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 16 16:05:39.489045 containerd[1987]: time="2025-05-16T16:05:39.489041751Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 16 16:05:39.489092 containerd[1987]: time="2025-05-16T16:05:39.489079166Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 16 16:05:39.489113 containerd[1987]: time="2025-05-16T16:05:39.489094092Z" 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 16 16:05:39.489113 containerd[1987]: time="2025-05-16T16:05:39.489102856Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 16 16:05:39.489146 containerd[1987]: time="2025-05-16T16:05:39.489111899Z" 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 16 16:05:39.489146 containerd[1987]: time="2025-05-16T16:05:39.489120863Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 16 16:05:39.489146 containerd[1987]: time="2025-05-16T16:05:39.489130227Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 16 16:05:39.489146 containerd[1987]: time="2025-05-16T16:05:39.489142512Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 16 16:05:39.489212 containerd[1987]: time="2025-05-16T16:05:39.489159239Z" level=info msg="runtime interface created" May 16 16:05:39.489212 containerd[1987]: time="2025-05-16T16:05:39.489164841Z" level=info msg="created NRI interface" May 16 16:05:39.489212 containerd[1987]: time="2025-05-16T16:05:39.489172684Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 16 16:05:39.489212 containerd[1987]: time="2025-05-16T16:05:39.489183169Z" level=info msg="Connect containerd service" May 16 16:05:39.489212 containerd[1987]: time="2025-05-16T16:05:39.489210220Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 16 16:05:39.489724 containerd[1987]: time="2025-05-16T16:05:39.489695058Z" 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 16 16:05:39.498138 containerd[1987]: time="2025-05-16T16:05:39.498080247Z" level=info msg="Start subscribing containerd event" May 16 16:05:39.498252 containerd[1987]: time="2025-05-16T16:05:39.498149315Z" level=info msg="Start recovering state" May 16 16:05:39.498252 containerd[1987]: time="2025-05-16T16:05:39.498193973Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 16 16:05:39.498252 containerd[1987]: time="2025-05-16T16:05:39.498232949Z" level=info msg=serving... address=/run/containerd/containerd.sock May 16 16:05:39.498252 containerd[1987]: time="2025-05-16T16:05:39.498241713Z" level=info msg="Start event monitor" May 16 16:05:39.498455 containerd[1987]: time="2025-05-16T16:05:39.498255598Z" level=info msg="Start cni network conf syncer for default" May 16 16:05:39.498455 containerd[1987]: time="2025-05-16T16:05:39.498275847Z" level=info msg="Start streaming server" May 16 16:05:39.498455 containerd[1987]: time="2025-05-16T16:05:39.498295214Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 16 16:05:39.498455 containerd[1987]: time="2025-05-16T16:05:39.498302778Z" level=info msg="runtime interface starting up..." May 16 16:05:39.498455 containerd[1987]: time="2025-05-16T16:05:39.498309140Z" level=info msg="starting plugins..." May 16 16:05:39.498455 containerd[1987]: time="2025-05-16T16:05:39.498317744Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 16 16:05:39.498560 containerd[1987]: time="2025-05-16T16:05:39.498457001Z" level=info msg="containerd successfully booted in 0.050272s" May 16 16:05:39.498555 systemd[1]: Started containerd.service - containerd container runtime. May 16 16:05:39.504067 systemd[1]: Starting docker.service - Docker Application Container Engine... May 16 16:05:39.513066 (dockerd)[2035]: 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 16 16:05:39.536489 dockerd[2035]: time="2025-05-16T16:05:39.536440012Z" level=info msg="Starting up" May 16 16:05:39.537135 dockerd[2035]: time="2025-05-16T16:05:39.537115648Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 16 16:05:39.575875 dockerd[2035]: time="2025-05-16T16:05:39.575825917Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 16 16:05:39.584333 dockerd[2035]: time="2025-05-16T16:05:39.584263767Z" level=info msg="Loading containers: start." May 16 16:05:39.598230 systemd[1]: var-lib-docker-overlay2-3a6660cc5af6f968ac28fc9408ff0d015949cc827a6b7f0bfcbfcf5cb05d774a-merged.mount: Deactivated successfully. May 16 16:05:39.945580 systemd-networkd[1386]: vethb6e2af2: Link DOWN May 16 16:05:39.945587 systemd-networkd[1386]: vethb6e2af2: Lost carrier May 16 16:05:39.947246 kernel: docker0: port 1(vethb6e2af2) entered disabled state May 16 16:05:39.947292 kernel: vethb6e2af2 (unregistering): left allmulticast mode May 16 16:05:39.947308 kernel: vethb6e2af2 (unregistering): left promiscuous mode May 16 16:05:39.948870 kernel: docker0: port 1(vethb6e2af2) entered disabled state May 16 16:05:39.949750 systemd-networkd[1386]: docker0: Lost carrier May 16 16:05:39.950764 dockerd[2035]: time="2025-05-16T16:05:39.950071787Z" level=info msg="Removing stale sandbox 4c8f5b6b925d3a9b8e7796f21b2f61590b9aa62976a0268754dd46951afafb26 (39fdd8d3f55f23514c13d6966ce36234dc2c7116c775370465d3dd51120b2334)" May 16 16:05:39.955414 dockerd[2035]: time="2025-05-16T16:05:39.955372115Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 16 16:05:39.955475 dockerd[2035]: time="2025-05-16T16:05:39.955422895Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint a76822ae41d2703e3ffb22e081c4ae7bff3537fcba7758627b241edba454f1d2 18fa08d9a96771c620f805892e29236b200ee39d74132905897b48b6b9236a6f], retrying...." May 16 16:05:40.133281 dockerd[2035]: time="2025-05-16T16:05:40.133228735Z" level=warning msg="error locating sandbox id 4c8f5b6b925d3a9b8e7796f21b2f61590b9aa62976a0268754dd46951afafb26: sandbox 4c8f5b6b925d3a9b8e7796f21b2f61590b9aa62976a0268754dd46951afafb26 not found" May 16 16:05:40.133432 dockerd[2035]: time="2025-05-16T16:05:40.133308606Z" level=info msg="Loading containers: done." May 16 16:05:40.143397 dockerd[2035]: time="2025-05-16T16:05:40.143350684Z" 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 16 16:05:40.143531 dockerd[2035]: time="2025-05-16T16:05:40.143426233Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 16 16:05:40.143531 dockerd[2035]: time="2025-05-16T16:05:40.143464608Z" level=info msg="Initializing buildkit" May 16 16:05:40.156522 dockerd[2035]: time="2025-05-16T16:05:40.156485436Z" level=info msg="Completed buildkit initialization" May 16 16:05:40.162497 dockerd[2035]: time="2025-05-16T16:05:40.162467827Z" level=info msg="Daemon has completed initialization" May 16 16:05:40.162579 dockerd[2035]: time="2025-05-16T16:05:40.162525569Z" level=info msg="API listen on /run/docker.sock" May 16 16:05:40.162714 systemd[1]: Started docker.service - Docker Application Container Engine. May 16 16:05:40.556641 systemd[1]: run-docker-netns-4c8f5b6b925d.mount: Deactivated successfully. May 16 16:05:43.736543 systemd[1]: Started sshd@14-10.0.0.36:22-10.0.0.1:35684.service - OpenSSH per-connection server daemon (10.0.0.1:35684). May 16 16:05:43.793392 sshd[2257]: Accepted publickey for core from 10.0.0.1 port 35684 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:43.794496 sshd-session[2257]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:43.798702 systemd-logind[1432]: New session 15 of user core. May 16 16:05:43.808920 systemd[1]: Started session-15.scope - Session 15 of User core. May 16 16:05:43.862447 sshd[2259]: Connection closed by 10.0.0.1 port 35684 May 16 16:05:43.862931 sshd-session[2257]: pam_unix(sshd:session): session closed for user core May 16 16:05:43.876527 systemd[1]: sshd@14-10.0.0.36:22-10.0.0.1:35684.service: Deactivated successfully. May 16 16:05:43.878017 systemd[1]: session-15.scope: Deactivated successfully. May 16 16:05:43.880431 systemd-logind[1432]: Session 15 logged out. Waiting for processes to exit. May 16 16:05:43.881340 systemd[1]: Started sshd@15-10.0.0.36:22-10.0.0.1:35688.service - OpenSSH per-connection server daemon (10.0.0.1:35688). May 16 16:05:43.882490 systemd-logind[1432]: Removed session 15. May 16 16:05:43.935081 sshd[2265]: Accepted publickey for core from 10.0.0.1 port 35688 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:43.936258 sshd-session[2265]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:43.941089 systemd-logind[1432]: New session 16 of user core. May 16 16:05:43.946927 systemd[1]: Started session-16.scope - Session 16 of User core. May 16 16:05:44.000712 sshd[2267]: Connection closed by 10.0.0.1 port 35688 May 16 16:05:44.000587 sshd-session[2265]: pam_unix(sshd:session): session closed for user core May 16 16:05:44.015533 systemd[1]: sshd@15-10.0.0.36:22-10.0.0.1:35688.service: Deactivated successfully. May 16 16:05:44.017884 systemd[1]: session-16.scope: Deactivated successfully. May 16 16:05:44.018468 systemd-logind[1432]: Session 16 logged out. Waiting for processes to exit. May 16 16:05:44.021959 systemd[1]: Started sshd@16-10.0.0.36:22-10.0.0.1:35694.service - OpenSSH per-connection server daemon (10.0.0.1:35694). May 16 16:05:44.022619 systemd-logind[1432]: Removed session 16. May 16 16:05:44.076826 sshd[2273]: Accepted publickey for core from 10.0.0.1 port 35694 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:44.077884 sshd-session[2273]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:44.082079 systemd-logind[1432]: New session 17 of user core. May 16 16:05:44.100876 systemd[1]: Started session-17.scope - Session 17 of User core. May 16 16:05:44.156123 sshd[2275]: Connection closed by 10.0.0.1 port 35694 May 16 16:05:44.156391 sshd-session[2273]: pam_unix(sshd:session): session closed for user core May 16 16:05:44.165539 systemd[1]: sshd@16-10.0.0.36:22-10.0.0.1:35694.service: Deactivated successfully. May 16 16:05:44.168101 systemd[1]: session-17.scope: Deactivated successfully. May 16 16:05:44.168793 systemd-logind[1432]: Session 17 logged out. Waiting for processes to exit. May 16 16:05:44.170923 systemd[1]: Started sshd@17-10.0.0.36:22-10.0.0.1:35702.service - OpenSSH per-connection server daemon (10.0.0.1:35702). May 16 16:05:44.172233 systemd-logind[1432]: Removed session 17. May 16 16:05:44.223303 sshd[2288]: Accepted publickey for core from 10.0.0.1 port 35702 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:44.224308 sshd-session[2288]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:44.228463 systemd-logind[1432]: New session 18 of user core. May 16 16:05:44.236849 systemd[1]: Started session-18.scope - Session 18 of User core. May 16 16:05:44.301553 systemd[1]: var-lib-docker-overlay2-da42663623d3e5dad07952d8a70cf8e20efcf97468adb45bbeead334342de21b\x2dinit-merged.mount: Deactivated successfully. May 16 16:05:44.335254 containerd[1987]: time="2025-05-16T16:05:44.335211764Z" level=info msg="connecting to shim 75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba" address="unix:///run/containerd/s/55e074959dc4bb0c655fb43721cd1cbf5cad9e3ed25edeacd9ba760c173a0b1d" namespace=moby protocol=ttrpc version=3 May 16 16:05:44.357912 systemd[1]: Started docker-75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba.scope - libcontainer container 75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba. May 16 16:05:44.367565 systemd-resolved[1298]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 16 16:05:44.381241 kernel: docker0: port 1(vethc142b81) entered blocking state May 16 16:05:44.381301 kernel: docker0: port 1(vethc142b81) entered disabled state May 16 16:05:44.381909 kernel: vethc142b81: entered allmulticast mode May 16 16:05:44.382749 kernel: vethc142b81: entered promiscuous mode May 16 16:05:44.382878 systemd-networkd[1386]: vethc142b81: Link UP May 16 16:05:44.389759 kernel: eth0: renamed from veth4fc2920 May 16 16:05:44.391683 systemd-networkd[1386]: vethc142b81: Gained carrier May 16 16:05:44.391804 kernel: docker0: port 1(vethc142b81) entered blocking state May 16 16:05:44.391826 kernel: docker0: port 1(vethc142b81) entered forwarding state May 16 16:05:44.392620 systemd-networkd[1386]: docker0: Gained carrier May 16 16:05:44.409108 sshd[2290]: Connection closed by 10.0.0.1 port 35702 May 16 16:05:44.409595 sshd-session[2288]: pam_unix(sshd:session): session closed for user core May 16 16:05:44.422747 systemd[1]: sshd@17-10.0.0.36:22-10.0.0.1:35702.service: Deactivated successfully. May 16 16:05:44.425038 systemd[1]: session-18.scope: Deactivated successfully. May 16 16:05:44.425774 systemd-logind[1432]: Session 18 logged out. Waiting for processes to exit. May 16 16:05:44.428028 systemd[1]: Started sshd@18-10.0.0.36:22-10.0.0.1:35704.service - OpenSSH per-connection server daemon (10.0.0.1:35704). May 16 16:05:44.429067 systemd-logind[1432]: Removed session 18. May 16 16:05:44.478291 sshd[2357]: Accepted publickey for core from 10.0.0.1 port 35704 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:44.479335 sshd-session[2357]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:44.483597 systemd-logind[1432]: New session 19 of user core. May 16 16:05:44.503862 systemd[1]: Started session-19.scope - Session 19 of User core. May 16 16:05:44.557067 sshd[2359]: Connection closed by 10.0.0.1 port 35704 May 16 16:05:44.557254 sshd-session[2357]: pam_unix(sshd:session): session closed for user core May 16 16:05:44.569462 systemd[1]: sshd@18-10.0.0.36:22-10.0.0.1:35704.service: Deactivated successfully. May 16 16:05:44.570835 systemd[1]: session-19.scope: Deactivated successfully. May 16 16:05:44.572298 systemd-logind[1432]: Session 19 logged out. Waiting for processes to exit. May 16 16:05:44.573600 systemd[1]: Started sshd@19-10.0.0.36:22-10.0.0.1:35720.service - OpenSSH per-connection server daemon (10.0.0.1:35720). May 16 16:05:44.574598 systemd-logind[1432]: Removed session 19. May 16 16:05:44.626057 sshd[2365]: Accepted publickey for core from 10.0.0.1 port 35720 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:44.627045 sshd-session[2365]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:44.630468 systemd-logind[1432]: New session 20 of user core. May 16 16:05:44.641887 systemd[1]: Started session-20.scope - Session 20 of User core. May 16 16:05:44.691039 sudo[2368]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1987 May 16 16:05:44.691309 sudo[2368]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 16:05:44.694218 sudo[2368]: pam_unix(sudo:session): session closed for user root May 16 16:05:44.695214 sshd[2367]: Connection closed by 10.0.0.1 port 35720 May 16 16:05:44.695501 sshd-session[2365]: pam_unix(sshd:session): session closed for user core May 16 16:05:44.696863 dockerd[2035]: time="2025-05-16T16:05:44.696810985Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 16 16:05:44.696863 dockerd[2035]: time="2025-05-16T16:05:44.696846036Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 16 16:05:44.701107 dockerd[2035]: time="2025-05-16T16:05:44.701066939Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 16 16:05:44.701107 dockerd[2035]: time="2025-05-16T16:05:44.701093227Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 16 16:05:44.705476 systemd[1]: containerd.service: Deactivated successfully. May 16 16:05:44.705568 systemd[1]: containerd.service: Unit process 2308 (containerd-shim) remains running after unit stopped. May 16 16:05:44.705804 systemd[1]: containerd.service: Consumed 143ms CPU time, 136.6M memory peak. May 16 16:05:44.706142 systemd[1]: sshd@19-10.0.0.36:22-10.0.0.1:35720.service: Deactivated successfully. May 16 16:05:44.707367 systemd[1]: session-20.scope: Deactivated successfully. May 16 16:05:44.708003 systemd-logind[1432]: Session 20 logged out. Waiting for processes to exit. May 16 16:05:44.710629 systemd[1]: Started sshd@20-10.0.0.36:22-10.0.0.1:35730.service - OpenSSH per-connection server daemon (10.0.0.1:35730). May 16 16:05:44.711065 systemd-logind[1432]: Removed session 20. May 16 16:05:44.765394 sshd[2375]: Accepted publickey for core from 10.0.0.1 port 35730 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:44.766505 sshd-session[2375]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:44.770788 systemd-logind[1432]: New session 21 of user core. May 16 16:05:44.781871 systemd[1]: Started session-21.scope - Session 21 of User core. May 16 16:05:44.833961 sshd[2377]: Connection closed by 10.0.0.1 port 35730 May 16 16:05:44.834162 sshd-session[2375]: pam_unix(sshd:session): session closed for user core May 16 16:05:44.837536 systemd[1]: sshd@20-10.0.0.36:22-10.0.0.1:35730.service: Deactivated successfully. May 16 16:05:44.840053 systemd[1]: session-21.scope: Deactivated successfully. May 16 16:05:44.840793 systemd-logind[1432]: Session 21 logged out. Waiting for processes to exit. May 16 16:05:44.842943 systemd-logind[1432]: Removed session 21. May 16 16:05:46.122010 systemd-networkd[1386]: vethc142b81: Gained IPv6LL May 16 16:05:49.912185 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. May 16 16:05:49.912523 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 16 16:05:49.913379 dockerd[2035]: time="2025-05-16T16:05:49.912679500Z" level=info msg="Processing signal 'terminated'" May 16 16:05:50.846722 systemd[1]: Started sshd@21-10.0.0.36:22-10.0.0.1:35738.service - OpenSSH per-connection server daemon (10.0.0.1:35738). May 16 16:05:50.903687 sshd[2383]: Accepted publickey for core from 10.0.0.1 port 35738 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:50.904929 sshd-session[2383]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:50.908782 systemd-logind[1432]: New session 22 of user core. May 16 16:05:50.916879 systemd[1]: Started session-22.scope - Session 22 of User core. May 16 16:05:50.969156 sshd[2385]: Connection closed by 10.0.0.1 port 35738 May 16 16:05:50.969454 sshd-session[2383]: pam_unix(sshd:session): session closed for user core May 16 16:05:50.973050 systemd[1]: sshd@21-10.0.0.36:22-10.0.0.1:35738.service: Deactivated successfully. May 16 16:05:50.974555 systemd[1]: session-22.scope: Deactivated successfully. May 16 16:05:50.975984 systemd-logind[1432]: Session 22 logged out. Waiting for processes to exit. May 16 16:05:50.977045 systemd-logind[1432]: Removed session 22. May 16 16:05:51.913317 dockerd[2035]: time="2025-05-16T16:05:51.913209147Z" level=error msg="Error sending stop (signal 15) to container" container=75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba error="Cannot kill container 75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" May 16 16:05:51.913317 dockerd[2035]: time="2025-05-16T16:05:51.913289644Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba May 16 16:05:52.436474 update_engine[1433]: I20250516 16:05:52.436379 1433 update_attempter.cc:509] Updating boot flags... May 16 16:05:56.992748 systemd[1]: Started sshd@22-10.0.0.36:22-10.0.0.1:38738.service - OpenSSH per-connection server daemon (10.0.0.1:38738). May 16 16:05:57.057802 sshd[2409]: Accepted publickey for core from 10.0.0.1 port 38738 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:05:57.058955 sshd-session[2409]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:05:57.062760 systemd-logind[1432]: New session 23 of user core. May 16 16:05:57.072871 systemd[1]: Started session-23.scope - Session 23 of User core. May 16 16:05:57.124766 sshd[2411]: Connection closed by 10.0.0.1 port 38738 May 16 16:05:57.125120 sshd-session[2409]: pam_unix(sshd:session): session closed for user core May 16 16:05:57.128123 systemd[1]: sshd@22-10.0.0.36:22-10.0.0.1:38738.service: Deactivated successfully. May 16 16:05:57.129563 systemd[1]: session-23.scope: Deactivated successfully. May 16 16:05:57.131359 systemd-logind[1432]: Session 23 logged out. Waiting for processes to exit. May 16 16:05:57.132421 systemd-logind[1432]: Removed session 23. May 16 16:06:01.914029 dockerd[2035]: time="2025-05-16T16:06:01.913948787Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba error="context deadline exceeded" May 16 16:06:01.914602 systemd[1]: docker-75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba.scope: Deactivated successfully. May 16 16:06:03.148648 systemd[1]: Started sshd@23-10.0.0.36:22-10.0.0.1:49756.service - OpenSSH per-connection server daemon (10.0.0.1:49756). May 16 16:06:03.190930 sshd[2418]: Accepted publickey for core from 10.0.0.1 port 49756 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:06:03.191989 sshd-session[2418]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:06:03.196354 systemd-logind[1432]: New session 24 of user core. May 16 16:06:03.205856 systemd[1]: Started session-24.scope - Session 24 of User core. May 16 16:06:03.258486 sshd[2420]: Connection closed by 10.0.0.1 port 49756 May 16 16:06:03.258885 sshd-session[2418]: pam_unix(sshd:session): session closed for user core May 16 16:06:03.261776 systemd[1]: sshd@23-10.0.0.36:22-10.0.0.1:49756.service: Deactivated successfully. May 16 16:06:03.265061 systemd[1]: session-24.scope: Deactivated successfully. May 16 16:06:03.265773 systemd-logind[1432]: Session 24 logged out. Waiting for processes to exit. May 16 16:06:03.266957 systemd-logind[1432]: Removed session 24. May 16 16:06:04.913149 dockerd[2035]: time="2025-05-16T16:06:04.913077037Z" level=error msg="Force shutdown daemon" May 16 16:06:04.913580 dockerd[2035]: time="2025-05-16T16:06:04.913272020Z" level=info msg="Daemon shutdown complete" May 16 16:06:04.917701 systemd[1]: docker.service: Deactivated successfully. May 16 16:06:04.918031 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 16 16:06:04.918464 systemd[1]: docker.socket: Deactivated successfully. May 16 16:06:04.918765 systemd[1]: Closed docker.socket - Docker Socket for the API. May 16 16:06:04.918817 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 16 16:06:04.922149 systemd[1]: Starting docker.socket - Docker Socket for the API... May 16 16:06:04.922320 systemd[1]: containerd.service: Found left-over process 2308 (containerd-shim) in control group while starting unit. Ignoring. May 16 16:06:04.922328 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 16 16:06:04.930154 systemd[1]: Starting containerd.service - containerd container runtime... May 16 16:06:04.930606 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 16 16:06:04.941149 systemd[1]: containerd.service: Found left-over process 2308 (containerd-shim) in control group while starting unit. Ignoring. May 16 16:06:04.941158 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 16 16:06:04.945123 (ntainerd)[2431]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 16 16:06:04.957369 containerd[2431]: time="2025-05-16T16:06:04Z" 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 16 16:06:04.957741 containerd[2431]: time="2025-05-16T16:06:04.957706498Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 16 16:06:04.965071 containerd[2431]: time="2025-05-16T16:06:04.965027641Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.481µs" May 16 16:06:04.965071 containerd[2431]: time="2025-05-16T16:06:04.965062765Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 16 16:06:04.965166 containerd[2431]: time="2025-05-16T16:06:04.965081207Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 16 16:06:04.965166 containerd[2431]: time="2025-05-16T16:06:04.965118651Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 16 16:06:04.965166 containerd[2431]: time="2025-05-16T16:06:04.965130293Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 16 16:06:04.965363 containerd[2431]: time="2025-05-16T16:06:04.965333237Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 16 16:06:04.965392 containerd[2431]: time="2025-05-16T16:06:04.965373721Z" 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 16 16:06:04.965392 containerd[2431]: time="2025-05-16T16:06:04.965387043Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 16 16:06:04.965595 containerd[2431]: time="2025-05-16T16:06:04.965567744Z" 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 16 16:06:04.965595 containerd[2431]: time="2025-05-16T16:06:04.965587067Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 16 16:06:04.965640 containerd[2431]: time="2025-05-16T16:06:04.965597908Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 16 16:06:04.965640 containerd[2431]: time="2025-05-16T16:06:04.965605589Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 16 16:06:04.965640 containerd[2431]: time="2025-05-16T16:06:04.965628992Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 16 16:06:04.965714 containerd[2431]: time="2025-05-16T16:06:04.965700640Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 16 16:06:04.965758 containerd[2431]: time="2025-05-16T16:06:04.965724003Z" 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 16 16:06:04.965789 containerd[2431]: time="2025-05-16T16:06:04.965756407Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 16 16:06:04.965807 containerd[2431]: time="2025-05-16T16:06:04.965786770Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 16 16:06:04.966308 containerd[2431]: time="2025-05-16T16:06:04.966272907Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 16 16:06:04.966378 containerd[2431]: time="2025-05-16T16:06:04.966344476Z" level=info msg="metadata content store policy set" policy=shared May 16 16:06:04.966610 containerd[2431]: time="2025-05-16T16:06:04.966574223Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966771166Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966793929Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966808411Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966820012Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966830613Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966840934Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966852296Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966866857Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966876779Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966886380Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.966898541Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 16 16:06:04.967185 containerd[2431]: time="2025-05-16T16:06:04.967094564Z" level=info msg="connecting to shim 75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba" address="unix:///run/containerd/s/55e074959dc4bb0c655fb43721cd1cbf5cad9e3ed25edeacd9ba760c173a0b1d" namespace=moby protocol=ttrpc version=3 May 16 16:06:04.973322 containerd[2431]: time="2025-05-16T16:06:04.973297695Z" level=info msg="cleaning leaked shim process" id=75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba namespace=moby May 16 16:06:04.981519 containerd[2431]: time="2025-05-16T16:06:04.981485661Z" level=info msg="shim disconnected" id=75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba namespace=moby May 16 16:06:04.981599 containerd[2431]: time="2025-05-16T16:06:04.981517824Z" level=warning msg="cleaning up after shim disconnected" id=75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba namespace=moby May 16 16:06:04.981599 containerd[2431]: time="2025-05-16T16:06:04.981548228Z" level=info msg="cleaning up dead shim" namespace=moby May 16 16:06:04.990812 containerd[2431]: time="2025-05-16T16:06:04.990748592Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/3: file already closed" namespace=moby May 16 16:06:04.990878 containerd[2431]: time="2025-05-16T16:06:04.990858445Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 16 16:06:04.990913 containerd[2431]: time="2025-05-16T16:06:04.990892009Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 16 16:06:04.990913 containerd[2431]: time="2025-05-16T16:06:04.990908211Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 16 16:06:04.990961 containerd[2431]: time="2025-05-16T16:06:04.990922813Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 16 16:06:04.990961 containerd[2431]: time="2025-05-16T16:06:04.990933854Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 16 16:06:04.990961 containerd[2431]: time="2025-05-16T16:06:04.990943975Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 16 16:06:04.990961 containerd[2431]: time="2025-05-16T16:06:04.990956457Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 16 16:06:04.991034 containerd[2431]: time="2025-05-16T16:06:04.990967898Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 16 16:06:04.991034 containerd[2431]: time="2025-05-16T16:06:04.990980140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 16 16:06:04.991034 containerd[2431]: time="2025-05-16T16:06:04.990992101Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 16 16:06:04.991034 containerd[2431]: time="2025-05-16T16:06:04.991002502Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 16 16:06:04.991106 containerd[2431]: time="2025-05-16T16:06:04.991064110Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 16 16:06:04.991106 containerd[2431]: time="2025-05-16T16:06:04.991080271Z" level=info msg="Start snapshots syncer" May 16 16:06:04.991144 containerd[2431]: time="2025-05-16T16:06:04.991114155Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 16 16:06:04.991364 containerd[2431]: time="2025-05-16T16:06:04.991317819Z" 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 16 16:06:04.991448 containerd[2431]: time="2025-05-16T16:06:04.991366985Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 16 16:06:04.991448 containerd[2431]: time="2025-05-16T16:06:04.991438314Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 16 16:06:04.991505 containerd[2431]: time="2025-05-16T16:06:04.991488680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 16 16:06:04.991534 containerd[2431]: time="2025-05-16T16:06:04.991525164Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 16 16:06:04.991561 containerd[2431]: time="2025-05-16T16:06:04.991537285Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 16 16:06:04.991561 containerd[2431]: time="2025-05-16T16:06:04.991547407Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 16 16:06:04.991561 containerd[2431]: time="2025-05-16T16:06:04.991559608Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 16 16:06:04.991615 containerd[2431]: time="2025-05-16T16:06:04.991570489Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 16 16:06:04.991615 containerd[2431]: time="2025-05-16T16:06:04.991581691Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 16 16:06:04.991615 containerd[2431]: time="2025-05-16T16:06:04.991606934Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 16 16:06:04.991673 containerd[2431]: time="2025-05-16T16:06:04.991617935Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 16 16:06:04.991673 containerd[2431]: time="2025-05-16T16:06:04.991628976Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 16 16:06:04.991673 containerd[2431]: time="2025-05-16T16:06:04.991663860Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 16 16:06:04.991742 containerd[2431]: time="2025-05-16T16:06:04.991677822Z" 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 16 16:06:04.991742 containerd[2431]: time="2025-05-16T16:06:04.991687343Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 16 16:06:04.991742 containerd[2431]: time="2025-05-16T16:06:04.991696344Z" 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 16 16:06:04.991742 containerd[2431]: time="2025-05-16T16:06:04.991703985Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 16 16:06:04.991742 containerd[2431]: time="2025-05-16T16:06:04.991717827Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 16 16:06:04.991845 containerd[2431]: time="2025-05-16T16:06:04.991750270Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 16 16:06:04.991845 containerd[2431]: time="2025-05-16T16:06:04.991768673Z" level=info msg="runtime interface created" May 16 16:06:04.991845 containerd[2431]: time="2025-05-16T16:06:04.991774073Z" level=info msg="created NRI interface" May 16 16:06:04.991845 containerd[2431]: time="2025-05-16T16:06:04.991781914Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 16 16:06:04.991845 containerd[2431]: time="2025-05-16T16:06:04.991792555Z" level=info msg="Connect containerd service" May 16 16:06:04.991845 containerd[2431]: time="2025-05-16T16:06:04.991821159Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 16 16:06:04.992277 containerd[2431]: time="2025-05-16T16:06:04.992239408Z" 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 16 16:06:05.000293 containerd[2431]: time="2025-05-16T16:06:05.000236551Z" level=info msg="Start subscribing containerd event" May 16 16:06:05.000373 containerd[2431]: time="2025-05-16T16:06:05.000299998Z" level=info msg="Start recovering state" May 16 16:06:05.000373 containerd[2431]: time="2025-05-16T16:06:05.000356885Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 16 16:06:05.000430 containerd[2431]: time="2025-05-16T16:06:05.000367646Z" level=info msg="Start event monitor" May 16 16:06:05.000457 containerd[2431]: time="2025-05-16T16:06:05.000433654Z" level=info msg="Start cni network conf syncer for default" May 16 16:06:05.000457 containerd[2431]: time="2025-05-16T16:06:05.000443015Z" level=info msg="Start streaming server" May 16 16:06:05.000457 containerd[2431]: time="2025-05-16T16:06:05.000452016Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 16 16:06:05.000523 containerd[2431]: time="2025-05-16T16:06:05.000458577Z" level=info msg="runtime interface starting up..." May 16 16:06:05.000523 containerd[2431]: time="2025-05-16T16:06:05.000464258Z" level=info msg="starting plugins..." May 16 16:06:05.000523 containerd[2431]: time="2025-05-16T16:06:05.000478059Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 16 16:06:05.000523 containerd[2431]: time="2025-05-16T16:06:05.000404130Z" level=info msg=serving... address=/run/containerd/containerd.sock May 16 16:06:05.000636 containerd[2431]: time="2025-05-16T16:06:05.000612475Z" level=info msg="containerd successfully booted in 0.043386s" May 16 16:06:05.000765 systemd[1]: Started containerd.service - containerd container runtime. May 16 16:06:05.003398 systemd[1]: Starting docker.service - Docker Application Container Engine... May 16 16:06:05.021036 (dockerd)[2479]: 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 16 16:06:05.044688 dockerd[2479]: time="2025-05-16T16:06:05.044638546Z" level=info msg="Starting up" May 16 16:06:05.045164 dockerd[2479]: time="2025-05-16T16:06:05.045145603Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 16 16:06:05.070957 dockerd[2479]: time="2025-05-16T16:06:05.070909403Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 16 16:06:05.078462 dockerd[2479]: time="2025-05-16T16:06:05.078421535Z" level=info msg="Loading containers: start." May 16 16:06:05.094907 systemd[1]: var-lib-docker-overlay2-da42663623d3e5dad07952d8a70cf8e20efcf97468adb45bbeead334342de21b-merged.mount: Deactivated successfully. May 16 16:06:05.429204 systemd-networkd[1386]: vethc142b81: Link DOWN May 16 16:06:05.429211 systemd-networkd[1386]: vethc142b81: Lost carrier May 16 16:06:05.431096 kernel: docker0: port 1(vethc142b81) entered disabled state May 16 16:06:05.431149 kernel: vethc142b81 (unregistering): left allmulticast mode May 16 16:06:05.431165 kernel: vethc142b81 (unregistering): left promiscuous mode May 16 16:06:05.431798 kernel: docker0: port 1(vethc142b81) entered disabled state May 16 16:06:05.433230 systemd-networkd[1386]: docker0: Lost carrier May 16 16:06:05.433987 dockerd[2479]: time="2025-05-16T16:06:05.433956593Z" level=info msg="Removing stale sandbox d1dafb68955c916e9d064468f893d7fea8ea764d4ad1f1c1d4b80e99324496ae (75df4d94933ff26bcf37cfbbd182c0e719bdfd47cecc67ac4ebb1df61db4f7ba)" May 16 16:06:05.436627 dockerd[2479]: time="2025-05-16T16:06:05.436595132Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 16 16:06:05.436697 dockerd[2479]: time="2025-05-16T16:06:05.436638497Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 91853842ad3307e9a2135ba5e17b3c3c52c2a29936cd82fa60069a81d49460b2 931f4a4c4cb6f72cdcf8d90f2e80da84295c236b7b5573a5be4bf9e518c6b54e], retrying...." May 16 16:06:05.603278 dockerd[2479]: time="2025-05-16T16:06:05.603225938Z" level=warning msg="error locating sandbox id 4c8f5b6b925d3a9b8e7796f21b2f61590b9aa62976a0268754dd46951afafb26: sandbox 4c8f5b6b925d3a9b8e7796f21b2f61590b9aa62976a0268754dd46951afafb26 not found" May 16 16:06:05.603278 dockerd[2479]: time="2025-05-16T16:06:05.603270863Z" level=warning msg="error locating sandbox id d1dafb68955c916e9d064468f893d7fea8ea764d4ad1f1c1d4b80e99324496ae: sandbox d1dafb68955c916e9d064468f893d7fea8ea764d4ad1f1c1d4b80e99324496ae not found" May 16 16:06:05.603412 dockerd[2479]: time="2025-05-16T16:06:05.603325950Z" level=info msg="Loading containers: done." May 16 16:06:05.613296 dockerd[2479]: time="2025-05-16T16:06:05.613244794Z" 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 16 16:06:05.613419 dockerd[2479]: time="2025-05-16T16:06:05.613316362Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 16 16:06:05.613419 dockerd[2479]: time="2025-05-16T16:06:05.613356006Z" level=info msg="Initializing buildkit" May 16 16:06:05.624719 dockerd[2479]: time="2025-05-16T16:06:05.624684170Z" level=info msg="Completed buildkit initialization" May 16 16:06:05.631225 dockerd[2479]: time="2025-05-16T16:06:05.631195148Z" level=info msg="Daemon has completed initialization" May 16 16:06:05.631413 systemd[1]: Started docker.service - Docker Application Container Engine. May 16 16:06:05.631947 dockerd[2479]: time="2025-05-16T16:06:05.631439176Z" level=info msg="API listen on /run/docker.sock" May 16 16:06:06.062761 systemd[1]: run-docker-netns-d1dafb68955c.mount: Deactivated successfully. May 16 16:06:09.273046 systemd[1]: Started sshd@24-10.0.0.36:22-10.0.0.1:49772.service - OpenSSH per-connection server daemon (10.0.0.1:49772). May 16 16:06:09.334181 sshd[2700]: Accepted publickey for core from 10.0.0.1 port 49772 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:06:09.335341 sshd-session[2700]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:06:09.339620 systemd-logind[1432]: New session 25 of user core. May 16 16:06:09.348891 systemd[1]: Started session-25.scope - Session 25 of User core. May 16 16:06:09.402389 sshd[2702]: Connection closed by 10.0.0.1 port 49772 May 16 16:06:09.403140 sshd-session[2700]: pam_unix(sshd:session): session closed for user core May 16 16:06:09.419872 systemd[1]: sshd@24-10.0.0.36:22-10.0.0.1:49772.service: Deactivated successfully. May 16 16:06:09.422180 systemd[1]: session-25.scope: Deactivated successfully. May 16 16:06:09.422890 systemd-logind[1432]: Session 25 logged out. Waiting for processes to exit. May 16 16:06:09.425143 systemd[1]: Started sshd@25-10.0.0.36:22-10.0.0.1:49776.service - OpenSSH per-connection server daemon (10.0.0.1:49776). May 16 16:06:09.426020 systemd-logind[1432]: Removed session 25. May 16 16:06:09.483150 sshd[2708]: Accepted publickey for core from 10.0.0.1 port 49776 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:06:09.484448 sshd-session[2708]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:06:09.488911 systemd-logind[1432]: New session 26 of user core. May 16 16:06:09.505910 systemd[1]: Started session-26.scope - Session 26 of User core. May 16 16:06:09.559856 sshd[2710]: Connection closed by 10.0.0.1 port 49776 May 16 16:06:09.560273 sshd-session[2708]: pam_unix(sshd:session): session closed for user core May 16 16:06:09.569547 systemd[1]: sshd@25-10.0.0.36:22-10.0.0.1:49776.service: Deactivated successfully. May 16 16:06:09.572114 systemd[1]: session-26.scope: Deactivated successfully. May 16 16:06:09.572817 systemd-logind[1432]: Session 26 logged out. Waiting for processes to exit. May 16 16:06:09.574819 systemd[1]: Started sshd@26-10.0.0.36:22-10.0.0.1:49786.service - OpenSSH per-connection server daemon (10.0.0.1:49786). May 16 16:06:09.577143 systemd-logind[1432]: Removed session 26. May 16 16:06:09.625968 sshd[2716]: Accepted publickey for core from 10.0.0.1 port 49786 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:06:09.627046 sshd-session[2716]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:06:09.631431 systemd-logind[1432]: New session 27 of user core. May 16 16:06:09.638880 systemd[1]: Started session-27.scope - Session 27 of User core. May 16 16:06:09.694894 sshd[2718]: Connection closed by 10.0.0.1 port 49786 May 16 16:06:09.695350 sshd-session[2716]: pam_unix(sshd:session): session closed for user core May 16 16:06:09.711631 systemd[1]: sshd@26-10.0.0.36:22-10.0.0.1:49786.service: Deactivated successfully. May 16 16:06:09.712987 systemd[1]: session-27.scope: Deactivated successfully. May 16 16:06:09.713705 systemd-logind[1432]: Session 27 logged out. Waiting for processes to exit. May 16 16:06:09.715700 systemd[1]: Started sshd@27-10.0.0.36:22-10.0.0.1:49802.service - OpenSSH per-connection server daemon (10.0.0.1:49802). May 16 16:06:09.716452 systemd-logind[1432]: Removed session 27. May 16 16:06:09.768348 sshd[2731]: Accepted publickey for core from 10.0.0.1 port 49802 ssh2: RSA SHA256:bkgptDe9jseKO6+aQtJKCzW+g5Mhm35Zmmkqt5qGuGI May 16 16:06:09.769571 sshd-session[2731]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 16:06:09.773667 systemd-logind[1432]: New session 28 of user core. May 16 16:06:09.789907 systemd[1]: Started session-28.scope - Session 28 of User core. May 16 16:06:09.855562 systemd[1]: var-lib-docker-overlay2-1a2ab4617cfdeb46155f6e5f27502460651b1d283bbc17fcd4b971efc2a90303\x2dinit-merged.mount: Deactivated successfully. May 16 16:06:09.884675 containerd[2431]: time="2025-05-16T16:06:09.884614105Z" level=info msg="connecting to shim cff12e0592ee0403e3b6f5be68e0ef08fcb3e4d7eb6089b7b3958cff251c7a09" address="unix:///run/containerd/s/1aff14f860c372f2ffffc2b719e7712c7ef4a4bacf67e66e2e7cf9fc352554a1" namespace=moby protocol=ttrpc version=3 May 16 16:06:09.907894 systemd[1]: Started docker-cff12e0592ee0403e3b6f5be68e0ef08fcb3e4d7eb6089b7b3958cff251c7a09.scope - libcontainer container cff12e0592ee0403e3b6f5be68e0ef08fcb3e4d7eb6089b7b3958cff251c7a09. May 16 16:06:09.917570 systemd-resolved[1298]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 16 16:06:09.930955 kernel: docker0: port 1(veth593030e) entered blocking state May 16 16:06:09.931022 kernel: docker0: port 1(veth593030e) entered disabled state May 16 16:06:09.931042 kernel: veth593030e: entered allmulticast mode May 16 16:06:09.932125 kernel: veth593030e: entered promiscuous mode May 16 16:06:09.932302 systemd-networkd[1386]: veth593030e: Link UP May 16 16:06:09.942214 kernel: eth0: renamed from veth8993786 May 16 16:06:09.942272 kernel: docker0: port 1(veth593030e) entered blocking state May 16 16:06:09.942287 kernel: docker0: port 1(veth593030e) entered forwarding state May 16 16:06:09.942961 systemd-networkd[1386]: veth593030e: Gained carrier May 16 16:06:09.944765 systemd-networkd[1386]: docker0: Gained carrier May 16 16:06:09.962781 sshd[2733]: Connection closed by 10.0.0.1 port 49802 May 16 16:06:09.962865 sshd-session[2731]: pam_unix(sshd:session): session closed for user core May 16 16:06:09.966066 systemd-logind[1432]: Session 28 logged out. Waiting for processes to exit. May 16 16:06:09.966242 systemd[1]: sshd@27-10.0.0.36:22-10.0.0.1:49802.service: Deactivated successfully. May 16 16:06:09.967622 systemd[1]: session-28.scope: Deactivated successfully. May 16 16:06:09.970166 systemd-logind[1432]: Removed session 28. May 16 16:06:11.337869 systemd-networkd[1386]: veth593030e: Gained IPv6LL