Sep 5 09:56:57.781643 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 5 09:56:57.781668 kernel: Linux version 6.12.44-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Fri Sep 5 07:50:30 -00 2025 Sep 5 09:56:57.781686 kernel: KASLR enabled Sep 5 09:56:57.781692 kernel: efi: EFI v2.7 by EDK II Sep 5 09:56:57.781698 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Sep 5 09:56:57.781703 kernel: random: crng init done Sep 5 09:56:57.781710 kernel: secureboot: Secure boot disabled Sep 5 09:56:57.781715 kernel: ACPI: Early table checksum verification disabled Sep 5 09:56:57.781721 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Sep 5 09:56:57.781776 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 5 09:56:57.781784 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781790 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781796 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781802 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781809 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781817 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781824 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781830 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781836 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 09:56:57.781842 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 5 09:56:57.781848 kernel: ACPI: Use ACPI SPCR as default console: No Sep 5 09:56:57.781854 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 09:56:57.781860 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Sep 5 09:56:57.781866 kernel: Zone ranges: Sep 5 09:56:57.781872 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 09:56:57.781880 kernel: DMA32 empty Sep 5 09:56:57.781886 kernel: Normal empty Sep 5 09:56:57.781891 kernel: Device empty Sep 5 09:56:57.781897 kernel: Movable zone start for each node Sep 5 09:56:57.781903 kernel: Early memory node ranges Sep 5 09:56:57.781909 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Sep 5 09:56:57.781915 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Sep 5 09:56:57.781921 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Sep 5 09:56:57.781927 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Sep 5 09:56:57.781933 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Sep 5 09:56:57.781939 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Sep 5 09:56:57.781945 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Sep 5 09:56:57.781952 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Sep 5 09:56:57.781958 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Sep 5 09:56:57.781964 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 5 09:56:57.781973 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 5 09:56:57.781979 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 5 09:56:57.781985 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 5 09:56:57.781993 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 09:56:57.781999 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 5 09:56:57.782006 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Sep 5 09:56:57.782012 kernel: psci: probing for conduit method from ACPI. Sep 5 09:56:57.782019 kernel: psci: PSCIv1.1 detected in firmware. Sep 5 09:56:57.782025 kernel: psci: Using standard PSCI v0.2 function IDs Sep 5 09:56:57.782031 kernel: psci: Trusted OS migration not required Sep 5 09:56:57.782037 kernel: psci: SMC Calling Convention v1.1 Sep 5 09:56:57.782044 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 5 09:56:57.782050 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 5 09:56:57.782058 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 5 09:56:57.782065 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 5 09:56:57.782071 kernel: Detected PIPT I-cache on CPU0 Sep 5 09:56:57.782077 kernel: CPU features: detected: GIC system register CPU interface Sep 5 09:56:57.782084 kernel: CPU features: detected: Spectre-v4 Sep 5 09:56:57.782090 kernel: CPU features: detected: Spectre-BHB Sep 5 09:56:57.782097 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 5 09:56:57.782103 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 5 09:56:57.782109 kernel: CPU features: detected: ARM erratum 1418040 Sep 5 09:56:57.782116 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 5 09:56:57.782122 kernel: alternatives: applying boot alternatives Sep 5 09:56:57.782130 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=02f5108cf8c766bf71bb8e1e855083d321539c5b845cf6842e973740cc1f534b Sep 5 09:56:57.782138 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 5 09:56:57.782144 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 5 09:56:57.782151 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 5 09:56:57.782157 kernel: Fallback order for Node 0: 0 Sep 5 09:56:57.782164 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Sep 5 09:56:57.782170 kernel: Policy zone: DMA Sep 5 09:56:57.782176 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 5 09:56:57.782183 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Sep 5 09:56:57.782189 kernel: software IO TLB: area num 4. Sep 5 09:56:57.782195 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Sep 5 09:56:57.782202 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Sep 5 09:56:57.782209 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 5 09:56:57.782216 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 5 09:56:57.782227 kernel: rcu: RCU event tracing is enabled. Sep 5 09:56:57.782234 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 5 09:56:57.782240 kernel: Trampoline variant of Tasks RCU enabled. Sep 5 09:56:57.782268 kernel: Tracing variant of Tasks RCU enabled. Sep 5 09:56:57.782283 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 5 09:56:57.782289 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 5 09:56:57.782296 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 09:56:57.782302 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 09:56:57.782309 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 5 09:56:57.782317 kernel: GICv3: 256 SPIs implemented Sep 5 09:56:57.782323 kernel: GICv3: 0 Extended SPIs implemented Sep 5 09:56:57.782330 kernel: Root IRQ handler: gic_handle_irq Sep 5 09:56:57.782336 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 5 09:56:57.782342 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 5 09:56:57.782349 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 5 09:56:57.782355 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 5 09:56:57.782362 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Sep 5 09:56:57.782369 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Sep 5 09:56:57.782375 kernel: GICv3: using LPI property table @0x0000000040130000 Sep 5 09:56:57.782382 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Sep 5 09:56:57.782388 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 5 09:56:57.782396 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 09:56:57.782402 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 5 09:56:57.782409 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 5 09:56:57.782415 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 5 09:56:57.782422 kernel: arm-pv: using stolen time PV Sep 5 09:56:57.782428 kernel: Console: colour dummy device 80x25 Sep 5 09:56:57.782435 kernel: ACPI: Core revision 20240827 Sep 5 09:56:57.782442 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 5 09:56:57.782448 kernel: pid_max: default: 32768 minimum: 301 Sep 5 09:56:57.782455 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 5 09:56:57.782462 kernel: landlock: Up and running. Sep 5 09:56:57.782469 kernel: SELinux: Initializing. Sep 5 09:56:57.782475 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 09:56:57.782482 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 09:56:57.782491 kernel: rcu: Hierarchical SRCU implementation. Sep 5 09:56:57.782500 kernel: rcu: Max phase no-delay instances is 400. Sep 5 09:56:57.782510 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 5 09:56:57.782518 kernel: Remapping and enabling EFI services. Sep 5 09:56:57.782525 kernel: smp: Bringing up secondary CPUs ... Sep 5 09:56:57.782557 kernel: Detected PIPT I-cache on CPU1 Sep 5 09:56:57.782564 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 5 09:56:57.782572 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Sep 5 09:56:57.782580 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 09:56:57.782586 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 5 09:56:57.782593 kernel: Detected PIPT I-cache on CPU2 Sep 5 09:56:57.782601 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 5 09:56:57.782608 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Sep 5 09:56:57.782616 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 09:56:57.782622 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 5 09:56:57.782629 kernel: Detected PIPT I-cache on CPU3 Sep 5 09:56:57.782636 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 5 09:56:57.782643 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Sep 5 09:56:57.782650 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 09:56:57.782657 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 5 09:56:57.782664 kernel: smp: Brought up 1 node, 4 CPUs Sep 5 09:56:57.782671 kernel: SMP: Total of 4 processors activated. Sep 5 09:56:57.782684 kernel: CPU: All CPU(s) started at EL1 Sep 5 09:56:57.782691 kernel: CPU features: detected: 32-bit EL0 Support Sep 5 09:56:57.782698 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 5 09:56:57.782705 kernel: CPU features: detected: Common not Private translations Sep 5 09:56:57.782712 kernel: CPU features: detected: CRC32 instructions Sep 5 09:56:57.782719 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 5 09:56:57.782726 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 5 09:56:57.782738 kernel: CPU features: detected: LSE atomic instructions Sep 5 09:56:57.782745 kernel: CPU features: detected: Privileged Access Never Sep 5 09:56:57.782752 kernel: CPU features: detected: RAS Extension Support Sep 5 09:56:57.782761 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 5 09:56:57.782768 kernel: alternatives: applying system-wide alternatives Sep 5 09:56:57.782775 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Sep 5 09:56:57.782782 kernel: Memory: 2424416K/2572288K available (11136K kernel code, 2436K rwdata, 9060K rodata, 39040K init, 1038K bss, 125536K reserved, 16384K cma-reserved) Sep 5 09:56:57.782789 kernel: devtmpfs: initialized Sep 5 09:56:57.782796 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 5 09:56:57.782803 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 5 09:56:57.782810 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 5 09:56:57.782818 kernel: 0 pages in range for non-PLT usage Sep 5 09:56:57.782825 kernel: 508544 pages in range for PLT usage Sep 5 09:56:57.782832 kernel: pinctrl core: initialized pinctrl subsystem Sep 5 09:56:57.782839 kernel: SMBIOS 3.0.0 present. Sep 5 09:56:57.782846 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Sep 5 09:56:57.782853 kernel: DMI: Memory slots populated: 1/1 Sep 5 09:56:57.782860 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 5 09:56:57.782867 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 5 09:56:57.782874 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 5 09:56:57.782882 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 5 09:56:57.782889 kernel: audit: initializing netlink subsys (disabled) Sep 5 09:56:57.782896 kernel: audit: type=2000 audit(0.026:1): state=initialized audit_enabled=0 res=1 Sep 5 09:56:57.782903 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 5 09:56:57.782910 kernel: cpuidle: using governor menu Sep 5 09:56:57.782917 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 5 09:56:57.782924 kernel: ASID allocator initialised with 32768 entries Sep 5 09:56:57.782931 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 5 09:56:57.782938 kernel: Serial: AMBA PL011 UART driver Sep 5 09:56:57.782946 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 5 09:56:57.782953 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 5 09:56:57.782960 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 5 09:56:57.782967 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 5 09:56:57.782974 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 5 09:56:57.782980 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 5 09:56:57.782987 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 5 09:56:57.782994 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 5 09:56:57.783001 kernel: ACPI: Added _OSI(Module Device) Sep 5 09:56:57.783007 kernel: ACPI: Added _OSI(Processor Device) Sep 5 09:56:57.783015 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 5 09:56:57.783022 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 5 09:56:57.783029 kernel: ACPI: Interpreter enabled Sep 5 09:56:57.783036 kernel: ACPI: Using GIC for interrupt routing Sep 5 09:56:57.783043 kernel: ACPI: MCFG table detected, 1 entries Sep 5 09:56:57.783049 kernel: ACPI: CPU0 has been hot-added Sep 5 09:56:57.783056 kernel: ACPI: CPU1 has been hot-added Sep 5 09:56:57.783063 kernel: ACPI: CPU2 has been hot-added Sep 5 09:56:57.783070 kernel: ACPI: CPU3 has been hot-added Sep 5 09:56:57.783078 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 5 09:56:57.783085 kernel: printk: legacy console [ttyAMA0] enabled Sep 5 09:56:57.783092 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 5 09:56:57.783217 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 5 09:56:57.783282 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 5 09:56:57.783342 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 5 09:56:57.783400 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 5 09:56:57.783460 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 5 09:56:57.783469 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 5 09:56:57.783476 kernel: PCI host bridge to bus 0000:00 Sep 5 09:56:57.783538 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 5 09:56:57.783593 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 5 09:56:57.783647 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 5 09:56:57.783712 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 5 09:56:57.783810 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Sep 5 09:56:57.783883 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 5 09:56:57.783945 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Sep 5 09:56:57.784005 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Sep 5 09:56:57.784066 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Sep 5 09:56:57.784125 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Sep 5 09:56:57.784187 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Sep 5 09:56:57.784253 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Sep 5 09:56:57.784308 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 5 09:56:57.784362 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 5 09:56:57.784416 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 5 09:56:57.784425 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 5 09:56:57.784432 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 5 09:56:57.784439 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 5 09:56:57.784448 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 5 09:56:57.784455 kernel: iommu: Default domain type: Translated Sep 5 09:56:57.784462 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 5 09:56:57.784469 kernel: efivars: Registered efivars operations Sep 5 09:56:57.784476 kernel: vgaarb: loaded Sep 5 09:56:57.784482 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 5 09:56:57.784489 kernel: VFS: Disk quotas dquot_6.6.0 Sep 5 09:56:57.784496 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 5 09:56:57.784503 kernel: pnp: PnP ACPI init Sep 5 09:56:57.784574 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 5 09:56:57.784584 kernel: pnp: PnP ACPI: found 1 devices Sep 5 09:56:57.784591 kernel: NET: Registered PF_INET protocol family Sep 5 09:56:57.784598 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 5 09:56:57.784605 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 5 09:56:57.784612 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 5 09:56:57.784619 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 5 09:56:57.784626 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 5 09:56:57.784633 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 5 09:56:57.784641 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 09:56:57.784648 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 09:56:57.784655 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 5 09:56:57.784663 kernel: PCI: CLS 0 bytes, default 64 Sep 5 09:56:57.784670 kernel: kvm [1]: HYP mode not available Sep 5 09:56:57.784686 kernel: Initialise system trusted keyrings Sep 5 09:56:57.784694 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 5 09:56:57.784701 kernel: Key type asymmetric registered Sep 5 09:56:57.784708 kernel: Asymmetric key parser 'x509' registered Sep 5 09:56:57.784717 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 5 09:56:57.784724 kernel: io scheduler mq-deadline registered Sep 5 09:56:57.784745 kernel: io scheduler kyber registered Sep 5 09:56:57.784752 kernel: io scheduler bfq registered Sep 5 09:56:57.784760 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 5 09:56:57.784766 kernel: ACPI: button: Power Button [PWRB] Sep 5 09:56:57.784774 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 5 09:56:57.784843 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 5 09:56:57.784853 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 5 09:56:57.784862 kernel: thunder_xcv, ver 1.0 Sep 5 09:56:57.784869 kernel: thunder_bgx, ver 1.0 Sep 5 09:56:57.784877 kernel: nicpf, ver 1.0 Sep 5 09:56:57.784883 kernel: nicvf, ver 1.0 Sep 5 09:56:57.784956 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 5 09:56:57.785016 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-05T09:56:57 UTC (1757066217) Sep 5 09:56:57.785026 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 5 09:56:57.785034 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 5 09:56:57.785042 kernel: watchdog: NMI not fully supported Sep 5 09:56:57.785049 kernel: watchdog: Hard watchdog permanently disabled Sep 5 09:56:57.785056 kernel: NET: Registered PF_INET6 protocol family Sep 5 09:56:57.785063 kernel: Segment Routing with IPv6 Sep 5 09:56:57.785071 kernel: In-situ OAM (IOAM) with IPv6 Sep 5 09:56:57.785077 kernel: NET: Registered PF_PACKET protocol family Sep 5 09:56:57.785085 kernel: Key type dns_resolver registered Sep 5 09:56:57.785092 kernel: registered taskstats version 1 Sep 5 09:56:57.785098 kernel: Loading compiled-in X.509 certificates Sep 5 09:56:57.785107 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.44-flatcar: a1d02269adfcd8c8f11a69ebd3ae00b498993ee3' Sep 5 09:56:57.785114 kernel: Demotion targets for Node 0: null Sep 5 09:56:57.785135 kernel: Key type .fscrypt registered Sep 5 09:56:57.785142 kernel: Key type fscrypt-provisioning registered Sep 5 09:56:57.785149 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 5 09:56:57.785157 kernel: ima: Allocated hash algorithm: sha1 Sep 5 09:56:57.785164 kernel: ima: No architecture policies found Sep 5 09:56:57.785171 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 5 09:56:57.785177 kernel: clk: Disabling unused clocks Sep 5 09:56:57.785186 kernel: PM: genpd: Disabling unused power domains Sep 5 09:56:57.785193 kernel: Warning: unable to open an initial console. Sep 5 09:56:57.785200 kernel: Freeing unused kernel memory: 39040K Sep 5 09:56:57.785207 kernel: Run /init as init process Sep 5 09:56:57.785214 kernel: with arguments: Sep 5 09:56:57.785221 kernel: /init Sep 5 09:56:57.785228 kernel: with environment: Sep 5 09:56:57.785235 kernel: HOME=/ Sep 5 09:56:57.785242 kernel: TERM=linux Sep 5 09:56:57.785250 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 5 09:56:57.785258 systemd[1]: Successfully made /usr/ read-only. Sep 5 09:56:57.785268 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) Sep 5 09:56:57.785276 systemd[1]: Detected virtualization kvm. Sep 5 09:56:57.785283 systemd[1]: Detected architecture arm64. Sep 5 09:56:57.785290 systemd[1]: Running in initrd. Sep 5 09:56:57.785297 systemd[1]: No hostname configured, using default hostname. Sep 5 09:56:57.785306 systemd[1]: Hostname set to . Sep 5 09:56:57.785314 systemd[1]: Initializing machine ID from VM UUID. Sep 5 09:56:57.785320 kernel: hrtimer: interrupt took 15657440 ns Sep 5 09:56:57.785328 systemd[1]: Queued start job for default target initrd.target. Sep 5 09:56:57.785335 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 09:56:57.785343 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 09:56:57.785351 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 5 09:56:57.785358 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 09:56:57.785367 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 5 09:56:57.785375 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 5 09:56:57.785383 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 5 09:56:57.785391 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 5 09:56:57.785398 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 09:56:57.785405 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 09:56:57.785413 systemd[1]: Reached target paths.target - Path Units. Sep 5 09:56:57.785422 systemd[1]: Reached target slices.target - Slice Units. Sep 5 09:56:57.785429 systemd[1]: Reached target swap.target - Swaps. Sep 5 09:56:57.785436 systemd[1]: Reached target timers.target - Timer Units. Sep 5 09:56:57.785444 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 09:56:57.785451 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 09:56:57.785459 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 5 09:56:57.785466 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 5 09:56:57.785473 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 09:56:57.785482 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 09:56:57.785490 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 09:56:57.785497 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 09:56:57.785504 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 5 09:56:57.785512 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 09:56:57.785519 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 5 09:56:57.785527 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). Sep 5 09:56:57.785534 systemd[1]: Starting systemd-fsck-usr.service... Sep 5 09:56:57.785542 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 09:56:57.785550 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 09:56:57.785557 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 09:56:57.785565 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 09:56:57.785573 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 5 09:56:57.785581 systemd[1]: Finished systemd-fsck-usr.service. Sep 5 09:56:57.785589 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 5 09:56:57.785609 systemd-journald[243]: Collecting audit messages is disabled. Sep 5 09:56:57.785627 systemd-journald[243]: Journal started Sep 5 09:56:57.785645 systemd-journald[243]: Runtime Journal (/run/log/journal/5e2f5cea845142a883fa3081cae2b1e8) is 6M, max 48.5M, 42.4M free. Sep 5 09:56:57.780695 systemd-modules-load[244]: Inserted module 'overlay' Sep 5 09:56:57.787155 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 09:56:57.788887 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 09:56:57.790018 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 09:56:57.793844 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 5 09:56:57.796717 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 5 09:56:57.796745 kernel: Bridge firewalling registered Sep 5 09:56:57.795613 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 09:56:57.796646 systemd-modules-load[244]: Inserted module 'br_netfilter' Sep 5 09:56:57.809038 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 09:56:57.811258 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 09:56:57.814952 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 09:56:57.816891 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 09:56:57.818364 systemd-tmpfiles[265]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 5 09:56:57.824913 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 09:56:57.827958 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 09:56:57.829626 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 5 09:56:57.831779 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 09:56:57.839975 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 09:56:57.852791 dracut-cmdline[288]: 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=02f5108cf8c766bf71bb8e1e855083d321539c5b845cf6842e973740cc1f534b Sep 5 09:56:57.885240 systemd-resolved[291]: Positive Trust Anchors: Sep 5 09:56:57.885259 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 09:56:57.885291 systemd-resolved[291]: 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 Sep 5 09:56:57.890121 systemd-resolved[291]: Defaulting to hostname 'linux'. Sep 5 09:56:57.891047 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 09:56:57.898478 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 09:56:57.934759 kernel: SCSI subsystem initialized Sep 5 09:56:57.938754 kernel: Loading iSCSI transport class v2.0-870. Sep 5 09:56:57.946767 kernel: iscsi: registered transport (tcp) Sep 5 09:56:57.959074 kernel: iscsi: registered transport (qla4xxx) Sep 5 09:56:57.959116 kernel: QLogic iSCSI HBA Driver Sep 5 09:56:57.975945 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 09:56:57.993124 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 09:56:57.994368 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 09:56:58.041951 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 5 09:56:58.043994 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 5 09:56:58.110764 kernel: raid6: neonx8 gen() 15691 MB/s Sep 5 09:56:58.127762 kernel: raid6: neonx4 gen() 15736 MB/s Sep 5 09:56:58.144773 kernel: raid6: neonx2 gen() 13136 MB/s Sep 5 09:56:58.161762 kernel: raid6: neonx1 gen() 10479 MB/s Sep 5 09:56:58.178767 kernel: raid6: int64x8 gen() 6903 MB/s Sep 5 09:56:58.195770 kernel: raid6: int64x4 gen() 7349 MB/s Sep 5 09:56:58.212760 kernel: raid6: int64x2 gen() 6099 MB/s Sep 5 09:56:58.229757 kernel: raid6: int64x1 gen() 5003 MB/s Sep 5 09:56:58.229782 kernel: raid6: using algorithm neonx4 gen() 15736 MB/s Sep 5 09:56:58.246764 kernel: raid6: .... xor() 12307 MB/s, rmw enabled Sep 5 09:56:58.246788 kernel: raid6: using neon recovery algorithm Sep 5 09:56:58.251752 kernel: xor: measuring software checksum speed Sep 5 09:56:58.251773 kernel: 8regs : 21579 MB/sec Sep 5 09:56:58.252785 kernel: 32regs : 19294 MB/sec Sep 5 09:56:58.252801 kernel: arm64_neon : 28109 MB/sec Sep 5 09:56:58.252810 kernel: xor: using function: arm64_neon (28109 MB/sec) Sep 5 09:56:58.305778 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 5 09:56:58.311343 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 5 09:56:58.313532 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 09:56:58.340170 systemd-udevd[501]: Using default interface naming scheme 'v255'. Sep 5 09:56:58.344157 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 09:56:58.346175 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 5 09:56:58.373540 dracut-pre-trigger[509]: rd.md=0: removing MD RAID activation Sep 5 09:56:58.394437 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 09:56:58.396574 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 09:56:58.453048 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 09:56:58.457450 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 5 09:56:58.506914 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 5 09:56:58.507088 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 5 09:56:58.514355 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 09:56:58.514469 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 09:56:58.521534 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 09:56:58.523346 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 09:56:58.526094 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 09:56:58.550627 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 09:56:58.562916 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 5 09:56:58.564155 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 5 09:56:58.577149 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 5 09:56:58.583252 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 5 09:56:58.584216 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 5 09:56:58.592956 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 09:56:58.593927 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 09:56:58.595562 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 09:56:58.597274 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 09:56:58.599461 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 5 09:56:58.601050 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 5 09:56:58.621776 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 09:56:58.623662 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 5 09:56:59.634768 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 09:56:59.635075 disk-uuid[601]: The operation has completed successfully. Sep 5 09:56:59.659118 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 5 09:56:59.659225 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 5 09:56:59.683967 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 5 09:56:59.713393 sh[615]: Success Sep 5 09:56:59.725060 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 5 09:56:59.725099 kernel: device-mapper: uevent: version 1.0.3 Sep 5 09:56:59.726033 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 5 09:56:59.732760 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 5 09:56:59.756000 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 5 09:56:59.757529 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 5 09:56:59.767563 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 5 09:56:59.774233 kernel: BTRFS: device fsid dba47615-2608-4406-8805-29b3fcc261a3 devid 1 transid 42 /dev/mapper/usr (253:0) scanned by mount (627) Sep 5 09:56:59.774262 kernel: BTRFS info (device dm-0): first mount of filesystem dba47615-2608-4406-8805-29b3fcc261a3 Sep 5 09:56:59.774273 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 5 09:56:59.778742 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 5 09:56:59.778770 kernel: BTRFS info (device dm-0): enabling free space tree Sep 5 09:56:59.779336 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 5 09:56:59.780396 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 5 09:56:59.781574 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 5 09:56:59.782229 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 5 09:56:59.783536 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 5 09:56:59.805748 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (656) Sep 5 09:56:59.807879 kernel: BTRFS info (device vda6): first mount of filesystem d0aa5c9b-a731-49f0-8c89-15e0cc5105c0 Sep 5 09:56:59.807913 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 09:56:59.808905 kernel: BTRFS info (device vda6): turning on async discard Sep 5 09:56:59.809948 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 09:56:59.814745 kernel: BTRFS info (device vda6): last unmount of filesystem d0aa5c9b-a731-49f0-8c89-15e0cc5105c0 Sep 5 09:56:59.814923 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 5 09:56:59.816444 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 5 09:56:59.876816 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 09:56:59.879685 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 09:56:59.919142 systemd-networkd[801]: lo: Link UP Sep 5 09:56:59.919156 systemd-networkd[801]: lo: Gained carrier Sep 5 09:56:59.919921 systemd-networkd[801]: Enumeration completed Sep 5 09:56:59.920011 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 09:56:59.920398 systemd-networkd[801]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 09:56:59.920401 systemd-networkd[801]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 09:56:59.920985 systemd-networkd[801]: eth0: Link UP Sep 5 09:56:59.921296 systemd-networkd[801]: eth0: Gained carrier Sep 5 09:56:59.921306 systemd-networkd[801]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 09:56:59.922076 systemd[1]: Reached target network.target - Network. Sep 5 09:56:59.930046 ignition[701]: Ignition 2.22.0 Sep 5 09:56:59.930054 ignition[701]: Stage: fetch-offline Sep 5 09:56:59.930781 systemd-networkd[801]: eth0: DHCPv4 address 10.0.0.116/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 09:56:59.930081 ignition[701]: no configs at "/usr/lib/ignition/base.d" Sep 5 09:56:59.930088 ignition[701]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 09:56:59.930165 ignition[701]: parsed url from cmdline: "" Sep 5 09:56:59.930168 ignition[701]: no config URL provided Sep 5 09:56:59.930172 ignition[701]: reading system config file "/usr/lib/ignition/user.ign" Sep 5 09:56:59.930178 ignition[701]: no config at "/usr/lib/ignition/user.ign" Sep 5 09:56:59.930195 ignition[701]: op(1): [started] loading QEMU firmware config module Sep 5 09:56:59.930199 ignition[701]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 5 09:56:59.938955 ignition[701]: op(1): [finished] loading QEMU firmware config module Sep 5 09:56:59.938987 ignition[701]: QEMU firmware config was not found. Ignoring... Sep 5 09:56:59.943500 ignition[701]: parsing config with SHA512: 1416fccebda9b98e3d7e47a0c1ef02c15f1663eab86e4727efe355b248ee0642b4af7e1ac4e0ad138541fd4089288749a95fca6af1ee79920484d91fdbfadf27 Sep 5 09:56:59.950119 unknown[701]: fetched base config from "system" Sep 5 09:56:59.950131 unknown[701]: fetched user config from "qemu" Sep 5 09:56:59.950283 ignition[701]: fetch-offline: fetch-offline passed Sep 5 09:56:59.950352 ignition[701]: Ignition finished successfully Sep 5 09:56:59.952878 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 09:56:59.954272 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 5 09:56:59.955018 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 5 09:56:59.985612 ignition[813]: Ignition 2.22.0 Sep 5 09:56:59.985631 ignition[813]: Stage: kargs Sep 5 09:56:59.985799 ignition[813]: no configs at "/usr/lib/ignition/base.d" Sep 5 09:56:59.985809 ignition[813]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 09:56:59.986301 ignition[813]: kargs: kargs passed Sep 5 09:56:59.986340 ignition[813]: Ignition finished successfully Sep 5 09:56:59.988629 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 5 09:56:59.990426 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 5 09:57:00.018316 ignition[823]: Ignition 2.22.0 Sep 5 09:57:00.018335 ignition[823]: Stage: disks Sep 5 09:57:00.018460 ignition[823]: no configs at "/usr/lib/ignition/base.d" Sep 5 09:57:00.018469 ignition[823]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 09:57:00.018991 ignition[823]: disks: disks passed Sep 5 09:57:00.021963 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 5 09:57:00.019030 ignition[823]: Ignition finished successfully Sep 5 09:57:00.022918 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 5 09:57:00.023959 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 5 09:57:00.025475 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 09:57:00.026831 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 09:57:00.028472 systemd[1]: Reached target basic.target - Basic System. Sep 5 09:57:00.031205 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 5 09:57:00.055642 systemd-fsck[833]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 5 09:57:00.059846 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 5 09:57:00.062250 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 5 09:57:00.120765 kernel: EXT4-fs (vda9): mounted filesystem 4513519a-c97a-4364-8ff4-42592623cb86 r/w with ordered data mode. Quota mode: none. Sep 5 09:57:00.121442 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 5 09:57:00.122462 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 5 09:57:00.124433 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 09:57:00.125901 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 5 09:57:00.126676 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 5 09:57:00.126714 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 5 09:57:00.126753 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 09:57:00.139256 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 5 09:57:00.141517 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 5 09:57:00.145922 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (841) Sep 5 09:57:00.145941 kernel: BTRFS info (device vda6): first mount of filesystem d0aa5c9b-a731-49f0-8c89-15e0cc5105c0 Sep 5 09:57:00.145951 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 09:57:00.145960 kernel: BTRFS info (device vda6): turning on async discard Sep 5 09:57:00.146893 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 09:57:00.148201 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 09:57:00.175429 initrd-setup-root[865]: cut: /sysroot/etc/passwd: No such file or directory Sep 5 09:57:00.178552 initrd-setup-root[872]: cut: /sysroot/etc/group: No such file or directory Sep 5 09:57:00.181753 initrd-setup-root[879]: cut: /sysroot/etc/shadow: No such file or directory Sep 5 09:57:00.185255 initrd-setup-root[886]: cut: /sysroot/etc/gshadow: No such file or directory Sep 5 09:57:00.246151 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 5 09:57:00.248506 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 5 09:57:00.250546 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 5 09:57:00.264773 kernel: BTRFS info (device vda6): last unmount of filesystem d0aa5c9b-a731-49f0-8c89-15e0cc5105c0 Sep 5 09:57:00.272709 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 5 09:57:00.283593 ignition[955]: INFO : Ignition 2.22.0 Sep 5 09:57:00.283593 ignition[955]: INFO : Stage: mount Sep 5 09:57:00.284861 ignition[955]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 09:57:00.284861 ignition[955]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 09:57:00.284861 ignition[955]: INFO : mount: mount passed Sep 5 09:57:00.284861 ignition[955]: INFO : Ignition finished successfully Sep 5 09:57:00.286092 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 5 09:57:00.289443 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 5 09:57:00.773323 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 5 09:57:00.775945 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 09:57:00.791097 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (967) Sep 5 09:57:00.791127 kernel: BTRFS info (device vda6): first mount of filesystem d0aa5c9b-a731-49f0-8c89-15e0cc5105c0 Sep 5 09:57:00.791137 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 09:57:00.794134 kernel: BTRFS info (device vda6): turning on async discard Sep 5 09:57:00.794150 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 09:57:00.795469 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 09:57:00.828225 ignition[984]: INFO : Ignition 2.22.0 Sep 5 09:57:00.828225 ignition[984]: INFO : Stage: files Sep 5 09:57:00.829695 ignition[984]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 09:57:00.829695 ignition[984]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 09:57:00.829695 ignition[984]: DEBUG : files: compiled without relabeling support, skipping Sep 5 09:57:00.829695 ignition[984]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 5 09:57:00.829695 ignition[984]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 5 09:57:00.838189 ignition[984]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 5 09:57:00.839320 ignition[984]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 5 09:57:00.839320 ignition[984]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 5 09:57:00.838787 unknown[984]: wrote ssh authorized keys file for user: core Sep 5 09:57:00.842758 ignition[984]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 09:57:00.842758 ignition[984]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 09:57:00.842758 ignition[984]: INFO : files: op(4): [started] processing unit "etcd-member.service" Sep 5 09:57:00.842758 ignition[984]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Sep 5 09:57:00.849043 ignition[984]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Sep 5 09:57:00.859684 ignition[984]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 09:57:00.860943 ignition[984]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 09:57:00.860943 ignition[984]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Sep 5 09:57:00.860943 ignition[984]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Sep 5 09:57:00.860943 ignition[984]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Sep 5 09:57:00.867384 ignition[984]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 5 09:57:00.867384 ignition[984]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 5 09:57:00.867384 ignition[984]: INFO : files: files passed Sep 5 09:57:00.867384 ignition[984]: INFO : Ignition finished successfully Sep 5 09:57:00.863555 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 5 09:57:00.865512 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 5 09:57:00.867028 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 5 09:57:00.879751 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 5 09:57:00.879850 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 5 09:57:00.882344 initrd-setup-root-after-ignition[1012]: grep: /sysroot/oem/oem-release: No such file or directory Sep 5 09:57:00.883878 initrd-setup-root-after-ignition[1015]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 09:57:00.883878 initrd-setup-root-after-ignition[1015]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 5 09:57:00.886317 initrd-setup-root-after-ignition[1019]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 09:57:00.886279 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 09:57:00.887510 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 5 09:57:00.891312 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 5 09:57:00.929135 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 5 09:57:00.929268 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 5 09:57:00.931137 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 5 09:57:00.932501 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 5 09:57:00.933954 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 5 09:57:00.934772 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 5 09:57:00.959016 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 09:57:00.961156 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 5 09:57:00.979494 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 5 09:57:00.980544 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 09:57:00.982222 systemd[1]: Stopped target timers.target - Timer Units. Sep 5 09:57:00.983639 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 5 09:57:00.983791 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 09:57:00.985781 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 5 09:57:00.986623 systemd[1]: Stopped target basic.target - Basic System. Sep 5 09:57:00.988340 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 5 09:57:00.989889 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 09:57:00.991510 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 5 09:57:00.993382 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 5 09:57:00.995084 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 5 09:57:00.996630 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 09:57:00.998459 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 5 09:57:00.999956 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 5 09:57:01.001561 systemd[1]: Stopped target swap.target - Swaps. Sep 5 09:57:01.002822 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 5 09:57:01.002939 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 5 09:57:01.004753 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 5 09:57:01.006377 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 09:57:01.007806 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 5 09:57:01.007908 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 09:57:01.009456 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 5 09:57:01.009562 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 5 09:57:01.011616 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 5 09:57:01.011757 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 09:57:01.013609 systemd[1]: Stopped target paths.target - Path Units. Sep 5 09:57:01.014765 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 5 09:57:01.019843 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 09:57:01.020853 systemd[1]: Stopped target slices.target - Slice Units. Sep 5 09:57:01.022519 systemd[1]: Stopped target sockets.target - Socket Units. Sep 5 09:57:01.023751 systemd[1]: iscsid.socket: Deactivated successfully. Sep 5 09:57:01.023835 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 09:57:01.025071 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 5 09:57:01.025144 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 09:57:01.026355 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 5 09:57:01.026464 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 09:57:01.027819 systemd[1]: ignition-files.service: Deactivated successfully. Sep 5 09:57:01.027916 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 5 09:57:01.029897 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 5 09:57:01.031360 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 5 09:57:01.031482 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 09:57:01.044326 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 5 09:57:01.045130 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 5 09:57:01.045249 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 09:57:01.046710 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 5 09:57:01.046817 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 09:57:01.052647 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 5 09:57:01.052768 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 5 09:57:01.057983 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 5 09:57:01.059858 ignition[1039]: INFO : Ignition 2.22.0 Sep 5 09:57:01.059858 ignition[1039]: INFO : Stage: umount Sep 5 09:57:01.061879 ignition[1039]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 09:57:01.061879 ignition[1039]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 09:57:01.061879 ignition[1039]: INFO : umount: umount passed Sep 5 09:57:01.061879 ignition[1039]: INFO : Ignition finished successfully Sep 5 09:57:01.061173 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 5 09:57:01.061834 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 5 09:57:01.062805 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 5 09:57:01.062887 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 5 09:57:01.064476 systemd[1]: Stopped target network.target - Network. Sep 5 09:57:01.065402 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 5 09:57:01.065466 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 5 09:57:01.066641 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 5 09:57:01.066689 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 5 09:57:01.067944 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 5 09:57:01.067990 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 5 09:57:01.069350 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 5 09:57:01.069387 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 5 09:57:01.070649 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 5 09:57:01.070700 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 5 09:57:01.072190 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 5 09:57:01.073587 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 5 09:57:01.080057 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 5 09:57:01.080164 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 5 09:57:01.082710 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 5 09:57:01.082964 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 5 09:57:01.083001 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 09:57:01.085610 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 5 09:57:01.086530 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 5 09:57:01.086630 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 5 09:57:01.089270 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 5 09:57:01.090602 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 5 09:57:01.090636 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 5 09:57:01.092959 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 5 09:57:01.093972 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 5 09:57:01.094029 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 09:57:01.095570 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 5 09:57:01.095607 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 5 09:57:01.097847 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 5 09:57:01.097887 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 5 09:57:01.099493 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 09:57:01.117321 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 5 09:57:01.119905 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 09:57:01.121200 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 5 09:57:01.121237 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 5 09:57:01.122768 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 5 09:57:01.122795 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 09:57:01.124409 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 5 09:57:01.124452 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 5 09:57:01.126659 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 5 09:57:01.126714 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 5 09:57:01.128835 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 5 09:57:01.128883 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 09:57:01.131934 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 5 09:57:01.133467 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 5 09:57:01.133526 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 09:57:01.136227 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 5 09:57:01.136268 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 09:57:01.138872 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 09:57:01.138913 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 09:57:01.141988 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 5 09:57:01.149862 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 5 09:57:01.155029 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 5 09:57:01.155136 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 5 09:57:01.156918 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 5 09:57:01.159092 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 5 09:57:01.183174 systemd[1]: Switching root. Sep 5 09:57:01.218744 systemd-journald[243]: Received SIGTERM from PID 1 (systemd). Sep 5 09:57:01.218787 systemd-journald[243]: Journal stopped Sep 5 09:57:01.861403 kernel: SELinux: policy capability network_peer_controls=1 Sep 5 09:57:01.861457 kernel: SELinux: policy capability open_perms=1 Sep 5 09:57:01.861470 kernel: SELinux: policy capability extended_socket_class=1 Sep 5 09:57:01.861480 kernel: SELinux: policy capability always_check_network=0 Sep 5 09:57:01.861492 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 5 09:57:01.861503 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 5 09:57:01.861515 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 5 09:57:01.861524 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 5 09:57:01.861533 kernel: SELinux: policy capability userspace_initial_context=0 Sep 5 09:57:01.861542 kernel: audit: type=1403 audit(1757066221.294:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 5 09:57:01.861553 systemd[1]: Successfully loaded SELinux policy in 49.076ms. Sep 5 09:57:01.861572 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.548ms. Sep 5 09:57:01.861583 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) Sep 5 09:57:01.861595 systemd[1]: Detected virtualization kvm. Sep 5 09:57:01.861605 systemd[1]: Detected architecture arm64. Sep 5 09:57:01.861615 systemd[1]: Detected first boot. Sep 5 09:57:01.861625 systemd[1]: Initializing machine ID from VM UUID. Sep 5 09:57:01.861634 kernel: NET: Registered PF_VSOCK protocol family Sep 5 09:57:01.861644 zram_generator::config[1085]: No configuration found. Sep 5 09:57:01.861674 systemd[1]: Populated /etc with preset unit settings. Sep 5 09:57:01.861688 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 5 09:57:01.861700 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 5 09:57:01.861710 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 5 09:57:01.861725 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 5 09:57:01.861757 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 5 09:57:01.861770 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 5 09:57:01.861783 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 5 09:57:01.861793 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 5 09:57:01.861803 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 5 09:57:01.861813 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 5 09:57:01.861824 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 5 09:57:01.861833 systemd[1]: Created slice user.slice - User and Session Slice. Sep 5 09:57:01.861843 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 09:57:01.861854 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 09:57:01.861864 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 5 09:57:01.861875 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 5 09:57:01.861885 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 5 09:57:01.861896 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 09:57:01.861905 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 5 09:57:01.861915 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 09:57:01.861926 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 09:57:01.861936 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 5 09:57:01.861946 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 5 09:57:01.861957 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 5 09:57:01.861967 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 5 09:57:01.861977 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 09:57:01.861988 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 09:57:01.861997 systemd[1]: Reached target slices.target - Slice Units. Sep 5 09:57:01.862007 systemd[1]: Reached target swap.target - Swaps. Sep 5 09:57:01.862018 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 5 09:57:01.862028 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 5 09:57:01.862038 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 5 09:57:01.862049 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 09:57:01.862060 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 09:57:01.862070 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 09:57:01.862084 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 5 09:57:01.862094 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 5 09:57:01.862105 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 5 09:57:01.862115 systemd[1]: Mounting media.mount - External Media Directory... Sep 5 09:57:01.862125 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 5 09:57:01.862135 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 5 09:57:01.862147 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 5 09:57:01.862157 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). Sep 5 09:57:01.862167 systemd[1]: Reached target machines.target - Containers. Sep 5 09:57:01.862177 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 5 09:57:01.862187 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 09:57:01.862197 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 09:57:01.862207 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 5 09:57:01.862217 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 09:57:01.862229 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 09:57:01.862239 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 09:57:01.862248 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 5 09:57:01.862259 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 09:57:01.862268 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 5 09:57:01.862279 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 5 09:57:01.862288 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 5 09:57:01.862299 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 5 09:57:01.862308 systemd[1]: Stopped systemd-fsck-usr.service. Sep 5 09:57:01.862320 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). Sep 5 09:57:01.862330 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 09:57:01.862340 kernel: loop: module loaded Sep 5 09:57:01.862349 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 09:57:01.862359 kernel: ACPI: bus type drm_connector registered Sep 5 09:57:01.862369 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 09:57:01.862379 kernel: fuse: init (API version 7.41) Sep 5 09:57:01.862388 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 5 09:57:01.862398 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 5 09:57:01.862410 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 09:57:01.862421 systemd[1]: verity-setup.service: Deactivated successfully. Sep 5 09:57:01.862430 systemd[1]: Stopped verity-setup.service. Sep 5 09:57:01.862440 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 5 09:57:01.862450 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 5 09:57:01.862479 systemd-journald[1159]: Collecting audit messages is disabled. Sep 5 09:57:01.862502 systemd[1]: Mounted media.mount - External Media Directory. Sep 5 09:57:01.862512 systemd-journald[1159]: Journal started Sep 5 09:57:01.862531 systemd-journald[1159]: Runtime Journal (/run/log/journal/5e2f5cea845142a883fa3081cae2b1e8) is 6M, max 48.5M, 42.4M free. Sep 5 09:57:01.644901 systemd[1]: Queued start job for default target multi-user.target. Sep 5 09:57:01.668696 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 5 09:57:01.669051 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 5 09:57:01.864773 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 09:57:01.865317 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 5 09:57:01.866311 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 5 09:57:01.867287 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 5 09:57:01.869762 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 5 09:57:01.870893 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 09:57:01.872077 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 5 09:57:01.872237 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 5 09:57:01.873423 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 09:57:01.873572 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 09:57:01.874897 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 09:57:01.875050 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 09:57:01.876137 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 09:57:01.877759 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 09:57:01.879110 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 5 09:57:01.879259 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 5 09:57:01.880424 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 09:57:01.880569 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 09:57:01.881885 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 09:57:01.883007 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 09:57:01.884275 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 5 09:57:01.885686 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 5 09:57:01.897706 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 09:57:01.899704 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 5 09:57:01.901441 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 5 09:57:01.902508 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 5 09:57:01.902535 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 09:57:01.904176 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 5 09:57:01.914447 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 5 09:57:01.915499 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 09:57:01.916552 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 5 09:57:01.918331 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 5 09:57:01.919455 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 09:57:01.920507 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 5 09:57:01.921586 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 09:57:01.923862 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 09:57:01.925986 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 5 09:57:01.927635 systemd-journald[1159]: Time spent on flushing to /var/log/journal/5e2f5cea845142a883fa3081cae2b1e8 is 20.454ms for 857 entries. Sep 5 09:57:01.927635 systemd-journald[1159]: System Journal (/var/log/journal/5e2f5cea845142a883fa3081cae2b1e8) is 8M, max 195.6M, 187.6M free. Sep 5 09:57:01.964503 systemd-journald[1159]: Received client request to flush runtime journal. Sep 5 09:57:01.964551 kernel: loop0: detected capacity change from 0 to 119312 Sep 5 09:57:01.964594 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 5 09:57:01.931228 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 5 09:57:01.935538 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 09:57:01.937307 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 5 09:57:01.938828 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 5 09:57:01.942108 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 5 09:57:01.947200 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 5 09:57:01.950023 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 5 09:57:01.966970 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 5 09:57:01.972797 kernel: loop1: detected capacity change from 0 to 110408 Sep 5 09:57:01.972801 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 09:57:01.976897 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 5 09:57:01.979857 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 09:57:01.992170 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 5 09:57:02.000005 systemd-tmpfiles[1218]: ACLs are not supported, ignoring. Sep 5 09:57:02.000021 systemd-tmpfiles[1218]: ACLs are not supported, ignoring. Sep 5 09:57:02.003277 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 09:57:02.009763 kernel: loop2: detected capacity change from 0 to 119312 Sep 5 09:57:02.014817 kernel: loop3: detected capacity change from 0 to 110408 Sep 5 09:57:02.018637 (sd-merge)[1223]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 5 09:57:02.019021 (sd-merge)[1223]: Merged extensions into '/usr'. Sep 5 09:57:02.021940 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 5 09:57:02.024765 systemd[1]: Starting ensure-sysext.service... Sep 5 09:57:02.028881 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 09:57:02.045688 systemd[1]: Reload requested from client PID 1225 ('systemctl') (unit ensure-sysext.service)... Sep 5 09:57:02.045705 systemd[1]: Reloading... Sep 5 09:57:02.061793 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 5 09:57:02.061821 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 5 09:57:02.062145 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 5 09:57:02.062373 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 5 09:57:02.064751 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 5 09:57:02.065111 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Sep 5 09:57:02.065158 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Sep 5 09:57:02.069846 systemd-tmpfiles[1226]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 09:57:02.069944 systemd-tmpfiles[1226]: Skipping /boot Sep 5 09:57:02.078588 systemd-tmpfiles[1226]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 09:57:02.079854 systemd-tmpfiles[1226]: Skipping /boot Sep 5 09:57:02.106757 zram_generator::config[1260]: No configuration found. Sep 5 09:57:02.224837 ldconfig[1195]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 5 09:57:02.239670 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 5 09:57:02.239879 systemd[1]: Reloading finished in 193 ms. Sep 5 09:57:02.264758 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 5 09:57:02.288784 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 09:57:02.296187 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 09:57:02.302020 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 5 09:57:02.304727 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 5 09:57:02.307971 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 09:57:02.310229 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 5 09:57:02.315616 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 09:57:02.318037 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 09:57:02.321923 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 09:57:02.336984 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 09:57:02.338056 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 09:57:02.338171 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). Sep 5 09:57:02.339232 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 5 09:57:02.342197 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 09:57:02.342341 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 09:57:02.344017 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 09:57:02.344160 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 09:57:02.346921 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 5 09:57:02.352199 augenrules[1320]: No rules Sep 5 09:57:02.354121 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 09:57:02.354926 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 09:57:02.356391 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 09:57:02.356600 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 09:57:02.360396 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 5 09:57:02.367303 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 09:57:02.368142 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 09:57:02.369562 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 09:57:02.383536 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 09:57:02.385944 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 09:57:02.387928 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 09:57:02.389905 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 09:57:02.390035 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). Sep 5 09:57:02.391462 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 5 09:57:02.392433 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). Sep 5 09:57:02.394853 augenrules[1330]: /sbin/augenrules: No change Sep 5 09:57:02.399176 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 5 09:57:02.401030 augenrules[1352]: No rules Sep 5 09:57:02.401340 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 09:57:02.401485 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 09:57:02.402917 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 09:57:02.403087 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 09:57:02.404244 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 09:57:02.404400 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 09:57:02.405664 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 09:57:02.405827 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 09:57:02.407163 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 09:57:02.407311 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 09:57:02.411201 systemd[1]: Finished ensure-sysext.service. Sep 5 09:57:02.415523 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 09:57:02.415579 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 09:57:02.417227 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 5 09:57:02.419222 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 09:57:02.421185 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 5 09:57:02.430222 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 5 09:57:02.443069 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 5 09:57:02.457795 systemd-udevd[1365]: Using default interface naming scheme 'v255'. Sep 5 09:57:02.473309 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 09:57:02.475139 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 5 09:57:02.476528 systemd[1]: Reached target time-set.target - System Time Set. Sep 5 09:57:02.479095 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 09:57:02.481599 systemd-resolved[1295]: Positive Trust Anchors: Sep 5 09:57:02.482115 systemd-resolved[1295]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 09:57:02.482150 systemd-resolved[1295]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 5 09:57:02.489165 systemd-resolved[1295]: Defaulting to hostname 'linux'. Sep 5 09:57:02.490516 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 09:57:02.493134 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 09:57:02.494887 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 09:57:02.496877 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 5 09:57:02.497815 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 5 09:57:02.498923 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 5 09:57:02.501150 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 5 09:57:02.502159 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 5 09:57:02.503318 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 5 09:57:02.503350 systemd[1]: Reached target paths.target - Path Units. Sep 5 09:57:02.504784 systemd[1]: Reached target timers.target - Timer Units. Sep 5 09:57:02.506321 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 5 09:57:02.510565 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 09:57:02.514774 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 5 09:57:02.516947 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 5 09:57:02.518070 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 5 09:57:02.533835 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 5 09:57:02.535250 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 5 09:57:02.536693 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 09:57:02.541057 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 5 09:57:02.541390 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 09:57:02.542857 systemd[1]: Reached target basic.target - Basic System. Sep 5 09:57:02.545057 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 5 09:57:02.545086 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 5 09:57:02.547190 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 5 09:57:02.550038 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 5 09:57:02.552541 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 5 09:57:02.556806 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 5 09:57:02.557713 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). Sep 5 09:57:02.570884 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 5 09:57:02.571169 jq[1413]: false Sep 5 09:57:02.572763 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 5 09:57:02.575673 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 5 09:57:02.580266 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 5 09:57:02.581994 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 5 09:57:02.582392 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 5 09:57:02.582957 systemd[1]: Starting update-engine.service - Update Engine... Sep 5 09:57:02.585386 extend-filesystems[1414]: Found /dev/vda6 Sep 5 09:57:02.586887 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 5 09:57:02.590885 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 5 09:57:02.593233 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 5 09:57:02.593400 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 5 09:57:02.593692 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 5 09:57:02.593863 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 5 09:57:02.596782 extend-filesystems[1414]: Found /dev/vda9 Sep 5 09:57:02.597528 extend-filesystems[1414]: Checking size of /dev/vda9 Sep 5 09:57:02.603828 extend-filesystems[1414]: Old size kept for /dev/vda9 Sep 5 09:57:02.605457 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 5 09:57:02.606809 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 5 09:57:02.608702 systemd-networkd[1388]: lo: Link UP Sep 5 09:57:02.608714 systemd-networkd[1388]: lo: Gained carrier Sep 5 09:57:02.609531 systemd-networkd[1388]: Enumeration completed Sep 5 09:57:02.609829 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 09:57:02.613515 systemd-networkd[1388]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 09:57:02.613871 systemd-networkd[1388]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 09:57:02.614578 systemd-networkd[1388]: eth0: Link UP Sep 5 09:57:02.615290 systemd-networkd[1388]: eth0: Gained carrier Sep 5 09:57:02.615706 systemd-networkd[1388]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 09:57:02.617035 systemd[1]: Reached target network.target - Network. Sep 5 09:57:02.626893 systemd[1]: Starting containerd.service - containerd container runtime... Sep 5 09:57:02.626965 jq[1424]: true Sep 5 09:57:02.629790 dbus-daemon[1410]: [system] SELinux support is enabled Sep 5 09:57:02.630347 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 5 09:57:02.632374 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 5 09:57:02.632405 systemd-networkd[1388]: eth0: DHCPv4 address 10.0.0.116/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 09:57:02.633460 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 5 09:57:02.634855 systemd-timesyncd[1364]: Network configuration changed, trying to establish connection. Sep 5 09:57:02.637828 systemd[1]: motdgen.service: Deactivated successfully. Sep 5 09:57:02.638035 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 5 09:57:02.639206 systemd-timesyncd[1364]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 5 09:57:02.639263 systemd-timesyncd[1364]: Initial clock synchronization to Fri 2025-09-05 09:57:02.411134 UTC. Sep 5 09:57:02.639798 update_engine[1423]: I20250905 09:57:02.639590 1423 main.cc:92] Flatcar Update Engine starting Sep 5 09:57:02.642186 update_engine[1423]: I20250905 09:57:02.642155 1423 update_check_scheduler.cc:74] Next update check in 10m51s Sep 5 09:57:02.647182 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 09:57:02.651021 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). Sep 5 09:57:02.651047 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 5 09:57:02.653696 jq[1448]: true Sep 5 09:57:02.653586 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 5 09:57:02.655851 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). Sep 5 09:57:02.655878 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 5 09:57:02.661316 systemd[1]: Started update-engine.service - Update Engine. Sep 5 09:57:02.663475 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 5 09:57:02.667849 systemd-logind[1422]: New seat seat0. Sep 5 09:57:02.678214 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 5 09:57:02.698932 bash[1471]: Updated "/home/core/.ssh/authorized_keys" Sep 5 09:57:02.699033 systemd[1]: Started systemd-logind.service - User Login Management. Sep 5 09:57:02.704447 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 5 09:57:02.706044 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 5 09:57:02.712753 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 5 09:57:02.724093 (ntainerd)[1473]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 5 09:57:02.766282 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 09:57:02.773774 systemd-logind[1422]: Watching system buttons on /dev/input/event0 (Power Button) Sep 5 09:57:02.789373 locksmithd[1464]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 5 09:57:02.830563 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 09:57:02.897147 containerd[1473]: time="2025-09-05T09:57:02Z" 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 Sep 5 09:57:02.898132 containerd[1473]: time="2025-09-05T09:57:02.898079920Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 5 09:57:02.907635 containerd[1473]: time="2025-09-05T09:57:02.907592120Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.48µs" Sep 5 09:57:02.907635 containerd[1473]: time="2025-09-05T09:57:02.907625880Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 5 09:57:02.907723 containerd[1473]: time="2025-09-05T09:57:02.907652800Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 5 09:57:02.907861 containerd[1473]: time="2025-09-05T09:57:02.907827600Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 5 09:57:02.907861 containerd[1473]: time="2025-09-05T09:57:02.907853360Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 5 09:57:02.907915 containerd[1473]: time="2025-09-05T09:57:02.907876960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 09:57:02.907946 containerd[1473]: time="2025-09-05T09:57:02.907925880Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 09:57:02.907966 containerd[1473]: time="2025-09-05T09:57:02.907943720Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 09:57:02.908175 containerd[1473]: time="2025-09-05T09:57:02.908143640Z" 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 Sep 5 09:57:02.908175 containerd[1473]: time="2025-09-05T09:57:02.908167120Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 09:57:02.908212 containerd[1473]: time="2025-09-05T09:57:02.908178200Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 09:57:02.908212 containerd[1473]: time="2025-09-05T09:57:02.908185960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 5 09:57:02.908267 containerd[1473]: time="2025-09-05T09:57:02.908252800Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 5 09:57:02.908513 containerd[1473]: time="2025-09-05T09:57:02.908484560Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 09:57:02.908535 containerd[1473]: time="2025-09-05T09:57:02.908525280Z" 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 Sep 5 09:57:02.908553 containerd[1473]: time="2025-09-05T09:57:02.908539920Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 5 09:57:02.908586 containerd[1473]: time="2025-09-05T09:57:02.908569440Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 5 09:57:02.908996 containerd[1473]: time="2025-09-05T09:57:02.908975440Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 5 09:57:02.909079 containerd[1473]: time="2025-09-05T09:57:02.909058960Z" level=info msg="metadata content store policy set" policy=shared Sep 5 09:57:02.912843 containerd[1473]: time="2025-09-05T09:57:02.912811960Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 5 09:57:02.912891 containerd[1473]: time="2025-09-05T09:57:02.912865200Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 5 09:57:02.912891 containerd[1473]: time="2025-09-05T09:57:02.912881520Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 5 09:57:02.912931 containerd[1473]: time="2025-09-05T09:57:02.912892760Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 5 09:57:02.912931 containerd[1473]: time="2025-09-05T09:57:02.912905280Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 5 09:57:02.912931 containerd[1473]: time="2025-09-05T09:57:02.912917200Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 5 09:57:02.912931 containerd[1473]: time="2025-09-05T09:57:02.912928560Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 5 09:57:02.913045 containerd[1473]: time="2025-09-05T09:57:02.912941360Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 5 09:57:02.913045 containerd[1473]: time="2025-09-05T09:57:02.912951720Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 5 09:57:02.913045 containerd[1473]: time="2025-09-05T09:57:02.912961800Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 5 09:57:02.913045 containerd[1473]: time="2025-09-05T09:57:02.912970440Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 5 09:57:02.913045 containerd[1473]: time="2025-09-05T09:57:02.912990080Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 5 09:57:02.913122 containerd[1473]: time="2025-09-05T09:57:02.913102200Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 5 09:57:02.913139 containerd[1473]: time="2025-09-05T09:57:02.913121240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 5 09:57:02.913139 containerd[1473]: time="2025-09-05T09:57:02.913136440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 5 09:57:02.913170 containerd[1473]: time="2025-09-05T09:57:02.913146880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 5 09:57:02.913170 containerd[1473]: time="2025-09-05T09:57:02.913161400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 5 09:57:02.913201 containerd[1473]: time="2025-09-05T09:57:02.913172240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 5 09:57:02.913201 containerd[1473]: time="2025-09-05T09:57:02.913183280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 5 09:57:02.913201 containerd[1473]: time="2025-09-05T09:57:02.913193040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 5 09:57:02.913253 containerd[1473]: time="2025-09-05T09:57:02.913206760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 5 09:57:02.913253 containerd[1473]: time="2025-09-05T09:57:02.913217600Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 5 09:57:02.913253 containerd[1473]: time="2025-09-05T09:57:02.913227320Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 5 09:57:02.913421 containerd[1473]: time="2025-09-05T09:57:02.913400920Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 5 09:57:02.913450 containerd[1473]: time="2025-09-05T09:57:02.913425920Z" level=info msg="Start snapshots syncer" Sep 5 09:57:02.913468 containerd[1473]: time="2025-09-05T09:57:02.913454120Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 5 09:57:02.913691 containerd[1473]: time="2025-09-05T09:57:02.913653600Z" 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\"}" Sep 5 09:57:02.913792 containerd[1473]: time="2025-09-05T09:57:02.913707520Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914135040Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914281400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914317200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914330680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914346360Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914363040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914378080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914390240Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914428560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914442480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 5 09:57:02.914607 containerd[1473]: time="2025-09-05T09:57:02.914492480Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 5 09:57:02.914930 containerd[1473]: time="2025-09-05T09:57:02.914586160Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 09:57:02.915035 containerd[1473]: time="2025-09-05T09:57:02.915018200Z" 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 Sep 5 09:57:02.915055 containerd[1473]: time="2025-09-05T09:57:02.915033640Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 09:57:02.915055 containerd[1473]: time="2025-09-05T09:57:02.915044320Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 09:57:02.915055 containerd[1473]: time="2025-09-05T09:57:02.915052120Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 5 09:57:02.915110 containerd[1473]: time="2025-09-05T09:57:02.915061640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 5 09:57:02.915110 containerd[1473]: time="2025-09-05T09:57:02.915073040Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 5 09:57:02.915161 containerd[1473]: time="2025-09-05T09:57:02.915150200Z" level=info msg="runtime interface created" Sep 5 09:57:02.915161 containerd[1473]: time="2025-09-05T09:57:02.915158760Z" level=info msg="created NRI interface" Sep 5 09:57:02.915196 containerd[1473]: time="2025-09-05T09:57:02.915167680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 5 09:57:02.915196 containerd[1473]: time="2025-09-05T09:57:02.915181320Z" level=info msg="Connect containerd service" Sep 5 09:57:02.915231 containerd[1473]: time="2025-09-05T09:57:02.915214600Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 5 09:57:02.915968 containerd[1473]: time="2025-09-05T09:57:02.915943040Z" 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" Sep 5 09:57:02.982394 containerd[1473]: time="2025-09-05T09:57:02.982232760Z" level=info msg="Start subscribing containerd event" Sep 5 09:57:02.982394 containerd[1473]: time="2025-09-05T09:57:02.982350080Z" level=info msg="Start recovering state" Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982466600Z" level=info msg="Start event monitor" Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982480760Z" level=info msg="Start cni network conf syncer for default" Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982490320Z" level=info msg="Start streaming server" Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982499920Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982507080Z" level=info msg="runtime interface starting up..." Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982522600Z" level=info msg="starting plugins..." Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982536720Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982539520Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 5 09:57:02.982558 containerd[1473]: time="2025-09-05T09:57:02.982591640Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 5 09:57:02.982899 containerd[1473]: time="2025-09-05T09:57:02.982712720Z" level=info msg="containerd successfully booted in 0.085919s" Sep 5 09:57:02.982831 systemd[1]: Started containerd.service - containerd container runtime. Sep 5 09:57:04.036878 systemd-networkd[1388]: eth0: Gained IPv6LL Sep 5 09:57:04.039980 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 5 09:57:04.041350 systemd[1]: Reached target network-online.target - Network is Online. Sep 5 09:57:04.044427 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 5 09:57:04.046581 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 5 09:57:04.067354 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 5 09:57:04.069560 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 5 09:57:04.071348 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 5 09:57:04.074632 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 5 09:57:04.075754 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 5 09:57:04.086099 (-wrapper)[1539]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 5 09:57:04.178046 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 5 09:57:04.206050 (dockerd)[1552]: 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 Sep 5 09:57:04.396182 dockerd[1552]: time="2025-09-05T09:57:04.395760117Z" level=info msg="Starting up" Sep 5 09:57:04.396600 dockerd[1552]: time="2025-09-05T09:57:04.396578044Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 5 09:57:04.406246 dockerd[1552]: time="2025-09-05T09:57:04.406214684Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 5 09:57:04.437208 dockerd[1552]: time="2025-09-05T09:57:04.437180558Z" level=info msg="Loading containers: start." Sep 5 09:57:04.444747 kernel: Initializing XFRM netlink socket Sep 5 09:57:04.620648 systemd-networkd[1388]: docker0: Link UP Sep 5 09:57:04.624133 dockerd[1552]: time="2025-09-05T09:57:04.624092020Z" level=info msg="Loading containers: done." Sep 5 09:57:04.635545 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4203640104-merged.mount: Deactivated successfully. Sep 5 09:57:04.636400 dockerd[1552]: time="2025-09-05T09:57:04.636358031Z" 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 Sep 5 09:57:04.636451 dockerd[1552]: time="2025-09-05T09:57:04.636423789Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 5 09:57:04.636509 dockerd[1552]: time="2025-09-05T09:57:04.636493682Z" level=info msg="Initializing buildkit" Sep 5 09:57:04.642796 sshd_keygen[1443]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 5 09:57:04.661715 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 5 09:57:04.663296 dockerd[1552]: time="2025-09-05T09:57:04.661993790Z" level=info msg="Completed buildkit initialization" Sep 5 09:57:04.663981 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 5 09:57:04.667799 dockerd[1552]: time="2025-09-05T09:57:04.667765142Z" level=info msg="Daemon has completed initialization" Sep 5 09:57:04.667916 dockerd[1552]: time="2025-09-05T09:57:04.667815573Z" level=info msg="API listen on /run/docker.sock" Sep 5 09:57:04.668380 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 5 09:57:04.671400 etcd-wrapper[1544]: Error response from daemon: No such container: etcd-member Sep 5 09:57:04.684146 etcd-wrapper[1764]: Error response from daemon: No such container: etcd-member Sep 5 09:57:04.687893 systemd[1]: issuegen.service: Deactivated successfully. Sep 5 09:57:04.688822 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 5 09:57:04.691166 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 5 09:57:04.707785 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 5 09:57:04.710279 etcd-wrapper[1791]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Sep 5 09:57:04.710915 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 5 09:57:04.712676 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 5 09:57:04.713813 systemd[1]: Reached target getty.target - Login Prompts. Sep 5 09:57:05.485771 etcd-wrapper[1791]: v3.5.16: Pulling from coreos/etcd Sep 5 09:57:05.653602 etcd-wrapper[1791]: d10f96ed9607: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: 2ae710cd8bfe: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: d462aa345367: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: 0f8b424aa0b9: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: d557676654e5: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: c8022d07192e: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: d858cbc252ad: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: 1069fc2daed1: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: b40161cd83fc: Pulling fs layer Sep 5 09:57:05.653602 etcd-wrapper[1791]: 5318d93a3a65: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: 307c1adadb60: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: f9b3c65df792: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: 5709b4a82c35: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: d5372e382b07: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: 9c3b5253dddc: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: 7a57323f7551: Pulling fs layer Sep 5 09:57:05.653920 etcd-wrapper[1791]: 0f8b424aa0b9: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: d557676654e5: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: c8022d07192e: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: d858cbc252ad: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: 1069fc2daed1: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: b40161cd83fc: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: 5318d93a3a65: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: 307c1adadb60: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: f9b3c65df792: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: 5709b4a82c35: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: d5372e382b07: Waiting Sep 5 09:57:05.653920 etcd-wrapper[1791]: 9c3b5253dddc: Waiting Sep 5 09:57:05.654236 etcd-wrapper[1791]: 7a57323f7551: Waiting Sep 5 09:57:05.914918 etcd-wrapper[1791]: 2ae710cd8bfe: Download complete Sep 5 09:57:05.933752 etcd-wrapper[1791]: d10f96ed9607: Download complete Sep 5 09:57:05.955212 etcd-wrapper[1791]: d10f96ed9607: Pull complete Sep 5 09:57:05.966626 systemd[1]: var-lib-docker-overlay2-d2362717470db084d65b2e68ef25e78935c23a97f71d25667a2de916507ae120-merged.mount: Deactivated successfully. Sep 5 09:57:05.978295 etcd-wrapper[1791]: 2ae710cd8bfe: Pull complete Sep 5 09:57:05.983252 etcd-wrapper[1791]: d462aa345367: Download complete Sep 5 09:57:06.177378 etcd-wrapper[1791]: d557676654e5: Download complete Sep 5 09:57:06.181784 etcd-wrapper[1791]: 0f8b424aa0b9: Verifying Checksum Sep 5 09:57:06.181784 etcd-wrapper[1791]: 0f8b424aa0b9: Download complete Sep 5 09:57:06.254831 etcd-wrapper[1791]: c8022d07192e: Verifying Checksum Sep 5 09:57:06.254831 etcd-wrapper[1791]: c8022d07192e: Download complete Sep 5 09:57:06.265991 systemd[1]: var-lib-docker-overlay2-19ba0a7a650785d66ea91748f6d2091b8b07d3dab4b97d553874d10b83f15156-merged.mount: Deactivated successfully. Sep 5 09:57:06.282374 etcd-wrapper[1791]: d462aa345367: Pull complete Sep 5 09:57:06.301646 etcd-wrapper[1791]: 0f8b424aa0b9: Pull complete Sep 5 09:57:06.318387 etcd-wrapper[1791]: d557676654e5: Pull complete Sep 5 09:57:06.333192 etcd-wrapper[1791]: c8022d07192e: Pull complete Sep 5 09:57:06.401841 etcd-wrapper[1791]: 1069fc2daed1: Verifying Checksum Sep 5 09:57:06.445204 etcd-wrapper[1791]: b40161cd83fc: Verifying Checksum Sep 5 09:57:06.445204 etcd-wrapper[1791]: b40161cd83fc: Download complete Sep 5 09:57:06.447114 etcd-wrapper[1791]: d858cbc252ad: Verifying Checksum Sep 5 09:57:06.447114 etcd-wrapper[1791]: d858cbc252ad: Download complete Sep 5 09:57:06.460345 etcd-wrapper[1791]: d858cbc252ad: Pull complete Sep 5 09:57:06.476569 etcd-wrapper[1791]: 1069fc2daed1: Pull complete Sep 5 09:57:06.491625 etcd-wrapper[1791]: b40161cd83fc: Pull complete Sep 5 09:57:06.665010 etcd-wrapper[1791]: 5318d93a3a65: Verifying Checksum Sep 5 09:57:06.665010 etcd-wrapper[1791]: 5318d93a3a65: Download complete Sep 5 09:57:06.678660 etcd-wrapper[1791]: 5318d93a3a65: Pull complete Sep 5 09:57:06.722406 etcd-wrapper[1791]: 307c1adadb60: Verifying Checksum Sep 5 09:57:06.742238 etcd-wrapper[1791]: 307c1adadb60: Pull complete Sep 5 09:57:06.843231 etcd-wrapper[1791]: f9b3c65df792: Verifying Checksum Sep 5 09:57:06.843231 etcd-wrapper[1791]: f9b3c65df792: Download complete Sep 5 09:57:06.962564 systemd[1]: var-lib-docker-overlay2-220517fb78a8ca7407270f1adff7b2c99ea46b46bf8cba314b17f7e3619cafff-merged.mount: Deactivated successfully. Sep 5 09:57:06.975012 etcd-wrapper[1791]: f9b3c65df792: Pull complete Sep 5 09:57:07.088874 etcd-wrapper[1791]: d5372e382b07: Verifying Checksum Sep 5 09:57:07.089121 etcd-wrapper[1791]: d5372e382b07: Download complete Sep 5 09:57:07.092904 etcd-wrapper[1791]: 5709b4a82c35: Verifying Checksum Sep 5 09:57:07.092904 etcd-wrapper[1791]: 5709b4a82c35: Download complete Sep 5 09:57:07.149753 etcd-wrapper[1791]: 9c3b5253dddc: Verifying Checksum Sep 5 09:57:07.149753 etcd-wrapper[1791]: 9c3b5253dddc: Download complete Sep 5 09:57:07.170828 systemd[1]: var-lib-docker-overlay2-f6464f23f757902c77ed40a5cdd202077fa5b41e61c0da8c15425beb553e9a4d-merged.mount: Deactivated successfully. Sep 5 09:57:07.204713 etcd-wrapper[1791]: 5709b4a82c35: Pull complete Sep 5 09:57:07.297782 systemd[1]: var-lib-docker-overlay2-6731a7b4cac722861cdbdcb643160ff3351519e67045736b545f7d09510bcd42-merged.mount: Deactivated successfully. Sep 5 09:57:07.323062 etcd-wrapper[1791]: d5372e382b07: Pull complete Sep 5 09:57:07.339975 etcd-wrapper[1791]: 9c3b5253dddc: Pull complete Sep 5 09:57:07.356651 etcd-wrapper[1791]: 7a57323f7551: Verifying Checksum Sep 5 09:57:07.356651 etcd-wrapper[1791]: 7a57323f7551: Download complete Sep 5 09:57:07.369219 etcd-wrapper[1791]: 7a57323f7551: Pull complete Sep 5 09:57:07.374886 etcd-wrapper[1791]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Sep 5 09:57:07.376930 etcd-wrapper[1791]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Sep 5 09:57:07.415976 containerd[1473]: time="2025-09-05T09:57:07.415924430Z" level=info msg="connecting to shim 17a1a1143e9a4705c39976c310d7a3acbb5e310c0985a7af3e418fff44a53f88" address="unix:///run/containerd/s/a7e5a31faa9aa5fc37ae496da842394010f12ce070324708ee99e9cf1b230ff0" namespace=moby protocol=ttrpc version=3 Sep 5 09:57:07.441874 systemd[1]: Started docker-17a1a1143e9a4705c39976c310d7a3acbb5e310c0985a7af3e418fff44a53f88.scope - libcontainer container 17a1a1143e9a4705c39976c310d7a3acbb5e310c0985a7af3e418fff44a53f88. Sep 5 09:57:07.453223 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 09:57:07.493297 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.493010Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 5 09:57:07.493520 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.493246Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"5e2f5cea845142a883fa3081cae2b1e8"} Sep 5 09:57:07.493520 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.493322Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 5 09:57:07.493520 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.493337Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Sep 5 09:57:07.493520 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.493342Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 5 09:57:07.493520 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.493360Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 5 09:57:07.493520 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.493407Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 5 09:57:07.493841 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.493420Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.0.0.116:2379"]} Sep 5 09:57:07.493841 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.493568Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 5 09:57:07.493841 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.493603Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Sep 5 09:57:07.494136 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.494029Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 5 09:57:07.494289 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.494167Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"5e2f5cea845142a883fa3081cae2b1e8","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.116:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"5e2f5cea845142a883fa3081cae2b1e8=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 5 09:57:07.496506 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.496347Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.86744ms"} Sep 5 09:57:07.499049 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.498915Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Sep 5 09:57:07.499239 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.499106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Sep 5 09:57:07.499239 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.499126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Sep 5 09:57:07.499239 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.499134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 5 09:57:07.499239 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.499142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Sep 5 09:57:07.499507 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.499183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 5 09:57:07.501335 etcd-wrapper[1791]: {"level":"warn","ts":"2025-09-05T09:57:07.501189Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Sep 5 09:57:07.502031 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.501927Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Sep 5 09:57:07.502562 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.502422Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Sep 5 09:57:07.503248 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.502954Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Sep 5 09:57:07.503248 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.503116Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 5 09:57:07.503657 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.503387Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Sep 5 09:57:07.503657 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.503425Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Sep 5 09:57:07.503657 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.503463Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Sep 5 09:57:07.503657 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.503471Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Sep 5 09:57:07.504888 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.504763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 5 09:57:07.505266 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.504933Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Sep 5 09:57:07.505464 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.505354Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Sep 5 09:57:07.505602 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.505373Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Sep 5 09:57:07.505602 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.505406Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.116:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.899914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.899940Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.899963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.899974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.899986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.899994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Sep 5 09:57:07.900219 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.900000Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Sep 5 09:57:07.900628 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.900475Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Sep 5 09:57:07.901043 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.900829Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:5e2f5cea845142a883fa3081cae2b1e8 ClientURLs:[http://10.0.0.116:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Sep 5 09:57:07.901154 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.900961Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Sep 5 09:57:07.901595 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.900996Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Sep 5 09:57:07.901595 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.901013Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Sep 5 09:57:07.901595 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.901050Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 5 09:57:07.901595 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.901067Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Sep 5 09:57:07.901776 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.901259Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Sep 5 09:57:07.901776 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.901367Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 5 09:57:07.901840 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 5 09:57:07.903032 etcd-wrapper[1791]: {"level":"info","ts":"2025-09-05T09:57:07.902680Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Sep 5 09:57:07.903067 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 5 09:57:07.904078 systemd[1]: Startup finished in 1.992s (kernel) + 3.695s (initrd) + 6.658s (userspace) = 12.346s. Sep 5 09:57:09.901240 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 5 09:57:09.902280 systemd[1]: Started sshd@0-10.0.0.116:22-10.0.0.1:50236.service - OpenSSH per-connection server daemon (10.0.0.1:50236). Sep 5 09:57:09.976317 sshd[1945]: Accepted publickey for core from 10.0.0.1 port 50236 ssh2: RSA SHA256:tOLGnqbHtWB8N54cVj3NnMRYRG5rvN1cVtXYUnow34E Sep 5 09:57:09.977877 sshd-session[1945]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 09:57:09.983381 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 5 09:57:09.984324 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 5 09:57:09.989238 systemd-logind[1422]: New session 1 of user core. Sep 5 09:57:09.998336 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 5 09:57:10.000368 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 5 09:57:10.011393 (systemd)[1950]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 5 09:57:10.013586 systemd-logind[1422]: New session c1 of user core. Sep 5 09:57:10.109342 systemd[1950]: Queued start job for default target default.target. Sep 5 09:57:10.121594 systemd[1950]: Created slice app.slice - User Application Slice. Sep 5 09:57:10.121622 systemd[1950]: Reached target paths.target - Paths. Sep 5 09:57:10.121652 systemd[1950]: Reached target timers.target - Timers. Sep 5 09:57:10.122696 systemd[1950]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 5 09:57:10.130716 systemd[1950]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 5 09:57:10.130787 systemd[1950]: Reached target sockets.target - Sockets. Sep 5 09:57:10.130820 systemd[1950]: Reached target basic.target - Basic System. Sep 5 09:57:10.130846 systemd[1950]: Reached target default.target - Main User Target. Sep 5 09:57:10.130868 systemd[1950]: Startup finished in 112ms. Sep 5 09:57:10.131078 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 5 09:57:10.132357 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 5 09:57:10.136147 sshd[1958]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 09:57:10.192933 systemd[1]: Started sshd@1-10.0.0.116:22-10.0.0.1:40948.service - OpenSSH per-connection server daemon (10.0.0.1:40948). Sep 5 09:57:10.237586 sshd[1961]: Accepted publickey for core from 10.0.0.1 port 40948 ssh2: RSA SHA256:tOLGnqbHtWB8N54cVj3NnMRYRG5rvN1cVtXYUnow34E Sep 5 09:57:10.238655 sshd-session[1961]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 09:57:10.242945 systemd-logind[1422]: New session 2 of user core. Sep 5 09:57:10.257864 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 5 09:57:10.260725 sshd[1964]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 09:57:10.306683 sshd[1964]: Connection closed by 10.0.0.1 port 40948 Sep 5 09:57:10.307105 sshd-session[1961]: pam_unix(sshd:session): session closed for user core Sep 5 09:57:10.314425 systemd[1]: sshd@1-10.0.0.116:22-10.0.0.1:40948.service: Deactivated successfully. Sep 5 09:57:10.317219 systemd[1]: session-2.scope: Deactivated successfully. Sep 5 09:57:10.318873 systemd-logind[1422]: Session 2 logged out. Waiting for processes to exit. Sep 5 09:57:10.320673 systemd[1]: Started sshd@2-10.0.0.116:22-10.0.0.1:40950.service - OpenSSH per-connection server daemon (10.0.0.1:40950). Sep 5 09:57:10.321988 systemd-logind[1422]: Removed session 2. Sep 5 09:57:10.379491 sshd[1970]: Accepted publickey for core from 10.0.0.1 port 40950 ssh2: RSA SHA256:tOLGnqbHtWB8N54cVj3NnMRYRG5rvN1cVtXYUnow34E Sep 5 09:57:10.380506 sshd-session[1970]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 09:57:10.384429 systemd-logind[1422]: New session 3 of user core. Sep 5 09:57:10.394919 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 5 09:57:10.398348 sshd[1973]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 09:57:10.441316 sshd[1973]: Connection closed by 10.0.0.1 port 40950 Sep 5 09:57:10.441553 sshd-session[1970]: pam_unix(sshd:session): session closed for user core Sep 5 09:57:10.450417 systemd[1]: sshd@2-10.0.0.116:22-10.0.0.1:40950.service: Deactivated successfully. Sep 5 09:57:10.452960 systemd[1]: session-3.scope: Deactivated successfully. Sep 5 09:57:10.453597 systemd-logind[1422]: Session 3 logged out. Waiting for processes to exit. Sep 5 09:57:10.455607 systemd[1]: Started sshd@3-10.0.0.116:22-10.0.0.1:40958.service - OpenSSH per-connection server daemon (10.0.0.1:40958). Sep 5 09:57:10.456632 systemd-logind[1422]: Removed session 3. Sep 5 09:57:10.501415 sshd[1979]: Accepted publickey for core from 10.0.0.1 port 40958 ssh2: RSA SHA256:tOLGnqbHtWB8N54cVj3NnMRYRG5rvN1cVtXYUnow34E Sep 5 09:57:10.502413 sshd-session[1979]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 09:57:10.506384 systemd-logind[1422]: New session 4 of user core. Sep 5 09:57:10.513908 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 5 09:57:10.517463 sshd[1982]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 09:57:10.564291 sshd[1982]: Connection closed by 10.0.0.1 port 40958 Sep 5 09:57:10.564556 sshd-session[1979]: pam_unix(sshd:session): session closed for user core Sep 5 09:57:10.582567 systemd[1]: sshd@3-10.0.0.116:22-10.0.0.1:40958.service: Deactivated successfully. Sep 5 09:57:10.585134 systemd[1]: session-4.scope: Deactivated successfully. Sep 5 09:57:10.587240 systemd-logind[1422]: Session 4 logged out. Waiting for processes to exit. Sep 5 09:57:10.589599 systemd[1]: Started sshd@4-10.0.0.116:22-10.0.0.1:40974.service - OpenSSH per-connection server daemon (10.0.0.1:40974). Sep 5 09:57:10.590201 systemd-logind[1422]: Removed session 4. Sep 5 09:57:10.646778 sshd[1988]: Accepted publickey for core from 10.0.0.1 port 40974 ssh2: RSA SHA256:tOLGnqbHtWB8N54cVj3NnMRYRG5rvN1cVtXYUnow34E Sep 5 09:57:10.647893 sshd-session[1988]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 09:57:10.651792 systemd-logind[1422]: New session 5 of user core. Sep 5 09:57:10.666904 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 5 09:57:10.669896 sshd[1991]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core