Jul 10 23:56:39.828559 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 10 23:56:39.828582 kernel: Linux version 6.12.36-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Thu Jul 10 22:17:59 -00 2025 Jul 10 23:56:39.828592 kernel: KASLR enabled Jul 10 23:56:39.828597 kernel: efi: EFI v2.7 by EDK II Jul 10 23:56:39.828603 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Jul 10 23:56:39.828608 kernel: random: crng init done Jul 10 23:56:39.828615 kernel: secureboot: Secure boot disabled Jul 10 23:56:39.828621 kernel: ACPI: Early table checksum verification disabled Jul 10 23:56:39.828627 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Jul 10 23:56:39.828634 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 10 23:56:39.828640 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828646 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828651 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828657 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828665 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828672 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828678 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828685 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828691 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 23:56:39.828697 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 10 23:56:39.828703 kernel: ACPI: Use ACPI SPCR as default console: Yes Jul 10 23:56:39.828716 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 10 23:56:39.828722 kernel: NODE_DATA(0) allocated [mem 0xdc965dc0-0xdc96cfff] Jul 10 23:56:39.828728 kernel: Zone ranges: Jul 10 23:56:39.828735 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 10 23:56:39.828743 kernel: DMA32 empty Jul 10 23:56:39.828749 kernel: Normal empty Jul 10 23:56:39.828755 kernel: Device empty Jul 10 23:56:39.828761 kernel: Movable zone start for each node Jul 10 23:56:39.828767 kernel: Early memory node ranges Jul 10 23:56:39.828773 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Jul 10 23:56:39.828779 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Jul 10 23:56:39.828790 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Jul 10 23:56:39.828798 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Jul 10 23:56:39.828805 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Jul 10 23:56:39.828812 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Jul 10 23:56:39.828818 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Jul 10 23:56:39.828826 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Jul 10 23:56:39.828834 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Jul 10 23:56:39.828840 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jul 10 23:56:39.828851 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jul 10 23:56:39.828858 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jul 10 23:56:39.828864 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jul 10 23:56:39.828872 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 10 23:56:39.828879 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 10 23:56:39.828885 kernel: psci: probing for conduit method from ACPI. Jul 10 23:56:39.828892 kernel: psci: PSCIv1.1 detected in firmware. Jul 10 23:56:39.828898 kernel: psci: Using standard PSCI v0.2 function IDs Jul 10 23:56:39.828905 kernel: psci: Trusted OS migration not required Jul 10 23:56:39.828911 kernel: psci: SMC Calling Convention v1.1 Jul 10 23:56:39.828918 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 10 23:56:39.828924 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Jul 10 23:56:39.828931 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Jul 10 23:56:39.828939 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 10 23:56:39.828945 kernel: Detected PIPT I-cache on CPU0 Jul 10 23:56:39.828952 kernel: CPU features: detected: GIC system register CPU interface Jul 10 23:56:39.828958 kernel: CPU features: detected: Spectre-v4 Jul 10 23:56:39.828965 kernel: CPU features: detected: Spectre-BHB Jul 10 23:56:39.828971 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 10 23:56:39.828978 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 10 23:56:39.828984 kernel: CPU features: detected: ARM erratum 1418040 Jul 10 23:56:39.828991 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 10 23:56:39.828997 kernel: alternatives: applying boot alternatives Jul 10 23:56:39.829004 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=9ae0b1f40710648305be8f7e436b6937e65ac0b33eb84d1b5b7411684b4e7538 Jul 10 23:56:39.829012 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 10 23:56:39.829019 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 10 23:56:39.829026 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 10 23:56:39.829032 kernel: Fallback order for Node 0: 0 Jul 10 23:56:39.829038 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Jul 10 23:56:39.829045 kernel: Policy zone: DMA Jul 10 23:56:39.829061 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 10 23:56:39.829068 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Jul 10 23:56:39.829075 kernel: software IO TLB: area num 4. Jul 10 23:56:39.829081 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Jul 10 23:56:39.829088 kernel: software IO TLB: mapped [mem 0x00000000d8c00000-0x00000000d9000000] (4MB) Jul 10 23:56:39.829094 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 10 23:56:39.829103 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 10 23:56:39.829110 kernel: rcu: RCU event tracing is enabled. Jul 10 23:56:39.829117 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 10 23:56:39.829123 kernel: Trampoline variant of Tasks RCU enabled. Jul 10 23:56:39.829130 kernel: Tracing variant of Tasks RCU enabled. Jul 10 23:56:39.829136 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 10 23:56:39.829143 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 10 23:56:39.829149 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 23:56:39.829156 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 23:56:39.829163 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 10 23:56:39.829169 kernel: GICv3: 256 SPIs implemented Jul 10 23:56:39.829177 kernel: GICv3: 0 Extended SPIs implemented Jul 10 23:56:39.829183 kernel: Root IRQ handler: gic_handle_irq Jul 10 23:56:39.829190 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jul 10 23:56:39.829196 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Jul 10 23:56:39.829203 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 10 23:56:39.829209 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 10 23:56:39.829216 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Jul 10 23:56:39.829223 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Jul 10 23:56:39.829229 kernel: GICv3: using LPI property table @0x0000000040130000 Jul 10 23:56:39.829236 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Jul 10 23:56:39.829242 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 10 23:56:39.829249 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 23:56:39.829257 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 10 23:56:39.829264 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 10 23:56:39.829271 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 10 23:56:39.829277 kernel: arm-pv: using stolen time PV Jul 10 23:56:39.829284 kernel: Console: colour dummy device 80x25 Jul 10 23:56:39.829291 kernel: ACPI: Core revision 20240827 Jul 10 23:56:39.829298 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 10 23:56:39.829305 kernel: pid_max: default: 32768 minimum: 301 Jul 10 23:56:39.829311 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 10 23:56:39.829319 kernel: landlock: Up and running. Jul 10 23:56:39.829326 kernel: SELinux: Initializing. Jul 10 23:56:39.829332 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 10 23:56:39.829339 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 10 23:56:39.829346 kernel: rcu: Hierarchical SRCU implementation. Jul 10 23:56:39.829353 kernel: rcu: Max phase no-delay instances is 400. Jul 10 23:56:39.829360 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 10 23:56:39.829367 kernel: Remapping and enabling EFI services. Jul 10 23:56:39.829373 kernel: smp: Bringing up secondary CPUs ... Jul 10 23:56:39.829381 kernel: Detected PIPT I-cache on CPU1 Jul 10 23:56:39.829393 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 10 23:56:39.829400 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Jul 10 23:56:39.829408 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 23:56:39.829416 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 10 23:56:39.829423 kernel: Detected PIPT I-cache on CPU2 Jul 10 23:56:39.829430 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 10 23:56:39.829438 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Jul 10 23:56:39.829446 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 23:56:39.829453 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 10 23:56:39.829460 kernel: Detected PIPT I-cache on CPU3 Jul 10 23:56:39.829468 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 10 23:56:39.829475 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Jul 10 23:56:39.829482 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 23:56:39.829488 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 10 23:56:39.829495 kernel: smp: Brought up 1 node, 4 CPUs Jul 10 23:56:39.829502 kernel: SMP: Total of 4 processors activated. Jul 10 23:56:39.829509 kernel: CPU: All CPU(s) started at EL1 Jul 10 23:56:39.829517 kernel: CPU features: detected: 32-bit EL0 Support Jul 10 23:56:39.829524 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 10 23:56:39.829531 kernel: CPU features: detected: Common not Private translations Jul 10 23:56:39.829538 kernel: CPU features: detected: CRC32 instructions Jul 10 23:56:39.829545 kernel: CPU features: detected: Enhanced Virtualization Traps Jul 10 23:56:39.829552 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 10 23:56:39.829560 kernel: CPU features: detected: LSE atomic instructions Jul 10 23:56:39.829566 kernel: CPU features: detected: Privileged Access Never Jul 10 23:56:39.829574 kernel: CPU features: detected: RAS Extension Support Jul 10 23:56:39.829582 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 10 23:56:39.829589 kernel: alternatives: applying system-wide alternatives Jul 10 23:56:39.829596 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Jul 10 23:56:39.829604 kernel: Memory: 2440420K/2572288K available (11136K kernel code, 2428K rwdata, 9032K rodata, 39488K init, 1035K bss, 125920K reserved, 0K cma-reserved) Jul 10 23:56:39.829611 kernel: devtmpfs: initialized Jul 10 23:56:39.829618 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 10 23:56:39.829625 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 10 23:56:39.829632 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jul 10 23:56:39.829639 kernel: 0 pages in range for non-PLT usage Jul 10 23:56:39.829647 kernel: 508448 pages in range for PLT usage Jul 10 23:56:39.829654 kernel: pinctrl core: initialized pinctrl subsystem Jul 10 23:56:39.829661 kernel: SMBIOS 3.0.0 present. Jul 10 23:56:39.829668 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jul 10 23:56:39.829675 kernel: DMI: Memory slots populated: 1/1 Jul 10 23:56:39.829682 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 10 23:56:39.829689 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 10 23:56:39.829697 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 10 23:56:39.829704 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 10 23:56:39.829718 kernel: audit: initializing netlink subsys (disabled) Jul 10 23:56:39.829725 kernel: audit: type=2000 audit(0.025:1): state=initialized audit_enabled=0 res=1 Jul 10 23:56:39.829732 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 10 23:56:39.829739 kernel: cpuidle: using governor menu Jul 10 23:56:39.829746 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 10 23:56:39.829754 kernel: ASID allocator initialised with 32768 entries Jul 10 23:56:39.829762 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 10 23:56:39.829771 kernel: Serial: AMBA PL011 UART driver Jul 10 23:56:39.829779 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 10 23:56:39.829788 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 10 23:56:39.829795 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 10 23:56:39.829802 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 10 23:56:39.829809 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 10 23:56:39.829816 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 10 23:56:39.829823 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 10 23:56:39.829830 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 10 23:56:39.829837 kernel: ACPI: Added _OSI(Module Device) Jul 10 23:56:39.829844 kernel: ACPI: Added _OSI(Processor Device) Jul 10 23:56:39.829852 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 10 23:56:39.829860 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 10 23:56:39.829867 kernel: ACPI: Interpreter enabled Jul 10 23:56:39.829874 kernel: ACPI: Using GIC for interrupt routing Jul 10 23:56:39.829881 kernel: ACPI: MCFG table detected, 1 entries Jul 10 23:56:39.829888 kernel: ACPI: CPU0 has been hot-added Jul 10 23:56:39.829895 kernel: ACPI: CPU1 has been hot-added Jul 10 23:56:39.829902 kernel: ACPI: CPU2 has been hot-added Jul 10 23:56:39.829908 kernel: ACPI: CPU3 has been hot-added Jul 10 23:56:39.829916 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 10 23:56:39.829925 kernel: printk: legacy console [ttyAMA0] enabled Jul 10 23:56:39.829932 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 10 23:56:39.830088 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 10 23:56:39.830159 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 10 23:56:39.830218 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 10 23:56:39.830276 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 10 23:56:39.830333 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 10 23:56:39.830345 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 10 23:56:39.830352 kernel: PCI host bridge to bus 0000:00 Jul 10 23:56:39.830417 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 10 23:56:39.830474 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 10 23:56:39.830528 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 10 23:56:39.830581 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 10 23:56:39.830660 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Jul 10 23:56:39.830740 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jul 10 23:56:39.830804 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Jul 10 23:56:39.830864 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Jul 10 23:56:39.830924 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Jul 10 23:56:39.830984 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Jul 10 23:56:39.831044 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Jul 10 23:56:39.831189 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Jul 10 23:56:39.831247 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 10 23:56:39.831298 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 10 23:56:39.831349 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 10 23:56:39.831358 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 10 23:56:39.831365 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 10 23:56:39.831372 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 10 23:56:39.831379 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 10 23:56:39.831388 kernel: iommu: Default domain type: Translated Jul 10 23:56:39.831395 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 10 23:56:39.831402 kernel: efivars: Registered efivars operations Jul 10 23:56:39.831409 kernel: vgaarb: loaded Jul 10 23:56:39.831416 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 10 23:56:39.831422 kernel: VFS: Disk quotas dquot_6.6.0 Jul 10 23:56:39.831430 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 10 23:56:39.831437 kernel: pnp: PnP ACPI init Jul 10 23:56:39.831503 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 10 23:56:39.831514 kernel: pnp: PnP ACPI: found 1 devices Jul 10 23:56:39.831522 kernel: NET: Registered PF_INET protocol family Jul 10 23:56:39.831529 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 10 23:56:39.831536 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 10 23:56:39.831543 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 10 23:56:39.831550 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 10 23:56:39.831557 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 10 23:56:39.831564 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 10 23:56:39.831572 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 10 23:56:39.831579 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 10 23:56:39.831586 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 10 23:56:39.831593 kernel: PCI: CLS 0 bytes, default 64 Jul 10 23:56:39.831600 kernel: kvm [1]: HYP mode not available Jul 10 23:56:39.831606 kernel: Initialise system trusted keyrings Jul 10 23:56:39.831613 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 10 23:56:39.831620 kernel: Key type asymmetric registered Jul 10 23:56:39.831627 kernel: Asymmetric key parser 'x509' registered Jul 10 23:56:39.831635 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jul 10 23:56:39.831643 kernel: io scheduler mq-deadline registered Jul 10 23:56:39.831650 kernel: io scheduler kyber registered Jul 10 23:56:39.831656 kernel: io scheduler bfq registered Jul 10 23:56:39.831663 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 10 23:56:39.831670 kernel: ACPI: button: Power Button [PWRB] Jul 10 23:56:39.831685 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 10 23:56:39.831755 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 10 23:56:39.831765 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 10 23:56:39.831774 kernel: thunder_xcv, ver 1.0 Jul 10 23:56:39.831781 kernel: thunder_bgx, ver 1.0 Jul 10 23:56:39.831788 kernel: nicpf, ver 1.0 Jul 10 23:56:39.831795 kernel: nicvf, ver 1.0 Jul 10 23:56:39.831862 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 10 23:56:39.831916 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-10T23:56:39 UTC (1752191799) Jul 10 23:56:39.831925 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 10 23:56:39.831933 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Jul 10 23:56:39.831941 kernel: watchdog: NMI not fully supported Jul 10 23:56:39.831948 kernel: watchdog: Hard watchdog permanently disabled Jul 10 23:56:39.831955 kernel: NET: Registered PF_INET6 protocol family Jul 10 23:56:39.831962 kernel: Segment Routing with IPv6 Jul 10 23:56:39.831969 kernel: In-situ OAM (IOAM) with IPv6 Jul 10 23:56:39.831976 kernel: NET: Registered PF_PACKET protocol family Jul 10 23:56:39.831982 kernel: Key type dns_resolver registered Jul 10 23:56:39.831989 kernel: registered taskstats version 1 Jul 10 23:56:39.831996 kernel: Loading compiled-in X.509 certificates Jul 10 23:56:39.832003 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.36-flatcar: 0718d62a7a0702c0da490764fdc6ec06d7382bc1' Jul 10 23:56:39.832012 kernel: Demotion targets for Node 0: null Jul 10 23:56:39.832018 kernel: Key type .fscrypt registered Jul 10 23:56:39.832025 kernel: Key type fscrypt-provisioning registered Jul 10 23:56:39.832032 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 10 23:56:39.832039 kernel: ima: Allocated hash algorithm: sha1 Jul 10 23:56:39.832046 kernel: ima: No architecture policies found Jul 10 23:56:39.832074 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 10 23:56:39.832082 kernel: clk: Disabling unused clocks Jul 10 23:56:39.832091 kernel: PM: genpd: Disabling unused power domains Jul 10 23:56:39.832098 kernel: Warning: unable to open an initial console. Jul 10 23:56:39.832105 kernel: Freeing unused kernel memory: 39488K Jul 10 23:56:39.832112 kernel: Run /init as init process Jul 10 23:56:39.832118 kernel: with arguments: Jul 10 23:56:39.832125 kernel: /init Jul 10 23:56:39.832132 kernel: with environment: Jul 10 23:56:39.832138 kernel: HOME=/ Jul 10 23:56:39.832145 kernel: TERM=linux Jul 10 23:56:39.832152 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 10 23:56:39.832161 systemd[1]: Successfully made /usr/ read-only. Jul 10 23:56:39.832171 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) Jul 10 23:56:39.832179 systemd[1]: Detected virtualization kvm. Jul 10 23:56:39.832186 systemd[1]: Detected architecture arm64. Jul 10 23:56:39.832193 systemd[1]: Running in initrd. Jul 10 23:56:39.832200 systemd[1]: No hostname configured, using default hostname. Jul 10 23:56:39.832209 systemd[1]: Hostname set to . Jul 10 23:56:39.832217 systemd[1]: Initializing machine ID from VM UUID. Jul 10 23:56:39.832224 systemd[1]: Queued start job for default target initrd.target. Jul 10 23:56:39.832231 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 23:56:39.832239 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 23:56:39.832246 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 10 23:56:39.832254 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 10 23:56:39.832262 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 10 23:56:39.832271 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 10 23:56:39.832280 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 10 23:56:39.832287 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 10 23:56:39.832295 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 23:56:39.832302 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 10 23:56:39.832310 systemd[1]: Reached target paths.target - Path Units. Jul 10 23:56:39.832323 systemd[1]: Reached target slices.target - Slice Units. Jul 10 23:56:39.832331 systemd[1]: Reached target swap.target - Swaps. Jul 10 23:56:39.832339 systemd[1]: Reached target timers.target - Timer Units. Jul 10 23:56:39.832347 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 10 23:56:39.832354 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 10 23:56:39.832362 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 10 23:56:39.832369 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 10 23:56:39.832377 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 10 23:56:39.832384 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 10 23:56:39.832392 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 23:56:39.832400 systemd[1]: Reached target sockets.target - Socket Units. Jul 10 23:56:39.832408 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 10 23:56:39.832415 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 10 23:56:39.832423 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 10 23:56:39.832430 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). Jul 10 23:56:39.832438 systemd[1]: Starting systemd-fsck-usr.service... Jul 10 23:56:39.832445 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 10 23:56:39.832453 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 10 23:56:39.832460 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 23:56:39.832469 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 10 23:56:39.832478 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 23:56:39.832485 systemd[1]: Finished systemd-fsck-usr.service. Jul 10 23:56:39.832493 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 10 23:56:39.832523 systemd-journald[244]: Collecting audit messages is disabled. Jul 10 23:56:39.832543 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 23:56:39.832552 systemd-journald[244]: Journal started Jul 10 23:56:39.832572 systemd-journald[244]: Runtime Journal (/run/log/journal/7ee09036f2a94a32aab25e585c7c1b35) is 6M, max 48.5M, 42.4M free. Jul 10 23:56:39.823014 systemd-modules-load[245]: Inserted module 'overlay' Jul 10 23:56:39.835435 systemd[1]: Started systemd-journald.service - Journal Service. Jul 10 23:56:39.837387 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 23:56:39.841146 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 10 23:56:39.842557 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 10 23:56:39.849069 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 10 23:56:39.850776 systemd-modules-load[245]: Inserted module 'br_netfilter' Jul 10 23:56:39.851492 kernel: Bridge firewalling registered Jul 10 23:56:39.857730 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 10 23:56:39.859154 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 10 23:56:39.862223 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 10 23:56:39.867785 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 23:56:39.869249 systemd-tmpfiles[268]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 10 23:56:39.872077 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 23:56:39.873398 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 10 23:56:39.876981 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 10 23:56:39.879877 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 23:56:39.881747 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 10 23:56:39.903786 dracut-cmdline[289]: 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=9ae0b1f40710648305be8f7e436b6937e65ac0b33eb84d1b5b7411684b4e7538 Jul 10 23:56:39.919396 systemd-resolved[286]: Positive Trust Anchors: Jul 10 23:56:39.919415 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 10 23:56:39.919447 systemd-resolved[286]: 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 Jul 10 23:56:39.925964 systemd-resolved[286]: Defaulting to hostname 'linux'. Jul 10 23:56:39.927156 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 10 23:56:39.928033 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 10 23:56:39.988131 kernel: SCSI subsystem initialized Jul 10 23:56:39.995073 kernel: Loading iSCSI transport class v2.0-870. Jul 10 23:56:40.002076 kernel: iscsi: registered transport (tcp) Jul 10 23:56:40.015256 kernel: iscsi: registered transport (qla4xxx) Jul 10 23:56:40.015311 kernel: QLogic iSCSI HBA Driver Jul 10 23:56:40.036071 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 10 23:56:40.057091 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 23:56:40.059234 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 10 23:56:40.108029 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 10 23:56:40.110433 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 10 23:56:40.186078 kernel: raid6: neonx8 gen() 15761 MB/s Jul 10 23:56:40.203072 kernel: raid6: neonx4 gen() 15829 MB/s Jul 10 23:56:40.220067 kernel: raid6: neonx2 gen() 13278 MB/s Jul 10 23:56:40.237068 kernel: raid6: neonx1 gen() 10422 MB/s Jul 10 23:56:40.254067 kernel: raid6: int64x8 gen() 6892 MB/s Jul 10 23:56:40.271068 kernel: raid6: int64x4 gen() 7352 MB/s Jul 10 23:56:40.288069 kernel: raid6: int64x2 gen() 6102 MB/s Jul 10 23:56:40.305070 kernel: raid6: int64x1 gen() 5050 MB/s Jul 10 23:56:40.305084 kernel: raid6: using algorithm neonx4 gen() 15829 MB/s Jul 10 23:56:40.322073 kernel: raid6: .... xor() 12370 MB/s, rmw enabled Jul 10 23:56:40.322095 kernel: raid6: using neon recovery algorithm Jul 10 23:56:40.327073 kernel: xor: measuring software checksum speed Jul 10 23:56:40.327093 kernel: 8regs : 21528 MB/sec Jul 10 23:56:40.328464 kernel: 32regs : 19501 MB/sec Jul 10 23:56:40.328478 kernel: arm64_neon : 28099 MB/sec Jul 10 23:56:40.328487 kernel: xor: using function: arm64_neon (28099 MB/sec) Jul 10 23:56:40.384084 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 10 23:56:40.390765 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 10 23:56:40.393002 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 23:56:40.420311 systemd-udevd[498]: Using default interface naming scheme 'v255'. Jul 10 23:56:40.424316 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 23:56:40.426515 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 10 23:56:40.455391 dracut-pre-trigger[506]: rd.md=0: removing MD RAID activation Jul 10 23:56:40.477533 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 10 23:56:40.479754 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 10 23:56:40.530586 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 23:56:40.533384 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 10 23:56:40.583361 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jul 10 23:56:40.589791 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 10 23:56:40.590216 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 23:56:40.590336 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 23:56:40.597289 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 23:56:40.599121 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 23:56:40.602433 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 23:56:40.629546 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 10 23:56:40.630563 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 23:56:40.640128 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 10 23:56:40.647792 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 10 23:56:40.653794 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 10 23:56:40.654714 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 10 23:56:40.662599 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 10 23:56:40.663557 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 10 23:56:40.664988 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 23:56:40.666575 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 10 23:56:40.668765 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 10 23:56:40.670337 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 10 23:56:40.689082 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 23:56:40.692160 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 10 23:56:41.755097 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 23:56:41.755293 disk-uuid[595]: The operation has completed successfully. Jul 10 23:56:41.775394 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 10 23:56:41.775492 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 10 23:56:41.805590 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 10 23:56:41.826929 sh[612]: Success Jul 10 23:56:41.838108 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 10 23:56:41.838142 kernel: device-mapper: uevent: version 1.0.3 Jul 10 23:56:41.841096 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 10 23:56:41.847088 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Jul 10 23:56:41.874861 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 10 23:56:41.877289 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 10 23:56:41.894438 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 10 23:56:41.899823 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 10 23:56:41.899864 kernel: BTRFS: device fsid 1d7bf05b-5ff9-431d-b4bb-8cc553220034 devid 1 transid 39 /dev/mapper/usr (253:0) scanned by mount (624) Jul 10 23:56:41.900078 kernel: BTRFS info (device dm-0): first mount of filesystem 1d7bf05b-5ff9-431d-b4bb-8cc553220034 Jul 10 23:56:41.901488 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 10 23:56:41.901514 kernel: BTRFS info (device dm-0): using free-space-tree Jul 10 23:56:41.905140 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 10 23:56:41.906130 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 10 23:56:41.907180 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 10 23:56:41.907920 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 10 23:56:41.910641 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 10 23:56:41.940836 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (655) Jul 10 23:56:41.940894 kernel: BTRFS info (device vda6): first mount of filesystem b11340e8-a7f1-4911-a987-813f898c22db Jul 10 23:56:41.940905 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 10 23:56:41.942096 kernel: BTRFS info (device vda6): using free-space-tree Jul 10 23:56:41.948077 kernel: BTRFS info (device vda6): last unmount of filesystem b11340e8-a7f1-4911-a987-813f898c22db Jul 10 23:56:41.948180 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 10 23:56:41.949864 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 10 23:56:42.011831 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 10 23:56:42.014387 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 10 23:56:42.060195 systemd-networkd[796]: lo: Link UP Jul 10 23:56:42.060207 systemd-networkd[796]: lo: Gained carrier Jul 10 23:56:42.060950 systemd-networkd[796]: Enumeration completed Jul 10 23:56:42.061354 systemd-networkd[796]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 23:56:42.061357 systemd-networkd[796]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 10 23:56:42.061934 systemd-networkd[796]: eth0: Link UP Jul 10 23:56:42.061937 systemd-networkd[796]: eth0: Gained carrier Jul 10 23:56:42.061945 systemd-networkd[796]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 23:56:42.062197 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 10 23:56:42.063311 systemd[1]: Reached target network.target - Network. Jul 10 23:56:42.090107 systemd-networkd[796]: eth0: DHCPv4 address 10.0.0.110/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 10 23:56:42.094334 ignition[703]: Ignition 2.21.0 Jul 10 23:56:42.094349 ignition[703]: Stage: fetch-offline Jul 10 23:56:42.094378 ignition[703]: no configs at "/usr/lib/ignition/base.d" Jul 10 23:56:42.094386 ignition[703]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 23:56:42.094562 ignition[703]: parsed url from cmdline: "" Jul 10 23:56:42.094568 ignition[703]: no config URL provided Jul 10 23:56:42.094572 ignition[703]: reading system config file "/usr/lib/ignition/user.ign" Jul 10 23:56:42.094578 ignition[703]: no config at "/usr/lib/ignition/user.ign" Jul 10 23:56:42.094597 ignition[703]: op(1): [started] loading QEMU firmware config module Jul 10 23:56:42.094601 ignition[703]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 10 23:56:42.103578 ignition[703]: op(1): [finished] loading QEMU firmware config module Jul 10 23:56:42.103604 ignition[703]: QEMU firmware config was not found. Ignoring... Jul 10 23:56:42.107286 ignition[703]: parsing config with SHA512: fcff0b42e928a8fdd88e0efdd49d3bf2aa07cf19013ce474588715e771ae607eeb942aee16ec9ef5f83554a9fcbf02ddf3266212f00f34ce3b027da8965fa245 Jul 10 23:56:42.111721 unknown[703]: fetched base config from "system" Jul 10 23:56:42.111733 unknown[703]: fetched user config from "qemu" Jul 10 23:56:42.111889 ignition[703]: fetch-offline: fetch-offline passed Jul 10 23:56:42.111968 ignition[703]: Ignition finished successfully Jul 10 23:56:42.115103 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 10 23:56:42.116253 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 10 23:56:42.117019 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 10 23:56:42.149553 ignition[813]: Ignition 2.21.0 Jul 10 23:56:42.149564 ignition[813]: Stage: kargs Jul 10 23:56:42.149726 ignition[813]: no configs at "/usr/lib/ignition/base.d" Jul 10 23:56:42.149735 ignition[813]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 23:56:42.150265 ignition[813]: kargs: kargs passed Jul 10 23:56:42.150309 ignition[813]: Ignition finished successfully Jul 10 23:56:42.153178 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 10 23:56:42.155554 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 10 23:56:42.178655 ignition[821]: Ignition 2.21.0 Jul 10 23:56:42.178672 ignition[821]: Stage: disks Jul 10 23:56:42.178835 ignition[821]: no configs at "/usr/lib/ignition/base.d" Jul 10 23:56:42.178845 ignition[821]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 23:56:42.182512 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 10 23:56:42.180231 ignition[821]: disks: disks passed Jul 10 23:56:42.183598 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 10 23:56:42.180292 ignition[821]: Ignition finished successfully Jul 10 23:56:42.184959 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 10 23:56:42.186362 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 10 23:56:42.187883 systemd[1]: Reached target sysinit.target - System Initialization. Jul 10 23:56:42.189217 systemd[1]: Reached target basic.target - Basic System. Jul 10 23:56:42.191774 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 10 23:56:42.219632 systemd-fsck[831]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 10 23:56:42.224096 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 10 23:56:42.225858 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 10 23:56:42.288078 kernel: EXT4-fs (vda9): mounted filesystem 5e67f91a-7210-47f1-85b9-a7aa031a1904 r/w with ordered data mode. Quota mode: none. Jul 10 23:56:42.288713 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 10 23:56:42.289787 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 10 23:56:42.291771 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 10 23:56:42.293297 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 10 23:56:42.294100 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 10 23:56:42.294138 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 10 23:56:42.294160 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 10 23:56:42.311668 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 10 23:56:42.314824 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 10 23:56:42.316647 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (839) Jul 10 23:56:42.316670 kernel: BTRFS info (device vda6): first mount of filesystem b11340e8-a7f1-4911-a987-813f898c22db Jul 10 23:56:42.318120 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 10 23:56:42.318138 kernel: BTRFS info (device vda6): using free-space-tree Jul 10 23:56:42.321198 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 10 23:56:42.356957 initrd-setup-root[864]: cut: /sysroot/etc/passwd: No such file or directory Jul 10 23:56:42.361160 initrd-setup-root[871]: cut: /sysroot/etc/group: No such file or directory Jul 10 23:56:42.365138 initrd-setup-root[878]: cut: /sysroot/etc/shadow: No such file or directory Jul 10 23:56:42.368742 initrd-setup-root[885]: cut: /sysroot/etc/gshadow: No such file or directory Jul 10 23:56:42.436890 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 10 23:56:42.438646 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 10 23:56:42.440012 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 10 23:56:42.460075 kernel: BTRFS info (device vda6): last unmount of filesystem b11340e8-a7f1-4911-a987-813f898c22db Jul 10 23:56:42.479219 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 10 23:56:42.490783 ignition[953]: INFO : Ignition 2.21.0 Jul 10 23:56:42.490783 ignition[953]: INFO : Stage: mount Jul 10 23:56:42.492068 ignition[953]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 23:56:42.492068 ignition[953]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 23:56:42.492068 ignition[953]: INFO : mount: mount passed Jul 10 23:56:42.492068 ignition[953]: INFO : Ignition finished successfully Jul 10 23:56:42.493385 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 10 23:56:42.496184 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 10 23:56:42.899267 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 10 23:56:42.900783 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 10 23:56:42.921066 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (966) Jul 10 23:56:42.922708 kernel: BTRFS info (device vda6): first mount of filesystem b11340e8-a7f1-4911-a987-813f898c22db Jul 10 23:56:42.922737 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 10 23:56:42.922747 kernel: BTRFS info (device vda6): using free-space-tree Jul 10 23:56:42.925600 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 10 23:56:42.954733 ignition[983]: INFO : Ignition 2.21.0 Jul 10 23:56:42.954733 ignition[983]: INFO : Stage: files Jul 10 23:56:42.956710 ignition[983]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 23:56:42.956710 ignition[983]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 23:56:42.956710 ignition[983]: DEBUG : files: compiled without relabeling support, skipping Jul 10 23:56:42.959106 ignition[983]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 10 23:56:42.959106 ignition[983]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 10 23:56:42.960938 ignition[983]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 10 23:56:42.960938 ignition[983]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 10 23:56:42.962871 ignition[983]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 10 23:56:42.960942 unknown[983]: wrote ssh authorized keys file for user: core Jul 10 23:56:42.966673 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 10 23:56:42.967988 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 10 23:56:42.967988 ignition[983]: INFO : files: op(4): [started] processing unit "docker.service" Jul 10 23:56:42.967988 ignition[983]: INFO : files: op(4): [finished] processing unit "docker.service" Jul 10 23:56:42.967988 ignition[983]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Jul 10 23:56:42.972015 ignition[983]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 10 23:56:42.974857 ignition[983]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 10 23:56:42.974857 ignition[983]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Jul 10 23:56:42.974857 ignition[983]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Jul 10 23:56:42.991785 ignition[983]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 10 23:56:42.994637 ignition[983]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 10 23:56:42.995703 ignition[983]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Jul 10 23:56:42.995703 ignition[983]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Jul 10 23:56:42.995703 ignition[983]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Jul 10 23:56:42.995703 ignition[983]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 10 23:56:42.995703 ignition[983]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 10 23:56:42.995703 ignition[983]: INFO : files: files passed Jul 10 23:56:42.995703 ignition[983]: INFO : Ignition finished successfully Jul 10 23:56:42.996589 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 10 23:56:42.998236 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 10 23:56:42.999618 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 10 23:56:43.011492 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 10 23:56:43.011590 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 10 23:56:43.014156 initrd-setup-root-after-ignition[1012]: grep: /sysroot/oem/oem-release: No such file or directory Jul 10 23:56:43.015192 initrd-setup-root-after-ignition[1014]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 10 23:56:43.015192 initrd-setup-root-after-ignition[1014]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 10 23:56:43.017294 initrd-setup-root-after-ignition[1018]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 10 23:56:43.017033 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 10 23:56:43.018494 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 10 23:56:43.020609 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 10 23:56:43.066113 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 10 23:56:43.066965 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 10 23:56:43.069161 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 10 23:56:43.070733 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 10 23:56:43.071731 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 10 23:56:43.072550 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 10 23:56:43.094118 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 10 23:56:43.096511 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 10 23:56:43.124248 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 10 23:56:43.126120 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 23:56:43.127169 systemd[1]: Stopped target timers.target - Timer Units. Jul 10 23:56:43.128636 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 10 23:56:43.128785 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 10 23:56:43.130739 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 10 23:56:43.132313 systemd[1]: Stopped target basic.target - Basic System. Jul 10 23:56:43.133622 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 10 23:56:43.135044 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 10 23:56:43.136637 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 10 23:56:43.138153 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 10 23:56:43.139684 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 10 23:56:43.141100 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 10 23:56:43.142675 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 10 23:56:43.144172 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 10 23:56:43.145531 systemd[1]: Stopped target swap.target - Swaps. Jul 10 23:56:43.146726 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 10 23:56:43.146864 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 10 23:56:43.148653 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 10 23:56:43.150203 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 23:56:43.151779 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 10 23:56:43.155146 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 23:56:43.156212 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 10 23:56:43.156338 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 10 23:56:43.158512 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 10 23:56:43.158630 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 10 23:56:43.160158 systemd[1]: Stopped target paths.target - Path Units. Jul 10 23:56:43.161384 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 10 23:56:43.166121 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 23:56:43.167197 systemd[1]: Stopped target slices.target - Slice Units. Jul 10 23:56:43.168760 systemd[1]: Stopped target sockets.target - Socket Units. Jul 10 23:56:43.169960 systemd[1]: iscsid.socket: Deactivated successfully. Jul 10 23:56:43.170042 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 10 23:56:43.171262 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 10 23:56:43.171338 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 10 23:56:43.172546 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 10 23:56:43.172665 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 10 23:56:43.174088 systemd[1]: ignition-files.service: Deactivated successfully. Jul 10 23:56:43.174192 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 10 23:56:43.176147 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 10 23:56:43.178085 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 10 23:56:43.178826 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 10 23:56:43.178937 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 23:56:43.180418 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 10 23:56:43.180515 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 10 23:56:43.186408 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 10 23:56:43.186503 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 10 23:56:43.192466 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 10 23:56:43.196406 ignition[1039]: INFO : Ignition 2.21.0 Jul 10 23:56:43.196406 ignition[1039]: INFO : Stage: umount Jul 10 23:56:43.199672 ignition[1039]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 23:56:43.199672 ignition[1039]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 23:56:43.199672 ignition[1039]: INFO : umount: umount passed Jul 10 23:56:43.199672 ignition[1039]: INFO : Ignition finished successfully Jul 10 23:56:43.196623 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 10 23:56:43.196724 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 10 23:56:43.199800 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 10 23:56:43.199882 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 10 23:56:43.201464 systemd[1]: Stopped target network.target - Network. Jul 10 23:56:43.202568 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 10 23:56:43.202628 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 10 23:56:43.203749 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 10 23:56:43.203786 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 10 23:56:43.204987 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 10 23:56:43.205027 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 10 23:56:43.206273 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 10 23:56:43.206308 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 10 23:56:43.207613 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 10 23:56:43.207655 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 10 23:56:43.209214 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 10 23:56:43.210527 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 10 23:56:43.218085 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 10 23:56:43.218177 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 10 23:56:43.222327 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 10 23:56:43.222556 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 10 23:56:43.222645 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 10 23:56:43.225194 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jul 10 23:56:43.225595 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 10 23:56:43.227024 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 10 23:56:43.227074 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 10 23:56:43.229271 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 10 23:56:43.229955 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 10 23:56:43.230005 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 10 23:56:43.231602 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 10 23:56:43.231642 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 10 23:56:43.233865 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 10 23:56:43.233907 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 10 23:56:43.235368 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 10 23:56:43.235406 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 23:56:43.237975 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 23:56:43.248019 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 10 23:56:43.248834 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 10 23:56:43.255598 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 10 23:56:43.255745 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 23:56:43.257530 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 10 23:56:43.257568 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 10 23:56:43.259047 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 10 23:56:43.259090 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 23:56:43.260546 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 10 23:56:43.260589 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 10 23:56:43.262810 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 10 23:56:43.262873 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 10 23:56:43.265009 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 10 23:56:43.265072 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 23:56:43.268130 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 10 23:56:43.269775 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 10 23:56:43.269836 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 23:56:43.272571 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 10 23:56:43.272616 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 23:56:43.275355 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 10 23:56:43.275394 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 23:56:43.278036 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 10 23:56:43.278088 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 23:56:43.279892 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 23:56:43.279929 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 23:56:43.299282 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 10 23:56:43.300119 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 10 23:56:43.301278 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 10 23:56:43.303452 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 10 23:56:43.323923 systemd[1]: Switching root. Jul 10 23:56:43.361967 systemd-journald[244]: Journal stopped Jul 10 23:56:44.032022 systemd-journald[244]: Received SIGTERM from PID 1 (systemd). Jul 10 23:56:44.032161 kernel: SELinux: policy capability network_peer_controls=1 Jul 10 23:56:44.032178 kernel: SELinux: policy capability open_perms=1 Jul 10 23:56:44.032189 kernel: SELinux: policy capability extended_socket_class=1 Jul 10 23:56:44.032198 kernel: SELinux: policy capability always_check_network=0 Jul 10 23:56:44.032207 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 10 23:56:44.032216 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 10 23:56:44.032224 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 10 23:56:44.032236 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 10 23:56:44.032245 kernel: SELinux: policy capability userspace_initial_context=0 Jul 10 23:56:44.032254 kernel: audit: type=1403 audit(1752191803.454:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 10 23:56:44.032269 systemd[1]: Successfully loaded SELinux policy in 40.477ms. Jul 10 23:56:44.032288 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.567ms. Jul 10 23:56:44.032303 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) Jul 10 23:56:44.032314 systemd[1]: Detected virtualization kvm. Jul 10 23:56:44.032324 systemd[1]: Detected architecture arm64. Jul 10 23:56:44.032334 systemd[1]: Detected first boot. Jul 10 23:56:44.032343 systemd[1]: Initializing machine ID from VM UUID. Jul 10 23:56:44.032353 zram_generator::config[1085]: No configuration found. Jul 10 23:56:44.032365 kernel: NET: Registered PF_VSOCK protocol family Jul 10 23:56:44.032375 systemd[1]: Populated /etc with preset unit settings. Jul 10 23:56:44.032386 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 10 23:56:44.032395 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 10 23:56:44.032405 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 10 23:56:44.032417 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 10 23:56:44.032427 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 10 23:56:44.032437 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 10 23:56:44.032446 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 10 23:56:44.032457 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 10 23:56:44.032467 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 10 23:56:44.032477 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 10 23:56:44.032487 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 10 23:56:44.032498 systemd[1]: Created slice user.slice - User and Session Slice. Jul 10 23:56:44.032508 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 23:56:44.032518 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 23:56:44.032528 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 10 23:56:44.032539 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 10 23:56:44.032549 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 10 23:56:44.032559 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 10 23:56:44.032569 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jul 10 23:56:44.032578 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 23:56:44.032589 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 10 23:56:44.032599 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 10 23:56:44.032610 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 10 23:56:44.032620 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 10 23:56:44.032630 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 10 23:56:44.032640 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 23:56:44.032650 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 10 23:56:44.032659 systemd[1]: Reached target slices.target - Slice Units. Jul 10 23:56:44.032671 systemd[1]: Reached target swap.target - Swaps. Jul 10 23:56:44.032681 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 10 23:56:44.032691 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 10 23:56:44.032708 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 10 23:56:44.032719 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 10 23:56:44.032729 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 10 23:56:44.032739 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 23:56:44.032749 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 10 23:56:44.032758 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 10 23:56:44.032770 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 10 23:56:44.032780 systemd[1]: Mounting media.mount - External Media Directory... Jul 10 23:56:44.032790 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 10 23:56:44.032800 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 10 23:56:44.032810 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 10 23:56:44.032821 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). Jul 10 23:56:44.032831 systemd[1]: Reached target machines.target - Containers. Jul 10 23:56:44.032841 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 10 23:56:44.032852 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 23:56:44.032862 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 10 23:56:44.032872 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 10 23:56:44.032882 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 23:56:44.032891 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 10 23:56:44.032902 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 23:56:44.032912 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 10 23:56:44.032922 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 23:56:44.032932 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 10 23:56:44.032943 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 10 23:56:44.032953 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 10 23:56:44.032962 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 10 23:56:44.032972 systemd[1]: Stopped systemd-fsck-usr.service. Jul 10 23:56:44.032983 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). Jul 10 23:56:44.032993 kernel: loop: module loaded Jul 10 23:56:44.033002 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 10 23:56:44.033011 kernel: fuse: init (API version 7.41) Jul 10 23:56:44.033021 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 10 23:56:44.033032 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 10 23:56:44.033043 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 10 23:56:44.033061 kernel: ACPI: bus type drm_connector registered Jul 10 23:56:44.033074 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 10 23:56:44.033109 systemd-journald[1157]: Collecting audit messages is disabled. Jul 10 23:56:44.033133 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 10 23:56:44.033148 systemd-journald[1157]: Journal started Jul 10 23:56:44.033169 systemd-journald[1157]: Runtime Journal (/run/log/journal/7ee09036f2a94a32aab25e585c7c1b35) is 6M, max 48.5M, 42.4M free. Jul 10 23:56:43.838465 systemd[1]: Queued start job for default target multi-user.target. Jul 10 23:56:43.861089 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 10 23:56:43.861486 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 10 23:56:44.036817 systemd[1]: verity-setup.service: Deactivated successfully. Jul 10 23:56:44.036871 systemd[1]: Stopped verity-setup.service. Jul 10 23:56:44.040149 systemd[1]: Started systemd-journald.service - Journal Service. Jul 10 23:56:44.040860 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 10 23:56:44.041799 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 10 23:56:44.042748 systemd[1]: Mounted media.mount - External Media Directory. Jul 10 23:56:44.043595 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 10 23:56:44.044576 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 10 23:56:44.045522 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 10 23:56:44.048088 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 10 23:56:44.049250 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 23:56:44.050487 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 10 23:56:44.050667 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 10 23:56:44.051859 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 23:56:44.052010 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 23:56:44.053130 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 10 23:56:44.053287 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 10 23:56:44.054341 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 23:56:44.054515 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 23:56:44.055822 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 10 23:56:44.055978 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 10 23:56:44.057082 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 23:56:44.057247 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 23:56:44.058361 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 10 23:56:44.059649 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 23:56:44.060881 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 10 23:56:44.062135 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 10 23:56:44.076532 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 10 23:56:44.078853 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 10 23:56:44.080861 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 10 23:56:44.081914 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 10 23:56:44.081952 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 10 23:56:44.083822 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 10 23:56:44.089921 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 10 23:56:44.090852 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 23:56:44.092172 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 10 23:56:44.093805 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 10 23:56:44.094844 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 10 23:56:44.095974 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 10 23:56:44.096869 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 10 23:56:44.098151 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 10 23:56:44.100807 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 10 23:56:44.104732 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 10 23:56:44.106514 systemd-journald[1157]: Time spent on flushing to /var/log/journal/7ee09036f2a94a32aab25e585c7c1b35 is 23.425ms for 853 entries. Jul 10 23:56:44.106514 systemd-journald[1157]: System Journal (/var/log/journal/7ee09036f2a94a32aab25e585c7c1b35) is 8M, max 195.6M, 187.6M free. Jul 10 23:56:44.140131 systemd-journald[1157]: Received client request to flush runtime journal. Jul 10 23:56:44.140193 kernel: loop0: detected capacity change from 0 to 138376 Jul 10 23:56:44.115370 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 23:56:44.117558 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 10 23:56:44.119362 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 10 23:56:44.123087 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 10 23:56:44.128501 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 10 23:56:44.136250 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 10 23:56:44.139175 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 10 23:56:44.144783 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 10 23:56:44.148355 systemd-tmpfiles[1202]: ACLs are not supported, ignoring. Jul 10 23:56:44.148628 systemd-tmpfiles[1202]: ACLs are not supported, ignoring. Jul 10 23:56:44.149295 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 10 23:56:44.153606 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 23:56:44.157019 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 10 23:56:44.162078 kernel: loop1: detected capacity change from 0 to 107312 Jul 10 23:56:44.170502 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 10 23:56:44.171343 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 10 23:56:44.190621 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 10 23:56:44.194067 kernel: loop2: detected capacity change from 0 to 138376 Jul 10 23:56:44.193223 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 10 23:56:44.200084 kernel: loop3: detected capacity change from 0 to 107312 Jul 10 23:56:44.204229 (sd-merge)[1223]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jul 10 23:56:44.204588 (sd-merge)[1223]: Merged extensions into '/usr'. Jul 10 23:56:44.212270 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 10 23:56:44.215223 systemd[1]: Starting ensure-sysext.service... Jul 10 23:56:44.217183 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 10 23:56:44.229373 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Jul 10 23:56:44.229390 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Jul 10 23:56:44.233436 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 23:56:44.241966 systemd[1]: Reload requested from client PID 1226 ('systemctl') (unit ensure-sysext.service)... Jul 10 23:56:44.241985 systemd[1]: Reloading... Jul 10 23:56:44.243628 systemd-tmpfiles[1228]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 10 23:56:44.243654 systemd-tmpfiles[1228]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 10 23:56:44.243865 systemd-tmpfiles[1228]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 10 23:56:44.244012 systemd-tmpfiles[1228]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 10 23:56:44.244557 systemd-tmpfiles[1228]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 10 23:56:44.244746 systemd-tmpfiles[1228]: ACLs are not supported, ignoring. Jul 10 23:56:44.244786 systemd-tmpfiles[1228]: ACLs are not supported, ignoring. Jul 10 23:56:44.247138 systemd-tmpfiles[1228]: Detected autofs mount point /boot during canonicalization of boot. Jul 10 23:56:44.247149 systemd-tmpfiles[1228]: Skipping /boot Jul 10 23:56:44.256390 systemd-tmpfiles[1228]: Detected autofs mount point /boot during canonicalization of boot. Jul 10 23:56:44.256404 systemd-tmpfiles[1228]: Skipping /boot Jul 10 23:56:44.293385 zram_generator::config[1257]: No configuration found. Jul 10 23:56:44.400706 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. Jul 10 23:56:44.408568 ldconfig[1196]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 10 23:56:44.479996 systemd[1]: Reloading finished in 237 ms. Jul 10 23:56:44.506782 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 10 23:56:44.534083 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 23:56:44.541626 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 10 23:56:44.543818 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 10 23:56:44.552322 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 10 23:56:44.558681 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 10 23:56:44.561384 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 10 23:56:44.564760 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 23:56:44.568362 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 23:56:44.570420 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 23:56:44.573400 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 23:56:44.574639 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 23:56:44.574797 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). Jul 10 23:56:44.580092 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 10 23:56:44.581219 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 23:56:44.589101 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 23:56:44.590924 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 23:56:44.591158 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 23:56:44.597367 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 23:56:44.597559 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 23:56:44.600160 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 23:56:44.602134 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 23:56:44.605462 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 23:56:44.606642 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 23:56:44.606776 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). Jul 10 23:56:44.607801 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 10 23:56:44.613927 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 23:56:44.621450 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 10 23:56:44.625063 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 23:56:44.626333 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 23:56:44.627316 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). Jul 10 23:56:44.628330 augenrules[1328]: No rules Jul 10 23:56:44.629108 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 10 23:56:44.630845 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 10 23:56:44.632354 systemd[1]: audit-rules.service: Deactivated successfully. Jul 10 23:56:44.645456 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 10 23:56:44.647237 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 23:56:44.647402 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 23:56:44.648884 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 23:56:44.649032 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 23:56:44.650662 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 10 23:56:44.650903 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 10 23:56:44.652387 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 23:56:44.652536 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 23:56:44.656384 systemd[1]: Finished ensure-sysext.service. Jul 10 23:56:44.657500 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 10 23:56:44.664472 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 10 23:56:44.664540 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 10 23:56:44.666514 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 10 23:56:44.667435 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). Jul 10 23:56:44.707002 systemd-resolved[1297]: Positive Trust Anchors: Jul 10 23:56:44.707020 systemd-resolved[1297]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 10 23:56:44.707153 systemd-resolved[1297]: 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 Jul 10 23:56:44.777278 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 10 23:56:44.778313 systemd-resolved[1297]: Defaulting to hostname 'linux'. Jul 10 23:56:44.778396 systemd[1]: Reached target time-set.target - System Time Set. Jul 10 23:56:44.783274 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 10 23:56:44.784140 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 10 23:56:44.812149 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 10 23:56:44.814998 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 23:56:44.817151 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 10 23:56:44.842245 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 10 23:56:44.854497 systemd-udevd[1350]: Using default interface naming scheme 'v255'. Jul 10 23:56:44.869690 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 23:56:44.871118 systemd[1]: Reached target sysinit.target - System Initialization. Jul 10 23:56:44.873103 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 10 23:56:44.874227 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 10 23:56:44.875301 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 10 23:56:44.876190 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 10 23:56:44.877232 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 10 23:56:44.878177 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 10 23:56:44.878204 systemd[1]: Reached target paths.target - Path Units. Jul 10 23:56:44.880129 systemd[1]: Reached target timers.target - Timer Units. Jul 10 23:56:44.881845 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 10 23:56:44.887020 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 10 23:56:44.891466 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 10 23:56:44.894345 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 10 23:56:44.895541 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 10 23:56:44.901342 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 10 23:56:44.902733 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 10 23:56:44.907273 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 10 23:56:44.909656 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 10 23:56:44.916747 systemd[1]: Reached target sockets.target - Socket Units. Jul 10 23:56:44.919116 systemd[1]: Reached target basic.target - Basic System. Jul 10 23:56:44.919858 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 10 23:56:44.919891 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 10 23:56:44.921898 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 10 23:56:44.924353 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 10 23:56:44.926780 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 10 23:56:44.929344 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 10 23:56:44.931179 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). Jul 10 23:56:44.945288 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 10 23:56:44.952226 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 10 23:56:44.956312 jq[1385]: false Jul 10 23:56:44.956885 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 10 23:56:44.968836 extend-filesystems[1386]: Found /dev/vda6 Jul 10 23:56:44.969560 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 10 23:56:44.972225 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 10 23:56:44.973162 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 10 23:56:44.975364 systemd[1]: Starting update-engine.service - Update Engine... Jul 10 23:56:44.975490 extend-filesystems[1386]: Found /dev/vda9 Jul 10 23:56:44.978272 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 10 23:56:44.980261 extend-filesystems[1386]: Checking size of /dev/vda9 Jul 10 23:56:44.980863 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 10 23:56:44.986440 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 10 23:56:44.995496 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 10 23:56:44.995910 systemd[1]: motdgen.service: Deactivated successfully. Jul 10 23:56:44.996111 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 10 23:56:44.997493 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 10 23:56:44.997684 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 10 23:56:45.002994 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jul 10 23:56:45.010889 extend-filesystems[1386]: Old size kept for /dev/vda9 Jul 10 23:56:45.014572 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 10 23:56:45.014851 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 10 23:56:45.018456 jq[1409]: true Jul 10 23:56:45.045022 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 10 23:56:45.050391 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 10 23:56:45.056078 jq[1423]: true Jul 10 23:56:45.056655 update_engine[1406]: I20250710 23:56:45.056505 1406 main.cc:92] Flatcar Update Engine starting Jul 10 23:56:45.066402 dbus-daemon[1383]: [system] SELinux support is enabled Jul 10 23:56:45.066617 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 10 23:56:45.070145 update_engine[1406]: I20250710 23:56:45.068737 1406 update_check_scheduler.cc:74] Next update check in 8m13s Jul 10 23:56:45.070147 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 10 23:56:45.074761 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). Jul 10 23:56:45.074807 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 10 23:56:45.076400 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). Jul 10 23:56:45.076416 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 10 23:56:45.078074 systemd[1]: Started update-engine.service - Update Engine. Jul 10 23:56:45.081582 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 10 23:56:45.122610 systemd-logind[1399]: New seat seat0. Jul 10 23:56:45.125590 bash[1446]: Updated "/home/core/.ssh/authorized_keys" Jul 10 23:56:45.129110 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 10 23:56:45.132872 systemd-networkd[1382]: lo: Link UP Jul 10 23:56:45.132878 systemd-networkd[1382]: lo: Gained carrier Jul 10 23:56:45.133760 systemd-networkd[1382]: Enumeration completed Jul 10 23:56:45.140222 systemd-networkd[1382]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 23:56:45.140230 systemd-networkd[1382]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 10 23:56:45.140809 systemd-networkd[1382]: eth0: Link UP Jul 10 23:56:45.140961 systemd-networkd[1382]: eth0: Gained carrier Jul 10 23:56:45.140976 systemd-networkd[1382]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 23:56:45.161164 systemd-networkd[1382]: eth0: DHCPv4 address 10.0.0.110/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 10 23:56:45.161898 systemd-timesyncd[1347]: Network configuration changed, trying to establish connection. Jul 10 23:56:45.162421 systemd-timesyncd[1347]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 10 23:56:45.162462 systemd-timesyncd[1347]: Initial clock synchronization to Thu 2025-07-10 23:56:45.505143 UTC. Jul 10 23:56:45.165435 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 10 23:56:45.167395 locksmithd[1432]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 10 23:56:45.181427 systemd[1]: Reached target network.target - Network. Jul 10 23:56:45.187283 systemd[1]: Starting containerd.service - containerd container runtime... Jul 10 23:56:45.188392 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 10 23:56:45.190366 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 10 23:56:45.196311 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 10 23:56:45.197377 systemd[1]: Started systemd-logind.service - User Login Management. Jul 10 23:56:45.219122 (ntainerd)[1473]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 10 23:56:45.235936 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 23:56:45.239085 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 10 23:56:45.264145 systemd-logind[1399]: Watching system buttons on /dev/input/event0 (Power Button) Jul 10 23:56:45.344130 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 23:56:45.422640 containerd[1473]: time="2025-07-10T23:56:45Z" 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 Jul 10 23:56:45.423226 containerd[1473]: time="2025-07-10T23:56:45.423192440Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 10 23:56:45.431300 containerd[1473]: time="2025-07-10T23:56:45.431251920Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.6µs" Jul 10 23:56:45.431300 containerd[1473]: time="2025-07-10T23:56:45.431290200Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 10 23:56:45.431300 containerd[1473]: time="2025-07-10T23:56:45.431308160Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 10 23:56:45.431510 containerd[1473]: time="2025-07-10T23:56:45.431470920Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 10 23:56:45.431510 containerd[1473]: time="2025-07-10T23:56:45.431492840Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 10 23:56:45.431555 containerd[1473]: time="2025-07-10T23:56:45.431536680Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 23:56:45.431601 containerd[1473]: time="2025-07-10T23:56:45.431584760Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 23:56:45.431625 containerd[1473]: time="2025-07-10T23:56:45.431600640Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 10 23:56:45.431952 containerd[1473]: time="2025-07-10T23:56:45.431922360Z" 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 Jul 10 23:56:45.431952 containerd[1473]: time="2025-07-10T23:56:45.431945320Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 23:56:45.431993 containerd[1473]: time="2025-07-10T23:56:45.431956920Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 23:56:45.431993 containerd[1473]: time="2025-07-10T23:56:45.431965040Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 10 23:56:45.432050 containerd[1473]: time="2025-07-10T23:56:45.432036400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 10 23:56:45.432271 containerd[1473]: time="2025-07-10T23:56:45.432242920Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 10 23:56:45.432296 containerd[1473]: time="2025-07-10T23:56:45.432278520Z" 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 Jul 10 23:56:45.432296 containerd[1473]: time="2025-07-10T23:56:45.432289080Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 10 23:56:45.432837 containerd[1473]: time="2025-07-10T23:56:45.432805880Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 10 23:56:45.433348 containerd[1473]: time="2025-07-10T23:56:45.433205960Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 10 23:56:45.433348 containerd[1473]: time="2025-07-10T23:56:45.433308120Z" level=info msg="metadata content store policy set" policy=shared Jul 10 23:56:45.442078 containerd[1473]: time="2025-07-10T23:56:45.442023840Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 10 23:56:45.442175 containerd[1473]: time="2025-07-10T23:56:45.442102680Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 10 23:56:45.442175 containerd[1473]: time="2025-07-10T23:56:45.442118920Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 10 23:56:45.442175 containerd[1473]: time="2025-07-10T23:56:45.442133000Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 10 23:56:45.442175 containerd[1473]: time="2025-07-10T23:56:45.442145840Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 10 23:56:45.442175 containerd[1473]: time="2025-07-10T23:56:45.442156800Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 10 23:56:45.442175 containerd[1473]: time="2025-07-10T23:56:45.442169120Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 10 23:56:45.442288 containerd[1473]: time="2025-07-10T23:56:45.442181360Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 10 23:56:45.442288 containerd[1473]: time="2025-07-10T23:56:45.442192920Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 10 23:56:45.442288 containerd[1473]: time="2025-07-10T23:56:45.442203000Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 10 23:56:45.442288 containerd[1473]: time="2025-07-10T23:56:45.442211680Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 10 23:56:45.442288 containerd[1473]: time="2025-07-10T23:56:45.442224160Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 10 23:56:45.442392 containerd[1473]: time="2025-07-10T23:56:45.442370200Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 10 23:56:45.442422 containerd[1473]: time="2025-07-10T23:56:45.442396280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 10 23:56:45.442422 containerd[1473]: time="2025-07-10T23:56:45.442411120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442421360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442431800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442442320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442460520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442472440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442484320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442500240Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 10 23:56:45.442524 containerd[1473]: time="2025-07-10T23:56:45.442510760Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 10 23:56:45.442734 containerd[1473]: time="2025-07-10T23:56:45.442701440Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 10 23:56:45.442734 containerd[1473]: time="2025-07-10T23:56:45.442724600Z" level=info msg="Start snapshots syncer" Jul 10 23:56:45.442803 containerd[1473]: time="2025-07-10T23:56:45.442752160Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 10 23:56:45.443023 containerd[1473]: time="2025-07-10T23:56:45.442968280Z" 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\"}" Jul 10 23:56:45.443023 containerd[1473]: time="2025-07-10T23:56:45.443020160Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 10 23:56:45.443224 containerd[1473]: time="2025-07-10T23:56:45.443117160Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 10 23:56:45.443260 containerd[1473]: time="2025-07-10T23:56:45.443226920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 10 23:56:45.443278 containerd[1473]: time="2025-07-10T23:56:45.443257800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 10 23:56:45.443278 containerd[1473]: time="2025-07-10T23:56:45.443269400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 10 23:56:45.443310 containerd[1473]: time="2025-07-10T23:56:45.443280160Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 10 23:56:45.443310 containerd[1473]: time="2025-07-10T23:56:45.443293480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 10 23:56:45.443310 containerd[1473]: time="2025-07-10T23:56:45.443303960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 10 23:56:45.443365 containerd[1473]: time="2025-07-10T23:56:45.443314840Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 10 23:56:45.443365 containerd[1473]: time="2025-07-10T23:56:45.443339560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 10 23:56:45.443365 containerd[1473]: time="2025-07-10T23:56:45.443351520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 10 23:56:45.443365 containerd[1473]: time="2025-07-10T23:56:45.443363240Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443393320Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443407320Z" 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 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443415800Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443425960Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443434200Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443443520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 10 23:56:45.443464 containerd[1473]: time="2025-07-10T23:56:45.443453960Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 10 23:56:45.443573 containerd[1473]: time="2025-07-10T23:56:45.443529160Z" level=info msg="runtime interface created" Jul 10 23:56:45.443573 containerd[1473]: time="2025-07-10T23:56:45.443534480Z" level=info msg="created NRI interface" Jul 10 23:56:45.443573 containerd[1473]: time="2025-07-10T23:56:45.443541960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 10 23:56:45.443573 containerd[1473]: time="2025-07-10T23:56:45.443552800Z" level=info msg="Connect containerd service" Jul 10 23:56:45.443632 containerd[1473]: time="2025-07-10T23:56:45.443583000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 10 23:56:45.444310 containerd[1473]: time="2025-07-10T23:56:45.444274800Z" 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" Jul 10 23:56:45.540226 containerd[1473]: time="2025-07-10T23:56:45.540157560Z" level=info msg="Start subscribing containerd event" Jul 10 23:56:45.540405 containerd[1473]: time="2025-07-10T23:56:45.540358320Z" level=info msg="Start recovering state" Jul 10 23:56:45.540467 containerd[1473]: time="2025-07-10T23:56:45.540441200Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 10 23:56:45.540578 containerd[1473]: time="2025-07-10T23:56:45.540495080Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 10 23:56:45.540698 containerd[1473]: time="2025-07-10T23:56:45.540673320Z" level=info msg="Start event monitor" Jul 10 23:56:45.540894 containerd[1473]: time="2025-07-10T23:56:45.540834800Z" level=info msg="Start cni network conf syncer for default" Jul 10 23:56:45.540894 containerd[1473]: time="2025-07-10T23:56:45.540849600Z" level=info msg="Start streaming server" Jul 10 23:56:45.540894 containerd[1473]: time="2025-07-10T23:56:45.540861000Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 10 23:56:45.540894 containerd[1473]: time="2025-07-10T23:56:45.540869040Z" level=info msg="runtime interface starting up..." Jul 10 23:56:45.540894 containerd[1473]: time="2025-07-10T23:56:45.540874320Z" level=info msg="starting plugins..." Jul 10 23:56:45.541095 containerd[1473]: time="2025-07-10T23:56:45.541072120Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 10 23:56:45.544398 containerd[1473]: time="2025-07-10T23:56:45.544319920Z" level=info msg="containerd successfully booted in 0.122034s" Jul 10 23:56:45.545208 systemd[1]: Started containerd.service - containerd container runtime. Jul 10 23:56:45.843959 sshd_keygen[1412]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 10 23:56:45.862604 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 10 23:56:45.865874 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 10 23:56:45.885396 systemd[1]: issuegen.service: Deactivated successfully. Jul 10 23:56:45.885610 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 10 23:56:45.887896 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 10 23:56:45.915323 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 10 23:56:45.917788 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 10 23:56:45.919619 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jul 10 23:56:45.920694 systemd[1]: Reached target getty.target - Login Prompts. Jul 10 23:56:46.264822 systemd-networkd[1382]: eth0: Gained IPv6LL Jul 10 23:56:46.270723 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 10 23:56:46.272229 systemd[1]: Reached target network-online.target - Network is Online. Jul 10 23:56:46.274398 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 10 23:56:46.276305 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 10 23:56:46.301433 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 10 23:56:46.301648 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 10 23:56:46.303418 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 10 23:56:46.305647 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 10 23:56:46.306307 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 10 23:56:46.307485 systemd[1]: Startup finished in 2.116s (kernel) + 3.834s (initrd) + 2.894s (userspace) = 8.845s. Jul 10 23:56:53.277732 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 10 23:56:53.278855 systemd[1]: Started sshd@0-10.0.0.110:22-10.0.0.1:56936.service - OpenSSH per-connection server daemon (10.0.0.1:56936). Jul 10 23:56:53.357736 sshd[1543]: Accepted publickey for core from 10.0.0.1 port 56936 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:53.359428 sshd-session[1543]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:53.365376 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 10 23:56:53.366277 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 10 23:56:53.371546 systemd-logind[1399]: New session 1 of user core. Jul 10 23:56:53.391113 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 10 23:56:53.393757 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 10 23:56:53.411948 (systemd)[1547]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 10 23:56:53.413928 systemd-logind[1399]: New session c1 of user core. Jul 10 23:56:53.524877 systemd[1547]: Queued start job for default target default.target. Jul 10 23:56:53.542933 systemd[1547]: Created slice app.slice - User Application Slice. Jul 10 23:56:53.542960 systemd[1547]: Reached target paths.target - Paths. Jul 10 23:56:53.542992 systemd[1547]: Reached target timers.target - Timers. Jul 10 23:56:53.544206 systemd[1547]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 10 23:56:53.552746 systemd[1547]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 10 23:56:53.552802 systemd[1547]: Reached target sockets.target - Sockets. Jul 10 23:56:53.552836 systemd[1547]: Reached target basic.target - Basic System. Jul 10 23:56:53.552863 systemd[1547]: Reached target default.target - Main User Target. Jul 10 23:56:53.552887 systemd[1547]: Startup finished in 133ms. Jul 10 23:56:53.553092 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 10 23:56:53.554570 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 10 23:56:53.624635 systemd[1]: Started sshd@1-10.0.0.110:22-10.0.0.1:56938.service - OpenSSH per-connection server daemon (10.0.0.1:56938). Jul 10 23:56:53.662131 sshd[1558]: Accepted publickey for core from 10.0.0.1 port 56938 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:53.663407 sshd-session[1558]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:53.667883 systemd-logind[1399]: New session 2 of user core. Jul 10 23:56:53.674240 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 10 23:56:53.725791 sshd[1560]: Connection closed by 10.0.0.1 port 56938 Jul 10 23:56:53.726176 sshd-session[1558]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:53.739189 systemd[1]: sshd@1-10.0.0.110:22-10.0.0.1:56938.service: Deactivated successfully. Jul 10 23:56:53.740590 systemd[1]: session-2.scope: Deactivated successfully. Jul 10 23:56:53.742139 systemd-logind[1399]: Session 2 logged out. Waiting for processes to exit. Jul 10 23:56:53.743375 systemd[1]: Started sshd@2-10.0.0.110:22-10.0.0.1:56944.service - OpenSSH per-connection server daemon (10.0.0.1:56944). Jul 10 23:56:53.744393 systemd-logind[1399]: Removed session 2. Jul 10 23:56:53.780657 sshd[1566]: Accepted publickey for core from 10.0.0.1 port 56944 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:53.781750 sshd-session[1566]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:53.786023 systemd-logind[1399]: New session 3 of user core. Jul 10 23:56:53.799216 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 10 23:56:53.847779 sshd[1569]: Connection closed by 10.0.0.1 port 56944 Jul 10 23:56:53.848163 sshd-session[1566]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:53.859235 systemd[1]: sshd@2-10.0.0.110:22-10.0.0.1:56944.service: Deactivated successfully. Jul 10 23:56:53.860583 systemd[1]: session-3.scope: Deactivated successfully. Jul 10 23:56:53.861538 systemd-logind[1399]: Session 3 logged out. Waiting for processes to exit. Jul 10 23:56:53.863756 systemd[1]: Started sshd@3-10.0.0.110:22-10.0.0.1:56946.service - OpenSSH per-connection server daemon (10.0.0.1:56946). Jul 10 23:56:53.864214 systemd-logind[1399]: Removed session 3. Jul 10 23:56:53.910411 sshd[1575]: Accepted publickey for core from 10.0.0.1 port 56946 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:53.911510 sshd-session[1575]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:53.915830 systemd-logind[1399]: New session 4 of user core. Jul 10 23:56:53.928222 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 10 23:56:53.979727 sshd[1577]: Connection closed by 10.0.0.1 port 56946 Jul 10 23:56:53.980213 sshd-session[1575]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:53.990310 systemd[1]: sshd@3-10.0.0.110:22-10.0.0.1:56946.service: Deactivated successfully. Jul 10 23:56:53.992418 systemd[1]: session-4.scope: Deactivated successfully. Jul 10 23:56:53.993211 systemd-logind[1399]: Session 4 logged out. Waiting for processes to exit. Jul 10 23:56:53.995858 systemd[1]: Started sshd@4-10.0.0.110:22-10.0.0.1:56956.service - OpenSSH per-connection server daemon (10.0.0.1:56956). Jul 10 23:56:53.996746 systemd-logind[1399]: Removed session 4. Jul 10 23:56:54.042763 sshd[1583]: Accepted publickey for core from 10.0.0.1 port 56956 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:54.043934 sshd-session[1583]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:54.047764 systemd-logind[1399]: New session 5 of user core. Jul 10 23:56:54.064257 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 10 23:56:54.127272 sudo[1586]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 10 23:56:54.133345 sudo[1586]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 23:56:54.161780 sudo[1586]: pam_unix(sudo:session): session closed for user root Jul 10 23:56:54.164039 sshd[1585]: Connection closed by 10.0.0.1 port 56956 Jul 10 23:56:54.163822 sshd-session[1583]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:54.176729 systemd[1]: sshd@4-10.0.0.110:22-10.0.0.1:56956.service: Deactivated successfully. Jul 10 23:56:54.178250 systemd[1]: session-5.scope: Deactivated successfully. Jul 10 23:56:54.180970 systemd-logind[1399]: Session 5 logged out. Waiting for processes to exit. Jul 10 23:56:54.183534 systemd[1]: Started sshd@5-10.0.0.110:22-10.0.0.1:56972.service - OpenSSH per-connection server daemon (10.0.0.1:56972). Jul 10 23:56:54.184486 systemd-logind[1399]: Removed session 5. Jul 10 23:56:54.234566 sshd[1592]: Accepted publickey for core from 10.0.0.1 port 56972 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:54.235788 sshd-session[1592]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:54.239747 systemd-logind[1399]: New session 6 of user core. Jul 10 23:56:54.249310 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 10 23:56:54.299905 sudo[1596]: 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 Jul 10 23:56:54.300216 sudo[1596]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 23:56:54.304980 sudo[1596]: pam_unix(sudo:session): session closed for user root Jul 10 23:56:54.309663 sudo[1595]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 10 23:56:54.309908 sudo[1595]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 23:56:54.318309 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 10 23:56:54.351813 augenrules[1618]: No rules Jul 10 23:56:54.353000 systemd[1]: audit-rules.service: Deactivated successfully. Jul 10 23:56:54.353264 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 10 23:56:54.354570 sudo[1595]: pam_unix(sudo:session): session closed for user root Jul 10 23:56:54.355692 sshd[1594]: Connection closed by 10.0.0.1 port 56972 Jul 10 23:56:54.356254 sshd-session[1592]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:54.368322 systemd[1]: sshd@5-10.0.0.110:22-10.0.0.1:56972.service: Deactivated successfully. Jul 10 23:56:54.370371 systemd[1]: session-6.scope: Deactivated successfully. Jul 10 23:56:54.372566 systemd-logind[1399]: Session 6 logged out. Waiting for processes to exit. Jul 10 23:56:54.374628 systemd[1]: Started sshd@6-10.0.0.110:22-10.0.0.1:56974.service - OpenSSH per-connection server daemon (10.0.0.1:56974). Jul 10 23:56:54.375505 systemd-logind[1399]: Removed session 6. Jul 10 23:56:54.426838 sshd[1627]: Accepted publickey for core from 10.0.0.1 port 56974 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:54.428196 sshd-session[1627]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:54.432642 systemd-logind[1399]: New session 7 of user core. Jul 10 23:56:54.444218 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 10 23:56:54.500576 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 10 23:56:54.512365 (dockerd)[1631]: 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 Jul 10 23:56:54.764321 dockerd[1631]: time="2025-07-10T23:56:54.764190222Z" level=info msg="Starting up" Jul 10 23:56:54.765908 dockerd[1631]: time="2025-07-10T23:56:54.765868697Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 10 23:56:54.826556 dockerd[1631]: time="2025-07-10T23:56:54.826501180Z" level=info msg="Loading containers: start." Jul 10 23:56:54.838891 kernel: Initializing XFRM netlink socket Jul 10 23:56:55.045915 systemd-networkd[1382]: docker0: Link UP Jul 10 23:56:55.052541 dockerd[1631]: time="2025-07-10T23:56:55.052495661Z" level=info msg="Loading containers: done." Jul 10 23:56:55.065040 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck855980507-merged.mount: Deactivated successfully. Jul 10 23:56:55.067917 dockerd[1631]: time="2025-07-10T23:56:55.067556875Z" 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 Jul 10 23:56:55.067917 dockerd[1631]: time="2025-07-10T23:56:55.067644712Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 10 23:56:55.067917 dockerd[1631]: time="2025-07-10T23:56:55.067748675Z" level=info msg="Initializing buildkit" Jul 10 23:56:55.090651 dockerd[1631]: time="2025-07-10T23:56:55.090612819Z" level=info msg="Completed buildkit initialization" Jul 10 23:56:55.095915 dockerd[1631]: time="2025-07-10T23:56:55.095772529Z" level=info msg="Daemon has completed initialization" Jul 10 23:56:55.096002 dockerd[1631]: time="2025-07-10T23:56:55.095875803Z" level=info msg="API listen on /run/docker.sock" Jul 10 23:56:55.096001 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 10 23:56:55.103902 sshd[1629]: Connection closed by 10.0.0.1 port 56974 Jul 10 23:56:55.104374 sshd-session[1627]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:55.111285 systemd[1]: sshd@6-10.0.0.110:22-10.0.0.1:56974.service: Deactivated successfully. Jul 10 23:56:55.113352 systemd[1]: session-7.scope: Deactivated successfully. Jul 10 23:56:55.116127 systemd-logind[1399]: Session 7 logged out. Waiting for processes to exit. Jul 10 23:56:55.118115 systemd[1]: Started sshd@7-10.0.0.110:22-10.0.0.1:56986.service - OpenSSH per-connection server daemon (10.0.0.1:56986). Jul 10 23:56:55.118809 systemd-logind[1399]: Removed session 7. Jul 10 23:56:55.164306 sshd[1835]: Accepted publickey for core from 10.0.0.1 port 56986 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:55.165502 sshd-session[1835]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:55.170515 systemd-logind[1399]: New session 8 of user core. Jul 10 23:56:55.182257 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 10 23:56:56.318914 systemd[1]: var-lib-docker-overlay2-9dc5008c44d3e6d3af5d3472e9402ad714aaffeeacdaf0dfe441882883e2542a\x2dinit-merged.mount: Deactivated successfully. Jul 10 23:56:56.361751 containerd[1473]: time="2025-07-10T23:56:56.361695279Z" level=info msg="connecting to shim 41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41" address="unix:///run/containerd/s/6df6ef60beba98f018b25ac3d8c43817daeff08d65853cbabe0efcf04fe88000" namespace=moby protocol=ttrpc version=3 Jul 10 23:56:56.392490 systemd[1]: Started docker-41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41.scope - libcontainer container 41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41. Jul 10 23:56:56.404890 systemd-resolved[1297]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 23:56:56.424383 kernel: docker0: port 1(vethec10d1e) entered blocking state Jul 10 23:56:56.424475 kernel: docker0: port 1(vethec10d1e) entered disabled state Jul 10 23:56:56.424495 kernel: vethec10d1e: entered allmulticast mode Jul 10 23:56:56.424514 kernel: vethec10d1e: entered promiscuous mode Jul 10 23:56:56.424990 systemd-networkd[1382]: vethec10d1e: Link UP Jul 10 23:56:56.433937 kernel: eth0: renamed from vethdc3cf48 Jul 10 23:56:56.434028 kernel: docker0: port 1(vethec10d1e) entered blocking state Jul 10 23:56:56.434047 kernel: docker0: port 1(vethec10d1e) entered forwarding state Jul 10 23:56:56.434126 systemd-networkd[1382]: vethec10d1e: Gained carrier Jul 10 23:56:56.434779 systemd-networkd[1382]: docker0: Gained carrier Jul 10 23:56:56.458972 sshd[1837]: Connection closed by 10.0.0.1 port 56986 Jul 10 23:56:56.458879 sshd-session[1835]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:56.473940 systemd[1]: sshd@7-10.0.0.110:22-10.0.0.1:56986.service: Deactivated successfully. Jul 10 23:56:56.477004 systemd[1]: session-8.scope: Deactivated successfully. Jul 10 23:56:56.479352 systemd-logind[1399]: Session 8 logged out. Waiting for processes to exit. Jul 10 23:56:56.481337 systemd[1]: Started sshd@8-10.0.0.110:22-10.0.0.1:56992.service - OpenSSH per-connection server daemon (10.0.0.1:56992). Jul 10 23:56:56.482795 systemd-logind[1399]: Removed session 8. Jul 10 23:56:56.526257 sshd[1912]: Accepted publickey for core from 10.0.0.1 port 56992 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:56.527551 sshd-session[1912]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:56.531612 systemd-logind[1399]: New session 9 of user core. Jul 10 23:56:56.541220 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 10 23:56:56.596694 sshd[1914]: Connection closed by 10.0.0.1 port 56992 Jul 10 23:56:56.597016 sshd-session[1912]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:56.606206 systemd[1]: sshd@8-10.0.0.110:22-10.0.0.1:56992.service: Deactivated successfully. Jul 10 23:56:56.608383 systemd[1]: session-9.scope: Deactivated successfully. Jul 10 23:56:56.610157 systemd-logind[1399]: Session 9 logged out. Waiting for processes to exit. Jul 10 23:56:56.611940 systemd[1]: Started sshd@9-10.0.0.110:22-10.0.0.1:56996.service - OpenSSH per-connection server daemon (10.0.0.1:56996). Jul 10 23:56:56.612996 systemd-logind[1399]: Removed session 9. Jul 10 23:56:56.663580 sshd[1920]: Accepted publickey for core from 10.0.0.1 port 56996 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:56.664793 sshd-session[1920]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:56.668700 systemd-logind[1399]: New session 10 of user core. Jul 10 23:56:56.681219 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 10 23:56:56.731722 sudo[1923]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1473 Jul 10 23:56:56.732336 sudo[1923]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 23:56:56.737562 sudo[1923]: pam_unix(sudo:session): session closed for user root Jul 10 23:56:56.737811 dockerd[1631]: time="2025-07-10T23:56:56.737750660Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 10 23:56:56.737811 dockerd[1631]: time="2025-07-10T23:56:56.737794994Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 10 23:56:56.738126 containerd[1473]: time="2025-07-10T23:56:56.737942438Z" level=info msg="Stop CRI service" Jul 10 23:56:56.738346 dockerd[1631]: time="2025-07-10T23:56:56.738312200Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 10 23:56:56.738346 dockerd[1631]: time="2025-07-10T23:56:56.738344641Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 10 23:56:56.738768 containerd[1473]: time="2025-07-10T23:56:56.738640661Z" level=info msg="Stop CRI service" Jul 10 23:56:56.738820 sshd[1922]: Connection closed by 10.0.0.1 port 56996 Jul 10 23:56:56.740177 sshd-session[1920]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:56.747120 systemd[1]: containerd.service: Deactivated successfully. Jul 10 23:56:56.747230 systemd[1]: containerd.service: Unit process 1861 (containerd-shim) remains running after unit stopped. Jul 10 23:56:56.747446 systemd[1]: containerd.service: Consumed 349ms CPU time, 135.1M memory peak. Jul 10 23:56:56.747813 systemd[1]: sshd@9-10.0.0.110:22-10.0.0.1:56996.service: Deactivated successfully. Jul 10 23:56:56.749737 systemd[1]: session-10.scope: Deactivated successfully. Jul 10 23:56:56.750446 systemd-logind[1399]: Session 10 logged out. Waiting for processes to exit. Jul 10 23:56:56.753368 systemd[1]: Started sshd@10-10.0.0.110:22-10.0.0.1:57010.service - OpenSSH per-connection server daemon (10.0.0.1:57010). Jul 10 23:56:56.753920 systemd-logind[1399]: Removed session 10. Jul 10 23:56:56.794657 sshd[1930]: Accepted publickey for core from 10.0.0.1 port 57010 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:56:56.795786 sshd-session[1930]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:56:56.800196 systemd-logind[1399]: New session 11 of user core. Jul 10 23:56:56.807246 systemd[1]: Started session-11.scope - Session 11 of User core. Jul 10 23:56:56.861819 sshd[1932]: Connection closed by 10.0.0.1 port 57010 Jul 10 23:56:56.862049 sshd-session[1930]: pam_unix(sshd:session): session closed for user core Jul 10 23:56:56.865379 systemd[1]: sshd@10-10.0.0.110:22-10.0.0.1:57010.service: Deactivated successfully. Jul 10 23:56:56.866852 systemd[1]: session-11.scope: Deactivated successfully. Jul 10 23:56:56.867595 systemd-logind[1399]: Session 11 logged out. Waiting for processes to exit. Jul 10 23:56:56.870784 systemd-logind[1399]: Removed session 11. Jul 10 23:56:57.590191 systemd-networkd[1382]: docker0: Gained IPv6LL Jul 10 23:56:57.718188 systemd-networkd[1382]: vethec10d1e: Gained IPv6LL Jul 10 23:57:01.997699 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Jul 10 23:57:01.998090 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 10 23:57:01.998798 dockerd[1631]: time="2025-07-10T23:57:01.998102468Z" level=info msg="Processing signal 'terminated'" Jul 10 23:57:02.917730 systemd[1]: Started sshd@11-10.0.0.110:22-10.0.0.1:38588.service - OpenSSH per-connection server daemon (10.0.0.1:38588). Jul 10 23:57:02.956304 sshd[1938]: Accepted publickey for core from 10.0.0.1 port 38588 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:02.957572 sshd-session[1938]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:02.961510 systemd-logind[1399]: New session 12 of user core. Jul 10 23:57:02.973406 systemd[1]: Started session-12.scope - Session 12 of User core. Jul 10 23:57:03.026743 sshd[1940]: Connection closed by 10.0.0.1 port 38588 Jul 10 23:57:03.027032 sshd-session[1938]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:03.030122 systemd[1]: sshd@11-10.0.0.110:22-10.0.0.1:38588.service: Deactivated successfully. Jul 10 23:57:03.031537 systemd[1]: session-12.scope: Deactivated successfully. Jul 10 23:57:03.033619 systemd-logind[1399]: Session 12 logged out. Waiting for processes to exit. Jul 10 23:57:03.034856 systemd-logind[1399]: Removed session 12. Jul 10 23:57:03.998682 dockerd[1631]: time="2025-07-10T23:57:03.998617178Z" level=error msg="Error sending stop (signal 15) to container" container=41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41 error="Cannot kill container 41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" Jul 10 23:57:03.998682 dockerd[1631]: time="2025-07-10T23:57:03.998670212Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41 Jul 10 23:57:09.061686 systemd[1]: Started sshd@12-10.0.0.110:22-10.0.0.1:38616.service - OpenSSH per-connection server daemon (10.0.0.1:38616). Jul 10 23:57:09.099604 sshd[1946]: Accepted publickey for core from 10.0.0.1 port 38616 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:09.100713 sshd-session[1946]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:09.104824 systemd-logind[1399]: New session 13 of user core. Jul 10 23:57:09.113204 systemd[1]: Started session-13.scope - Session 13 of User core. Jul 10 23:57:09.166272 sshd[1948]: Connection closed by 10.0.0.1 port 38616 Jul 10 23:57:09.166543 sshd-session[1946]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:09.169170 systemd[1]: sshd@12-10.0.0.110:22-10.0.0.1:38616.service: Deactivated successfully. Jul 10 23:57:09.170583 systemd[1]: session-13.scope: Deactivated successfully. Jul 10 23:57:09.173288 systemd-logind[1399]: Session 13 logged out. Waiting for processes to exit. Jul 10 23:57:09.174448 systemd-logind[1399]: Removed session 13. Jul 10 23:57:14.000389 dockerd[1631]: time="2025-07-10T23:57:14.000143724Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41 error="context deadline exceeded" Jul 10 23:57:14.000724 systemd[1]: docker-41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41.scope: Deactivated successfully. Jul 10 23:57:15.191758 systemd[1]: Started sshd@13-10.0.0.110:22-10.0.0.1:53520.service - OpenSSH per-connection server daemon (10.0.0.1:53520). Jul 10 23:57:15.230191 sshd[1954]: Accepted publickey for core from 10.0.0.1 port 53520 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:15.231547 sshd-session[1954]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:15.236488 systemd-logind[1399]: New session 14 of user core. Jul 10 23:57:15.246229 systemd[1]: Started session-14.scope - Session 14 of User core. Jul 10 23:57:15.299722 sshd[1956]: Connection closed by 10.0.0.1 port 53520 Jul 10 23:57:15.300221 sshd-session[1954]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:15.303965 systemd[1]: sshd@13-10.0.0.110:22-10.0.0.1:53520.service: Deactivated successfully. Jul 10 23:57:15.305557 systemd[1]: session-14.scope: Deactivated successfully. Jul 10 23:57:15.306227 systemd-logind[1399]: Session 14 logged out. Waiting for processes to exit. Jul 10 23:57:15.307211 systemd-logind[1399]: Removed session 14. Jul 10 23:57:16.998949 dockerd[1631]: time="2025-07-10T23:57:16.998884465Z" level=error msg="Force shutdown daemon" Jul 10 23:57:16.999313 dockerd[1631]: time="2025-07-10T23:57:16.999121249Z" level=info msg="Daemon shutdown complete" Jul 10 23:57:17.002495 systemd[1]: docker.service: Deactivated successfully. Jul 10 23:57:17.002809 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 10 23:57:17.002876 systemd[1]: docker.service: Consumed 809ms CPU time, 131.2M memory peak. Jul 10 23:57:17.003301 systemd[1]: docker.socket: Deactivated successfully. Jul 10 23:57:17.004176 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 10 23:57:17.004251 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 10 23:57:17.005716 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 10 23:57:17.005882 systemd[1]: containerd.service: Found left-over process 1861 (containerd-shim) in control group while starting unit. Ignoring. Jul 10 23:57:17.005891 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 10 23:57:17.020441 systemd[1]: Starting containerd.service - containerd container runtime... Jul 10 23:57:17.020994 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 10 23:57:17.031430 systemd[1]: containerd.service: Found left-over process 1861 (containerd-shim) in control group while starting unit. Ignoring. Jul 10 23:57:17.031442 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 10 23:57:17.035216 (ntainerd)[1967]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 10 23:57:17.046951 containerd[1967]: time="2025-07-10T23:57:17Z" 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 Jul 10 23:57:17.047377 containerd[1967]: time="2025-07-10T23:57:17.047344176Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 10 23:57:17.055042 containerd[1967]: time="2025-07-10T23:57:17.054995315Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.366µs" Jul 10 23:57:17.055042 containerd[1967]: time="2025-07-10T23:57:17.055034862Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 10 23:57:17.055129 containerd[1967]: time="2025-07-10T23:57:17.055064723Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 10 23:57:17.055129 containerd[1967]: time="2025-07-10T23:57:17.055101988Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 10 23:57:17.055129 containerd[1967]: time="2025-07-10T23:57:17.055113276Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 10 23:57:17.055325 containerd[1967]: time="2025-07-10T23:57:17.055293359Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055352 containerd[1967]: time="2025-07-10T23:57:17.055326221Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055352 containerd[1967]: time="2025-07-10T23:57:17.055336348Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055542 containerd[1967]: time="2025-07-10T23:57:17.055515430Z" 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 Jul 10 23:57:17.055542 containerd[1967]: time="2025-07-10T23:57:17.055535163Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055585 containerd[1967]: time="2025-07-10T23:57:17.055546771Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055585 containerd[1967]: time="2025-07-10T23:57:17.055554457Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055585 containerd[1967]: time="2025-07-10T23:57:17.055580434Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055691 containerd[1967]: time="2025-07-10T23:57:17.055669975Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 10 23:57:17.055715 containerd[1967]: time="2025-07-10T23:57:17.055701917Z" 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 Jul 10 23:57:17.055715 containerd[1967]: time="2025-07-10T23:57:17.055711884Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 10 23:57:17.055754 containerd[1967]: time="2025-07-10T23:57:17.055744786Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 10 23:57:17.055952 containerd[1967]: time="2025-07-10T23:57:17.055932154Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 10 23:57:17.055973 containerd[1967]: time="2025-07-10T23:57:17.055955130Z" level=info msg="metadata content store policy set" policy=shared Jul 10 23:57:17.056098 containerd[1967]: time="2025-07-10T23:57:17.056080295Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 10 23:57:17.056123 containerd[1967]: time="2025-07-10T23:57:17.056112477Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 10 23:57:17.056141 containerd[1967]: time="2025-07-10T23:57:17.056124606Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 10 23:57:17.056141 containerd[1967]: time="2025-07-10T23:57:17.056135373Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 10 23:57:17.056182 containerd[1967]: time="2025-07-10T23:57:17.056152385Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 10 23:57:17.056182 containerd[1967]: time="2025-07-10T23:57:17.056164193Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 10 23:57:17.056182 containerd[1967]: time="2025-07-10T23:57:17.056174680Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 10 23:57:17.056231 containerd[1967]: time="2025-07-10T23:57:17.056185727Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 10 23:57:17.056231 containerd[1967]: time="2025-07-10T23:57:17.056198736Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 10 23:57:17.056231 containerd[1967]: time="2025-07-10T23:57:17.056208143Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 10 23:57:17.056231 containerd[1967]: time="2025-07-10T23:57:17.056216949Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 10 23:57:17.056231 containerd[1967]: time="2025-07-10T23:57:17.056228036Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 10 23:57:17.056467 containerd[1967]: time="2025-07-10T23:57:17.056421488Z" level=info msg="connecting to shim 41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41" address="unix:///run/containerd/s/6df6ef60beba98f018b25ac3d8c43817daeff08d65853cbabe0efcf04fe88000" namespace=moby protocol=ttrpc version=3 Jul 10 23:57:17.062889 containerd[1967]: time="2025-07-10T23:57:17.062857599Z" level=info msg="cleaning leaked shim process" id=41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41 namespace=moby Jul 10 23:57:17.070912 containerd[1967]: time="2025-07-10T23:57:17.070850932Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 10 23:57:17.071274 containerd[1967]: time="2025-07-10T23:57:17.071248483Z" level=info msg="shim disconnected" id=41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41 namespace=moby Jul 10 23:57:17.071313 containerd[1967]: time="2025-07-10T23:57:17.071275021Z" level=warning msg="cleaning up after shim disconnected" id=41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41 namespace=moby Jul 10 23:57:17.071343 containerd[1967]: time="2025-07-10T23:57:17.071312447Z" level=info msg="cleaning up dead shim" namespace=moby Jul 10 23:57:17.079800 containerd[1967]: time="2025-07-10T23:57:17.079723985Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jul 10 23:57:17.079936 containerd[1967]: time="2025-07-10T23:57:17.079898464Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 10 23:57:17.079978 containerd[1967]: time="2025-07-10T23:57:17.079943135Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 10 23:57:17.079978 containerd[1967]: time="2025-07-10T23:57:17.079961547Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 10 23:57:17.079978 containerd[1967]: time="2025-07-10T23:57:17.079973315Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 10 23:57:17.080035 containerd[1967]: time="2025-07-10T23:57:17.079983963Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 10 23:57:17.080035 containerd[1967]: time="2025-07-10T23:57:17.079995691Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 10 23:57:17.080035 containerd[1967]: time="2025-07-10T23:57:17.080008179Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 10 23:57:17.080035 containerd[1967]: time="2025-07-10T23:57:17.080018626Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 10 23:57:17.080035 containerd[1967]: time="2025-07-10T23:57:17.080031795Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 10 23:57:17.080139 containerd[1967]: time="2025-07-10T23:57:17.080043043Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 10 23:57:17.080139 containerd[1967]: time="2025-07-10T23:57:17.080071462Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 10 23:57:17.080139 containerd[1967]: time="2025-07-10T23:57:17.080136307Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 10 23:57:17.080197 containerd[1967]: time="2025-07-10T23:57:17.080151757Z" level=info msg="Start snapshots syncer" Jul 10 23:57:17.080197 containerd[1967]: time="2025-07-10T23:57:17.080179296Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 10 23:57:17.080422 containerd[1967]: time="2025-07-10T23:57:17.080375190Z" 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\"}" Jul 10 23:57:17.080514 containerd[1967]: time="2025-07-10T23:57:17.080421901Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 10 23:57:17.080514 containerd[1967]: time="2025-07-10T23:57:17.080501075Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 10 23:57:17.080566 containerd[1967]: time="2025-07-10T23:57:17.080546907Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 10 23:57:17.080586 containerd[1967]: time="2025-07-10T23:57:17.080565279Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 10 23:57:17.080586 containerd[1967]: time="2025-07-10T23:57:17.080575446Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 10 23:57:17.080629 containerd[1967]: time="2025-07-10T23:57:17.080585053Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 10 23:57:17.080629 containerd[1967]: time="2025-07-10T23:57:17.080597101Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 10 23:57:17.080629 containerd[1967]: time="2025-07-10T23:57:17.080607908Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 10 23:57:17.080706 containerd[1967]: time="2025-07-10T23:57:17.080632205Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 10 23:57:17.080706 containerd[1967]: time="2025-07-10T23:57:17.080657142Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 10 23:57:17.080706 containerd[1967]: time="2025-07-10T23:57:17.080667909Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 10 23:57:17.080706 containerd[1967]: time="2025-07-10T23:57:17.080678356Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 10 23:57:17.080774 containerd[1967]: time="2025-07-10T23:57:17.080714301Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 10 23:57:17.080774 containerd[1967]: time="2025-07-10T23:57:17.080730472Z" 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 Jul 10 23:57:17.080774 containerd[1967]: time="2025-07-10T23:57:17.080738037Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 23:57:17.080774 containerd[1967]: time="2025-07-10T23:57:17.080752527Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 23:57:17.080774 containerd[1967]: time="2025-07-10T23:57:17.080760492Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 10 23:57:17.080774 containerd[1967]: time="2025-07-10T23:57:17.080771580Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 10 23:57:17.080870 containerd[1967]: time="2025-07-10T23:57:17.080781907Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 10 23:57:17.080870 containerd[1967]: time="2025-07-10T23:57:17.080797678Z" level=info msg="runtime interface created" Jul 10 23:57:17.080870 containerd[1967]: time="2025-07-10T23:57:17.080802841Z" level=info msg="created NRI interface" Jul 10 23:57:17.080870 containerd[1967]: time="2025-07-10T23:57:17.080810326Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 10 23:57:17.080870 containerd[1967]: time="2025-07-10T23:57:17.080820333Z" level=info msg="Connect containerd service" Jul 10 23:57:17.080870 containerd[1967]: time="2025-07-10T23:57:17.080845630Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 10 23:57:17.081406 containerd[1967]: time="2025-07-10T23:57:17.081370188Z" 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" Jul 10 23:57:17.089363 containerd[1967]: time="2025-07-10T23:57:17.089299878Z" level=info msg="Start subscribing containerd event" Jul 10 23:57:17.089363 containerd[1967]: time="2025-07-10T23:57:17.089356837Z" level=info msg="Start recovering state" Jul 10 23:57:17.089481 containerd[1967]: time="2025-07-10T23:57:17.089429486Z" level=info msg="Start event monitor" Jul 10 23:57:17.089481 containerd[1967]: time="2025-07-10T23:57:17.089440414Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 10 23:57:17.089524 containerd[1967]: time="2025-07-10T23:57:17.089483884Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 10 23:57:17.089524 containerd[1967]: time="2025-07-10T23:57:17.089443456Z" level=info msg="Start cni network conf syncer for default" Jul 10 23:57:17.089524 containerd[1967]: time="2025-07-10T23:57:17.089506299Z" level=info msg="Start streaming server" Jul 10 23:57:17.089524 containerd[1967]: time="2025-07-10T23:57:17.089514144Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 10 23:57:17.089524 containerd[1967]: time="2025-07-10T23:57:17.089520308Z" level=info msg="runtime interface starting up..." Jul 10 23:57:17.089524 containerd[1967]: time="2025-07-10T23:57:17.089525392Z" level=info msg="starting plugins..." Jul 10 23:57:17.089624 containerd[1967]: time="2025-07-10T23:57:17.089534398Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 10 23:57:17.089649 containerd[1967]: time="2025-07-10T23:57:17.089628742Z" level=info msg="containerd successfully booted in 0.042832s" Jul 10 23:57:17.089721 systemd[1]: Started containerd.service - containerd container runtime. Jul 10 23:57:17.091354 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 10 23:57:17.102333 (dockerd)[2016]: 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 Jul 10 23:57:17.125038 dockerd[2016]: time="2025-07-10T23:57:17.124985783Z" level=info msg="Starting up" Jul 10 23:57:17.125507 dockerd[2016]: time="2025-07-10T23:57:17.125489247Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 10 23:57:17.151204 dockerd[2016]: time="2025-07-10T23:57:17.151158559Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 10 23:57:17.159957 dockerd[2016]: time="2025-07-10T23:57:17.159908088Z" level=info msg="Loading containers: start." Jul 10 23:57:17.169807 systemd[1]: var-lib-docker-overlay2-9dc5008c44d3e6d3af5d3472e9402ad714aaffeeacdaf0dfe441882883e2542a-merged.mount: Deactivated successfully. Jul 10 23:57:17.519141 kernel: docker0: port 1(vethec10d1e) entered disabled state Jul 10 23:57:17.519258 kernel: vethec10d1e (unregistering): left allmulticast mode Jul 10 23:57:17.519128 systemd-networkd[1382]: vethec10d1e: Link DOWN Jul 10 23:57:17.519132 systemd-networkd[1382]: vethec10d1e: Lost carrier Jul 10 23:57:17.520083 kernel: vethec10d1e (unregistering): left promiscuous mode Jul 10 23:57:17.520124 kernel: docker0: port 1(vethec10d1e) entered disabled state Jul 10 23:57:17.521440 systemd-networkd[1382]: docker0: Lost carrier Jul 10 23:57:17.522172 dockerd[2016]: time="2025-07-10T23:57:17.522144428Z" level=info msg="Removing stale sandbox deb0dc143490f8cf19d69f73185a66642c279443540e3f4830699dbfb211238d (41cce5c5279f8c508ea20dd32765524f1cb82d57c83e61e0cb701d669ae26c41)" Jul 10 23:57:17.525313 dockerd[2016]: time="2025-07-10T23:57:17.525273992Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 10 23:57:17.525385 dockerd[2016]: time="2025-07-10T23:57:17.525323511Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 7c0e53757ad0cfb54b1c8415de32df5410de7b0274a7e89ed37b1e9c04f8fa11 d201735c0d0ebae64ad92263ba95187386e6d27bceedc07adff447b54c133704], retrying...." Jul 10 23:57:17.680181 dockerd[2016]: time="2025-07-10T23:57:17.680127148Z" level=warning msg="error locating sandbox id deb0dc143490f8cf19d69f73185a66642c279443540e3f4830699dbfb211238d: sandbox deb0dc143490f8cf19d69f73185a66642c279443540e3f4830699dbfb211238d not found" Jul 10 23:57:17.680293 dockerd[2016]: time="2025-07-10T23:57:17.680238635Z" level=info msg="Loading containers: done." Jul 10 23:57:17.690025 dockerd[2016]: time="2025-07-10T23:57:17.689961309Z" 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 Jul 10 23:57:17.690181 dockerd[2016]: time="2025-07-10T23:57:17.690047777Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 10 23:57:17.690181 dockerd[2016]: time="2025-07-10T23:57:17.690112627Z" level=info msg="Initializing buildkit" Jul 10 23:57:17.703454 dockerd[2016]: time="2025-07-10T23:57:17.703344002Z" level=info msg="Completed buildkit initialization" Jul 10 23:57:17.711633 dockerd[2016]: time="2025-07-10T23:57:17.711589923Z" level=info msg="Daemon has completed initialization" Jul 10 23:57:17.711708 dockerd[2016]: time="2025-07-10T23:57:17.711651932Z" level=info msg="API listen on /run/docker.sock" Jul 10 23:57:17.711799 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 10 23:57:18.141163 systemd[1]: run-docker-netns-deb0dc143490.mount: Deactivated successfully. Jul 10 23:57:21.327368 systemd[1]: Started sshd@14-10.0.0.110:22-10.0.0.1:53558.service - OpenSSH per-connection server daemon (10.0.0.1:53558). Jul 10 23:57:21.383166 sshd[2237]: Accepted publickey for core from 10.0.0.1 port 53558 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:21.384322 sshd-session[2237]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:21.387977 systemd-logind[1399]: New session 15 of user core. Jul 10 23:57:21.408246 systemd[1]: Started session-15.scope - Session 15 of User core. Jul 10 23:57:21.461348 sshd[2239]: Connection closed by 10.0.0.1 port 53558 Jul 10 23:57:21.461884 sshd-session[2237]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:21.476284 systemd[1]: sshd@14-10.0.0.110:22-10.0.0.1:53558.service: Deactivated successfully. Jul 10 23:57:21.477693 systemd[1]: session-15.scope: Deactivated successfully. Jul 10 23:57:21.478424 systemd-logind[1399]: Session 15 logged out. Waiting for processes to exit. Jul 10 23:57:21.481701 systemd[1]: Started sshd@15-10.0.0.110:22-10.0.0.1:53560.service - OpenSSH per-connection server daemon (10.0.0.1:53560). Jul 10 23:57:21.482178 systemd-logind[1399]: Removed session 15. Jul 10 23:57:21.526406 sshd[2245]: Accepted publickey for core from 10.0.0.1 port 53560 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:21.527698 sshd-session[2245]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:21.532096 systemd-logind[1399]: New session 16 of user core. Jul 10 23:57:21.543227 systemd[1]: Started session-16.scope - Session 16 of User core. Jul 10 23:57:21.594982 sshd[2247]: Connection closed by 10.0.0.1 port 53560 Jul 10 23:57:21.595488 sshd-session[2245]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:21.606178 systemd[1]: sshd@15-10.0.0.110:22-10.0.0.1:53560.service: Deactivated successfully. Jul 10 23:57:21.607568 systemd[1]: session-16.scope: Deactivated successfully. Jul 10 23:57:21.609536 systemd-logind[1399]: Session 16 logged out. Waiting for processes to exit. Jul 10 23:57:21.611788 systemd[1]: Started sshd@16-10.0.0.110:22-10.0.0.1:53564.service - OpenSSH per-connection server daemon (10.0.0.1:53564). Jul 10 23:57:21.612444 systemd-logind[1399]: Removed session 16. Jul 10 23:57:21.669555 sshd[2253]: Accepted publickey for core from 10.0.0.1 port 53564 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:21.670769 sshd-session[2253]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:21.674997 systemd-logind[1399]: New session 17 of user core. Jul 10 23:57:21.684203 systemd[1]: Started session-17.scope - Session 17 of User core. Jul 10 23:57:21.740660 sshd[2255]: Connection closed by 10.0.0.1 port 53564 Jul 10 23:57:21.741011 sshd-session[2253]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:21.753566 systemd[1]: sshd@16-10.0.0.110:22-10.0.0.1:53564.service: Deactivated successfully. Jul 10 23:57:21.756355 systemd[1]: session-17.scope: Deactivated successfully. Jul 10 23:57:21.757117 systemd-logind[1399]: Session 17 logged out. Waiting for processes to exit. Jul 10 23:57:21.759166 systemd[1]: Started sshd@17-10.0.0.110:22-10.0.0.1:53578.service - OpenSSH per-connection server daemon (10.0.0.1:53578). Jul 10 23:57:21.760479 systemd-logind[1399]: Removed session 17. Jul 10 23:57:21.807516 sshd[2268]: Accepted publickey for core from 10.0.0.1 port 53578 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:21.808743 sshd-session[2268]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:21.813105 systemd-logind[1399]: New session 18 of user core. Jul 10 23:57:21.825214 systemd[1]: Started session-18.scope - Session 18 of User core. Jul 10 23:57:21.892125 systemd[1]: var-lib-docker-overlay2-5fb080abf8790a2678e13fd795dc585956d0aca308ec35721afe0b7d2988b7d6\x2dinit-merged.mount: Deactivated successfully. Jul 10 23:57:21.928348 containerd[1967]: time="2025-07-10T23:57:21.928286797Z" level=info msg="connecting to shim dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8" address="unix:///run/containerd/s/da53949c8435a4f46e63cc0ba96ca9a4fd01e1920b78bb332e4edb6535bb036d" namespace=moby protocol=ttrpc version=3 Jul 10 23:57:21.959251 systemd[1]: Started docker-dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8.scope - libcontainer container dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8. Jul 10 23:57:21.969927 systemd-resolved[1297]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 23:57:21.984742 kernel: docker0: port 1(veth607d134) entered blocking state Jul 10 23:57:21.984836 kernel: docker0: port 1(veth607d134) entered disabled state Jul 10 23:57:21.984859 kernel: veth607d134: entered allmulticast mode Jul 10 23:57:21.984874 kernel: veth607d134: entered promiscuous mode Jul 10 23:57:21.985281 systemd-networkd[1382]: veth607d134: Link UP Jul 10 23:57:21.992082 kernel: eth0: renamed from veth8c1c163 Jul 10 23:57:21.993345 kernel: docker0: port 1(veth607d134) entered blocking state Jul 10 23:57:21.993393 kernel: docker0: port 1(veth607d134) entered forwarding state Jul 10 23:57:21.993678 systemd-networkd[1382]: veth607d134: Gained carrier Jul 10 23:57:21.994158 systemd-networkd[1382]: docker0: Gained carrier Jul 10 23:57:22.012792 sshd[2270]: Connection closed by 10.0.0.1 port 53578 Jul 10 23:57:22.013297 sshd-session[2268]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:22.028989 systemd[1]: sshd@17-10.0.0.110:22-10.0.0.1:53578.service: Deactivated successfully. Jul 10 23:57:22.032494 systemd[1]: session-18.scope: Deactivated successfully. Jul 10 23:57:22.033315 systemd-logind[1399]: Session 18 logged out. Waiting for processes to exit. Jul 10 23:57:22.036382 systemd[1]: Started sshd@18-10.0.0.110:22-10.0.0.1:53580.service - OpenSSH per-connection server daemon (10.0.0.1:53580). Jul 10 23:57:22.037134 systemd-logind[1399]: Removed session 18. Jul 10 23:57:22.092555 sshd[2342]: Accepted publickey for core from 10.0.0.1 port 53580 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:22.093912 sshd-session[2342]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:22.098687 systemd-logind[1399]: New session 19 of user core. Jul 10 23:57:22.110254 systemd[1]: Started session-19.scope - Session 19 of User core. Jul 10 23:57:22.165444 sshd[2344]: Connection closed by 10.0.0.1 port 53580 Jul 10 23:57:22.165914 sshd-session[2342]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:22.175306 systemd[1]: sshd@18-10.0.0.110:22-10.0.0.1:53580.service: Deactivated successfully. Jul 10 23:57:22.176802 systemd[1]: session-19.scope: Deactivated successfully. Jul 10 23:57:22.178563 systemd-logind[1399]: Session 19 logged out. Waiting for processes to exit. Jul 10 23:57:22.181299 systemd[1]: Started sshd@19-10.0.0.110:22-10.0.0.1:53596.service - OpenSSH per-connection server daemon (10.0.0.1:53596). Jul 10 23:57:22.181832 systemd-logind[1399]: Removed session 19. Jul 10 23:57:22.219572 sshd[2350]: Accepted publickey for core from 10.0.0.1 port 53596 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:22.220715 sshd-session[2350]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:22.225033 systemd-logind[1399]: New session 20 of user core. Jul 10 23:57:22.233222 systemd[1]: Started session-20.scope - Session 20 of User core. Jul 10 23:57:22.284609 sudo[2353]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1967 Jul 10 23:57:22.285422 sudo[2353]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 23:57:22.289339 sudo[2353]: pam_unix(sudo:session): session closed for user root Jul 10 23:57:22.290656 sshd[2352]: Connection closed by 10.0.0.1 port 53596 Jul 10 23:57:22.292578 dockerd[2016]: time="2025-07-10T23:57:22.291511170Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 10 23:57:22.292578 dockerd[2016]: time="2025-07-10T23:57:22.291547236Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 10 23:57:22.292578 dockerd[2016]: time="2025-07-10T23:57:22.292189852Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 10 23:57:22.292578 dockerd[2016]: time="2025-07-10T23:57:22.292215911Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 10 23:57:22.291935 sshd-session[2350]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:22.303250 systemd[1]: containerd.service: Deactivated successfully. Jul 10 23:57:22.303377 systemd[1]: containerd.service: Unit process 2292 (containerd-shim) remains running after unit stopped. Jul 10 23:57:22.303605 systemd[1]: containerd.service: Consumed 141ms CPU time, 135.1M memory peak. Jul 10 23:57:22.304296 systemd[1]: sshd@19-10.0.0.110:22-10.0.0.1:53596.service: Deactivated successfully. Jul 10 23:57:22.305941 systemd[1]: session-20.scope: Deactivated successfully. Jul 10 23:57:22.306853 systemd-logind[1399]: Session 20 logged out. Waiting for processes to exit. Jul 10 23:57:22.310953 systemd[1]: Started sshd@20-10.0.0.110:22-10.0.0.1:53598.service - OpenSSH per-connection server daemon (10.0.0.1:53598). Jul 10 23:57:22.311504 systemd-logind[1399]: Removed session 20. Jul 10 23:57:22.376176 sshd[2360]: Accepted publickey for core from 10.0.0.1 port 53598 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:22.378045 sshd-session[2360]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:22.382489 systemd-logind[1399]: New session 21 of user core. Jul 10 23:57:22.394242 systemd[1]: Started session-21.scope - Session 21 of User core. Jul 10 23:57:22.450001 sshd[2362]: Connection closed by 10.0.0.1 port 53598 Jul 10 23:57:22.450618 sshd-session[2360]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:22.455485 systemd[1]: sshd@20-10.0.0.110:22-10.0.0.1:53598.service: Deactivated successfully. Jul 10 23:57:22.459177 systemd[1]: session-21.scope: Deactivated successfully. Jul 10 23:57:22.460823 systemd-logind[1399]: Session 21 logged out. Waiting for processes to exit. Jul 10 23:57:22.462811 systemd-logind[1399]: Removed session 21. Jul 10 23:57:23.126279 systemd-networkd[1382]: veth607d134: Gained IPv6LL Jul 10 23:57:27.529516 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Jul 10 23:57:27.529997 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 10 23:57:27.530617 dockerd[2016]: time="2025-07-10T23:57:27.529939003Z" level=info msg="Processing signal 'terminated'" Jul 10 23:57:28.469363 systemd[1]: Started sshd@21-10.0.0.110:22-10.0.0.1:46428.service - OpenSSH per-connection server daemon (10.0.0.1:46428). Jul 10 23:57:28.508709 sshd[2368]: Accepted publickey for core from 10.0.0.1 port 46428 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:28.510072 sshd-session[2368]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:28.514787 systemd-logind[1399]: New session 22 of user core. Jul 10 23:57:28.524245 systemd[1]: Started session-22.scope - Session 22 of User core. Jul 10 23:57:28.578273 sshd[2370]: Connection closed by 10.0.0.1 port 46428 Jul 10 23:57:28.578567 sshd-session[2368]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:28.581755 systemd-logind[1399]: Session 22 logged out. Waiting for processes to exit. Jul 10 23:57:28.581912 systemd[1]: sshd@21-10.0.0.110:22-10.0.0.1:46428.service: Deactivated successfully. Jul 10 23:57:28.583314 systemd[1]: session-22.scope: Deactivated successfully. Jul 10 23:57:28.584821 systemd-logind[1399]: Removed session 22. Jul 10 23:57:29.532152 dockerd[2016]: time="2025-07-10T23:57:29.532035274Z" level=error msg="Error sending stop (signal 15) to container" container=dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8 error="Cannot kill container dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Jul 10 23:57:29.532152 dockerd[2016]: time="2025-07-10T23:57:29.532138404Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8 Jul 10 23:57:30.464543 update_engine[1406]: I20250710 23:57:30.464440 1406 update_attempter.cc:509] Updating boot flags... Jul 10 23:57:34.604812 systemd[1]: Started sshd@22-10.0.0.110:22-10.0.0.1:38160.service - OpenSSH per-connection server daemon (10.0.0.1:38160). Jul 10 23:57:34.666606 sshd[2392]: Accepted publickey for core from 10.0.0.1 port 38160 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:34.667970 sshd-session[2392]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:34.671757 systemd-logind[1399]: New session 23 of user core. Jul 10 23:57:34.685291 systemd[1]: Started session-23.scope - Session 23 of User core. Jul 10 23:57:34.738412 sshd[2394]: Connection closed by 10.0.0.1 port 38160 Jul 10 23:57:34.738715 sshd-session[2392]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:34.742045 systemd[1]: sshd@22-10.0.0.110:22-10.0.0.1:38160.service: Deactivated successfully. Jul 10 23:57:34.743629 systemd[1]: session-23.scope: Deactivated successfully. Jul 10 23:57:34.744363 systemd-logind[1399]: Session 23 logged out. Waiting for processes to exit. Jul 10 23:57:34.746508 systemd-logind[1399]: Removed session 23. Jul 10 23:57:39.533351 dockerd[2016]: time="2025-07-10T23:57:39.533277369Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8 error="context deadline exceeded" Jul 10 23:57:39.534563 systemd[1]: docker-dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8.scope: Deactivated successfully. Jul 10 23:57:40.756335 systemd[1]: Started sshd@23-10.0.0.110:22-10.0.0.1:38170.service - OpenSSH per-connection server daemon (10.0.0.1:38170). Jul 10 23:57:40.802623 sshd[2400]: Accepted publickey for core from 10.0.0.1 port 38170 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:40.803804 sshd-session[2400]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:40.807556 systemd-logind[1399]: New session 24 of user core. Jul 10 23:57:40.817287 systemd[1]: Started session-24.scope - Session 24 of User core. Jul 10 23:57:40.869929 sshd[2402]: Connection closed by 10.0.0.1 port 38170 Jul 10 23:57:40.870417 sshd-session[2400]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:40.873573 systemd[1]: sshd@23-10.0.0.110:22-10.0.0.1:38170.service: Deactivated successfully. Jul 10 23:57:40.875230 systemd[1]: session-24.scope: Deactivated successfully. Jul 10 23:57:40.876070 systemd-logind[1399]: Session 24 logged out. Waiting for processes to exit. Jul 10 23:57:40.877366 systemd-logind[1399]: Removed session 24. Jul 10 23:57:42.530447 dockerd[2016]: time="2025-07-10T23:57:42.530382105Z" level=error msg="Force shutdown daemon" Jul 10 23:57:42.530829 dockerd[2016]: time="2025-07-10T23:57:42.530507298Z" level=info msg="Daemon shutdown complete" Jul 10 23:57:42.534640 systemd[1]: docker.service: Deactivated successfully. Jul 10 23:57:42.534964 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 10 23:57:42.535866 systemd[1]: docker.socket: Deactivated successfully. Jul 10 23:57:42.536375 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 10 23:57:42.536409 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 10 23:57:42.541724 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 10 23:57:42.541893 systemd[1]: containerd.service: Found left-over process 2292 (containerd-shim) in control group while starting unit. Ignoring. Jul 10 23:57:42.541895 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 10 23:57:42.547398 systemd[1]: Starting containerd.service - containerd container runtime... Jul 10 23:57:42.548192 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 10 23:57:42.557268 systemd[1]: containerd.service: Found left-over process 2292 (containerd-shim) in control group while starting unit. Ignoring. Jul 10 23:57:42.557271 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 10 23:57:42.560864 (ntainerd)[2413]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 10 23:57:42.573267 containerd[2413]: time="2025-07-10T23:57:42Z" 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 Jul 10 23:57:42.573648 containerd[2413]: time="2025-07-10T23:57:42.573608619Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 10 23:57:42.585681 containerd[2413]: time="2025-07-10T23:57:42.585635674Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.883µs" Jul 10 23:57:42.585681 containerd[2413]: time="2025-07-10T23:57:42.585673964Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 10 23:57:42.585798 containerd[2413]: time="2025-07-10T23:57:42.585693049Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 10 23:57:42.585798 containerd[2413]: time="2025-07-10T23:57:42.585734581Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 10 23:57:42.585798 containerd[2413]: time="2025-07-10T23:57:42.585750905Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 10 23:57:42.585965 containerd[2413]: time="2025-07-10T23:57:42.585934314Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 23:57:42.585989 containerd[2413]: time="2025-07-10T23:57:42.585967483Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 23:57:42.585989 containerd[2413]: time="2025-07-10T23:57:42.585978366Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 10 23:57:42.586237 containerd[2413]: time="2025-07-10T23:57:42.586210428Z" 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 Jul 10 23:57:42.586237 containerd[2413]: time="2025-07-10T23:57:42.586230473Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 23:57:42.586296 containerd[2413]: time="2025-07-10T23:57:42.586243236Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 23:57:42.586296 containerd[2413]: time="2025-07-10T23:57:42.586251039Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 10 23:57:42.586296 containerd[2413]: time="2025-07-10T23:57:42.586274205Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 10 23:57:42.586365 containerd[2413]: time="2025-07-10T23:57:42.586349625Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 10 23:57:42.586389 containerd[2413]: time="2025-07-10T23:57:42.586374832Z" 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 Jul 10 23:57:42.586389 containerd[2413]: time="2025-07-10T23:57:42.586384794Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 10 23:57:42.586428 containerd[2413]: time="2025-07-10T23:57:42.586412322Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 10 23:57:42.586633 containerd[2413]: time="2025-07-10T23:57:42.586611095Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 10 23:57:42.586676 containerd[2413]: time="2025-07-10T23:57:42.586635661Z" level=info msg="metadata content store policy set" policy=shared Jul 10 23:57:42.586775 containerd[2413]: time="2025-07-10T23:57:42.586750452Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 10 23:57:42.586806 containerd[2413]: time="2025-07-10T23:57:42.586790783Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 10 23:57:42.586824 containerd[2413]: time="2025-07-10T23:57:42.586808308Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 10 23:57:42.586824 containerd[2413]: time="2025-07-10T23:57:42.586821551Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 10 23:57:42.586864 containerd[2413]: time="2025-07-10T23:57:42.586832994Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 10 23:57:42.586864 containerd[2413]: time="2025-07-10T23:57:42.586849238Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 10 23:57:42.586864 containerd[2413]: time="2025-07-10T23:57:42.586860161Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 10 23:57:42.586965 containerd[2413]: time="2025-07-10T23:57:42.586871524Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 10 23:57:42.586965 containerd[2413]: time="2025-07-10T23:57:42.586881767Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 10 23:57:42.586965 containerd[2413]: time="2025-07-10T23:57:42.586891650Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 10 23:57:42.586965 containerd[2413]: time="2025-07-10T23:57:42.586900332Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 10 23:57:42.586965 containerd[2413]: time="2025-07-10T23:57:42.586912335Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 10 23:57:42.587145 containerd[2413]: time="2025-07-10T23:57:42.587123472Z" level=info msg="connecting to shim dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8" address="unix:///run/containerd/s/da53949c8435a4f46e63cc0ba96ca9a4fd01e1920b78bb332e4edb6535bb036d" namespace=moby protocol=ttrpc version=3 Jul 10 23:57:42.594098 containerd[2413]: time="2025-07-10T23:57:42.593533905Z" level=info msg="cleaning leaked shim process" id=dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8 namespace=moby Jul 10 23:57:42.603882 containerd[2413]: time="2025-07-10T23:57:42.603530938Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 10 23:57:42.604833 containerd[2413]: time="2025-07-10T23:57:42.604619669Z" level=info msg="shim disconnected" id=dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8 namespace=moby Jul 10 23:57:42.604833 containerd[2413]: time="2025-07-10T23:57:42.604771509Z" level=warning msg="cleaning up after shim disconnected" id=dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8 namespace=moby Jul 10 23:57:42.605442 containerd[2413]: time="2025-07-10T23:57:42.604944195Z" level=info msg="cleaning up dead shim" namespace=moby Jul 10 23:57:42.614482 containerd[2413]: time="2025-07-10T23:57:42.614311419Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jul 10 23:57:42.614574 containerd[2413]: time="2025-07-10T23:57:42.614481985Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 10 23:57:42.614574 containerd[2413]: time="2025-07-10T23:57:42.614520395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 10 23:57:42.614574 containerd[2413]: time="2025-07-10T23:57:42.614537080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 10 23:57:42.614574 containerd[2413]: time="2025-07-10T23:57:42.614549403Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 10 23:57:42.614574 containerd[2413]: time="2025-07-10T23:57:42.614561166Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 10 23:57:42.614673 containerd[2413]: time="2025-07-10T23:57:42.614595015Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 10 23:57:42.614673 containerd[2413]: time="2025-07-10T23:57:42.614608099Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 10 23:57:42.614673 containerd[2413]: time="2025-07-10T23:57:42.614620102Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 10 23:57:42.614673 containerd[2413]: time="2025-07-10T23:57:42.614632985Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 10 23:57:42.614673 containerd[2413]: time="2025-07-10T23:57:42.614645428Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 10 23:57:42.614673 containerd[2413]: time="2025-07-10T23:57:42.614656151Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 10 23:57:42.614803 containerd[2413]: time="2025-07-10T23:57:42.614718568Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 10 23:57:42.614803 containerd[2413]: time="2025-07-10T23:57:42.614733412Z" level=info msg="Start snapshots syncer" Jul 10 23:57:42.614803 containerd[2413]: time="2025-07-10T23:57:42.614773063Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 10 23:57:42.615038 containerd[2413]: time="2025-07-10T23:57:42.614992321Z" 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\"}" Jul 10 23:57:42.615143 containerd[2413]: time="2025-07-10T23:57:42.615047736Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 10 23:57:42.615166 containerd[2413]: time="2025-07-10T23:57:42.615142401Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 10 23:57:42.615216 containerd[2413]: time="2025-07-10T23:57:42.615187693Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 10 23:57:42.615216 containerd[2413]: time="2025-07-10T23:57:42.615211380Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 10 23:57:42.615266 containerd[2413]: time="2025-07-10T23:57:42.615222943Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 10 23:57:42.615266 containerd[2413]: time="2025-07-10T23:57:42.615232745Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 10 23:57:42.615266 containerd[2413]: time="2025-07-10T23:57:42.615244269Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 10 23:57:42.615266 containerd[2413]: time="2025-07-10T23:57:42.615255832Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 10 23:57:42.615339 containerd[2413]: time="2025-07-10T23:57:42.615271996Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 10 23:57:42.615339 containerd[2413]: time="2025-07-10T23:57:42.615298683Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 10 23:57:42.615339 containerd[2413]: time="2025-07-10T23:57:42.615309446Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 10 23:57:42.615339 containerd[2413]: time="2025-07-10T23:57:42.615321569Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 10 23:57:42.615412 containerd[2413]: time="2025-07-10T23:57:42.615356178Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 10 23:57:42.615412 containerd[2413]: time="2025-07-10T23:57:42.615370342Z" 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 Jul 10 23:57:42.615412 containerd[2413]: time="2025-07-10T23:57:42.615379225Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 23:57:42.615412 containerd[2413]: time="2025-07-10T23:57:42.615388787Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 23:57:42.615412 containerd[2413]: time="2025-07-10T23:57:42.615396269Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 10 23:57:42.615412 containerd[2413]: time="2025-07-10T23:57:42.615405112Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 10 23:57:42.615517 containerd[2413]: time="2025-07-10T23:57:42.615416715Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 10 23:57:42.615517 containerd[2413]: time="2025-07-10T23:57:42.615432479Z" level=info msg="runtime interface created" Jul 10 23:57:42.615517 containerd[2413]: time="2025-07-10T23:57:42.615437280Z" level=info msg="created NRI interface" Jul 10 23:57:42.615517 containerd[2413]: time="2025-07-10T23:57:42.615445202Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 10 23:57:42.615517 containerd[2413]: time="2025-07-10T23:57:42.615456085Z" level=info msg="Connect containerd service" Jul 10 23:57:42.615517 containerd[2413]: time="2025-07-10T23:57:42.615480532Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 10 23:57:42.616040 containerd[2413]: time="2025-07-10T23:57:42.615889321Z" 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" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624626496Z" level=info msg="Start subscribing containerd event" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624685152Z" level=info msg="Start recovering state" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624746409Z" level=info msg="Start event monitor" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624758772Z" level=info msg="Start cni network conf syncer for default" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624765974Z" level=info msg="Start streaming server" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624787700Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624796742Z" level=info msg="runtime interface starting up..." Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624802544Z" level=info msg="starting plugins..." Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.624810746Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.625045649Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.625119428Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 10 23:57:42.627818 containerd[2413]: time="2025-07-10T23:57:42.626148743Z" level=info msg="containerd successfully booted in 0.053040s" Jul 10 23:57:42.626247 systemd[1]: Started containerd.service - containerd container runtime. Jul 10 23:57:42.629715 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 10 23:57:42.640356 (dockerd)[2462]: 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 Jul 10 23:57:42.664247 dockerd[2462]: time="2025-07-10T23:57:42.664191993Z" level=info msg="Starting up" Jul 10 23:57:42.666202 dockerd[2462]: time="2025-07-10T23:57:42.666164840Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 10 23:57:42.698501 dockerd[2462]: time="2025-07-10T23:57:42.698452550Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 10 23:57:42.706061 dockerd[2462]: time="2025-07-10T23:57:42.705940352Z" level=info msg="Loading containers: start." Jul 10 23:57:42.722115 systemd[1]: var-lib-docker-overlay2-5fb080abf8790a2678e13fd795dc585956d0aca308ec35721afe0b7d2988b7d6-merged.mount: Deactivated successfully. Jul 10 23:57:43.090932 kernel: docker0: port 1(veth607d134) entered disabled state Jul 10 23:57:43.091033 kernel: veth607d134 (unregistering): left allmulticast mode Jul 10 23:57:43.091104 kernel: veth607d134 (unregistering): left promiscuous mode Jul 10 23:57:43.091129 kernel: docker0: port 1(veth607d134) entered disabled state Jul 10 23:57:43.090619 systemd-networkd[1382]: veth607d134: Link DOWN Jul 10 23:57:43.090622 systemd-networkd[1382]: veth607d134: Lost carrier Jul 10 23:57:43.100067 systemd-networkd[1382]: docker0: Lost carrier Jul 10 23:57:43.100839 dockerd[2462]: time="2025-07-10T23:57:43.100801251Z" level=info msg="Removing stale sandbox 1392a1c243f2c39a6e8d50999e2d888ff71f5bf7293550f1665b50dac9964222 (dc3f180cf89cedfdd8425c1614ca3430cdac8b3353b3399fba9b1494caeb06b8)" Jul 10 23:57:43.103419 dockerd[2462]: time="2025-07-10T23:57:43.103385475Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 10 23:57:43.103476 dockerd[2462]: time="2025-07-10T23:57:43.103431407Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 255fe5fa19f804cd316432b4d858095a95850bd8ee8211c9c22b9ac57f02b6f0 603f7d9e18580da2e4c0b0e90b9a99e2deb3c3f45503703080091a1581486d95], retrying...." Jul 10 23:57:43.273394 dockerd[2462]: time="2025-07-10T23:57:43.273336876Z" level=warning msg="error locating sandbox id deb0dc143490f8cf19d69f73185a66642c279443540e3f4830699dbfb211238d: sandbox deb0dc143490f8cf19d69f73185a66642c279443540e3f4830699dbfb211238d not found" Jul 10 23:57:43.273394 dockerd[2462]: time="2025-07-10T23:57:43.273383688Z" level=warning msg="error locating sandbox id 1392a1c243f2c39a6e8d50999e2d888ff71f5bf7293550f1665b50dac9964222: sandbox 1392a1c243f2c39a6e8d50999e2d888ff71f5bf7293550f1665b50dac9964222 not found" Jul 10 23:57:43.273529 dockerd[2462]: time="2025-07-10T23:57:43.273434141Z" level=info msg="Loading containers: done." Jul 10 23:57:43.283416 dockerd[2462]: time="2025-07-10T23:57:43.283348687Z" 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 Jul 10 23:57:43.283567 dockerd[2462]: time="2025-07-10T23:57:43.283436830Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 10 23:57:43.283567 dockerd[2462]: time="2025-07-10T23:57:43.283479121Z" level=info msg="Initializing buildkit" Jul 10 23:57:43.295481 dockerd[2462]: time="2025-07-10T23:57:43.295443873Z" level=info msg="Completed buildkit initialization" Jul 10 23:57:43.301931 dockerd[2462]: time="2025-07-10T23:57:43.301888128Z" level=info msg="Daemon has completed initialization" Jul 10 23:57:43.302465 dockerd[2462]: time="2025-07-10T23:57:43.301953625Z" level=info msg="API listen on /run/docker.sock" Jul 10 23:57:43.302140 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 10 23:57:43.686348 systemd[1]: run-docker-netns-1392a1c243f2.mount: Deactivated successfully. Jul 10 23:57:46.886966 systemd[1]: Started sshd@24-10.0.0.110:22-10.0.0.1:56222.service - OpenSSH per-connection server daemon (10.0.0.1:56222). Jul 10 23:57:46.932263 sshd[2683]: Accepted publickey for core from 10.0.0.1 port 56222 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:46.933695 sshd-session[2683]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:46.938825 systemd-logind[1399]: New session 25 of user core. Jul 10 23:57:46.950288 systemd[1]: Started session-25.scope - Session 25 of User core. Jul 10 23:57:47.003034 sshd[2685]: Connection closed by 10.0.0.1 port 56222 Jul 10 23:57:47.003545 sshd-session[2683]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:47.020521 systemd[1]: sshd@24-10.0.0.110:22-10.0.0.1:56222.service: Deactivated successfully. Jul 10 23:57:47.023688 systemd[1]: session-25.scope: Deactivated successfully. Jul 10 23:57:47.026792 systemd-logind[1399]: Session 25 logged out. Waiting for processes to exit. Jul 10 23:57:47.030165 systemd[1]: Started sshd@25-10.0.0.110:22-10.0.0.1:56226.service - OpenSSH per-connection server daemon (10.0.0.1:56226). Jul 10 23:57:47.035821 systemd-logind[1399]: Removed session 25. Jul 10 23:57:47.079567 sshd[2691]: Accepted publickey for core from 10.0.0.1 port 56226 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:47.080813 sshd-session[2691]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:47.087131 systemd-logind[1399]: New session 26 of user core. Jul 10 23:57:47.106289 systemd[1]: Started session-26.scope - Session 26 of User core. Jul 10 23:57:47.160063 sshd[2693]: Connection closed by 10.0.0.1 port 56226 Jul 10 23:57:47.160229 sshd-session[2691]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:47.178411 systemd[1]: sshd@25-10.0.0.110:22-10.0.0.1:56226.service: Deactivated successfully. Jul 10 23:57:47.179999 systemd[1]: session-26.scope: Deactivated successfully. Jul 10 23:57:47.180646 systemd-logind[1399]: Session 26 logged out. Waiting for processes to exit. Jul 10 23:57:47.182911 systemd[1]: Started sshd@26-10.0.0.110:22-10.0.0.1:56232.service - OpenSSH per-connection server daemon (10.0.0.1:56232). Jul 10 23:57:47.183860 systemd-logind[1399]: Removed session 26. Jul 10 23:57:47.226247 sshd[2699]: Accepted publickey for core from 10.0.0.1 port 56232 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:47.227576 sshd-session[2699]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:47.232223 systemd-logind[1399]: New session 27 of user core. Jul 10 23:57:47.241234 systemd[1]: Started session-27.scope - Session 27 of User core. Jul 10 23:57:47.299566 sshd[2701]: Connection closed by 10.0.0.1 port 56232 Jul 10 23:57:47.299902 sshd-session[2699]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:47.308439 systemd[1]: sshd@26-10.0.0.110:22-10.0.0.1:56232.service: Deactivated successfully. Jul 10 23:57:47.310320 systemd[1]: session-27.scope: Deactivated successfully. Jul 10 23:57:47.311206 systemd-logind[1399]: Session 27 logged out. Waiting for processes to exit. Jul 10 23:57:47.313873 systemd[1]: Started sshd@27-10.0.0.110:22-10.0.0.1:56242.service - OpenSSH per-connection server daemon (10.0.0.1:56242). Jul 10 23:57:47.314530 systemd-logind[1399]: Removed session 27. Jul 10 23:57:47.371221 sshd[2714]: Accepted publickey for core from 10.0.0.1 port 56242 ssh2: RSA SHA256:WeUQKeUHIYQBEC6vd2p1LygcOYX3O2m1zuoI/cCo1DA Jul 10 23:57:47.372530 sshd-session[2714]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 23:57:47.376966 systemd-logind[1399]: New session 28 of user core. Jul 10 23:57:47.393272 systemd[1]: Started session-28.scope - Session 28 of User core. Jul 10 23:57:47.463215 systemd[1]: var-lib-docker-overlay2-ecdb80504c27967fb1b35975be23906d0ac161657f0a9f9073dca2fdb4d4b128\x2dinit-merged.mount: Deactivated successfully. Jul 10 23:57:47.499133 containerd[2413]: time="2025-07-10T23:57:47.499087647Z" level=info msg="connecting to shim 69a50e89217b6401b35850a6cacf9284b1c77b98ddcd493c621fc9a446274184" address="unix:///run/containerd/s/8b1dd11e46a9f5f1aaae61c1baef608d05cb2d832e8ed46e82c475f35a030f9b" namespace=moby protocol=ttrpc version=3 Jul 10 23:57:47.528285 systemd[1]: Started docker-69a50e89217b6401b35850a6cacf9284b1c77b98ddcd493c621fc9a446274184.scope - libcontainer container 69a50e89217b6401b35850a6cacf9284b1c77b98ddcd493c621fc9a446274184. Jul 10 23:57:47.539573 systemd-resolved[1297]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 23:57:47.555493 kernel: docker0: port 1(vetheb398f3) entered blocking state Jul 10 23:57:47.555592 kernel: docker0: port 1(vetheb398f3) entered disabled state Jul 10 23:57:47.555609 kernel: vetheb398f3: entered allmulticast mode Jul 10 23:57:47.556277 kernel: vetheb398f3: entered promiscuous mode Jul 10 23:57:47.556631 systemd-networkd[1382]: vetheb398f3: Link UP Jul 10 23:57:47.565123 kernel: eth0: renamed from vethade7932 Jul 10 23:57:47.567227 kernel: docker0: port 1(vetheb398f3) entered blocking state Jul 10 23:57:47.567463 kernel: docker0: port 1(vetheb398f3) entered forwarding state Jul 10 23:57:47.567316 systemd-networkd[1382]: vetheb398f3: Gained carrier Jul 10 23:57:47.567592 systemd-networkd[1382]: docker0: Gained carrier Jul 10 23:57:47.588076 sshd[2716]: Connection closed by 10.0.0.1 port 56242 Jul 10 23:57:47.588408 sshd-session[2714]: pam_unix(sshd:session): session closed for user core Jul 10 23:57:47.591804 systemd[1]: sshd@27-10.0.0.110:22-10.0.0.1:56242.service: Deactivated successfully. Jul 10 23:57:47.593840 systemd[1]: session-28.scope: Deactivated successfully. Jul 10 23:57:47.596364 systemd-logind[1399]: Session 28 logged out. Waiting for processes to exit. Jul 10 23:57:47.597592 systemd-logind[1399]: Removed session 28. Jul 10 23:57:48.918320 systemd-networkd[1382]: vetheb398f3: Gained IPv6LL