Dec 16 12:28:40.786785 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 16 12:28:40.786809 kernel: Linux version 6.12.61-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 Dec 12 15:20:48 -00 2025 Dec 16 12:28:40.786819 kernel: KASLR enabled Dec 16 12:28:40.786825 kernel: efi: EFI v2.7 by EDK II Dec 16 12:28:40.786831 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Dec 16 12:28:40.786837 kernel: random: crng init done Dec 16 12:28:40.786859 kernel: secureboot: Secure boot disabled Dec 16 12:28:40.786865 kernel: ACPI: Early table checksum verification disabled Dec 16 12:28:40.786871 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Dec 16 12:28:40.786879 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 16 12:28:40.786886 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786892 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786898 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786904 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786911 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786919 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786926 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786932 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786938 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:28:40.786944 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 16 12:28:40.786950 kernel: ACPI: Use ACPI SPCR as default console: Yes Dec 16 12:28:40.786956 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:28:40.786962 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Dec 16 12:28:40.786968 kernel: Zone ranges: Dec 16 12:28:40.786974 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:28:40.786981 kernel: DMA32 empty Dec 16 12:28:40.786987 kernel: Normal empty Dec 16 12:28:40.786992 kernel: Device empty Dec 16 12:28:40.786998 kernel: Movable zone start for each node Dec 16 12:28:40.787004 kernel: Early memory node ranges Dec 16 12:28:40.787010 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Dec 16 12:28:40.787016 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Dec 16 12:28:40.787022 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Dec 16 12:28:40.787028 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Dec 16 12:28:40.787033 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Dec 16 12:28:40.787039 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Dec 16 12:28:40.787045 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Dec 16 12:28:40.787052 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Dec 16 12:28:40.787058 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Dec 16 12:28:40.787064 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 16 12:28:40.787073 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 16 12:28:40.787079 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 16 12:28:40.787085 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 16 12:28:40.787093 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:28:40.787100 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Dec 16 12:28:40.787106 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Dec 16 12:28:40.787112 kernel: psci: probing for conduit method from ACPI. Dec 16 12:28:40.787119 kernel: psci: PSCIv1.1 detected in firmware. Dec 16 12:28:40.787125 kernel: psci: Using standard PSCI v0.2 function IDs Dec 16 12:28:40.787131 kernel: psci: Trusted OS migration not required Dec 16 12:28:40.787138 kernel: psci: SMC Calling Convention v1.1 Dec 16 12:28:40.787144 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Dec 16 12:28:40.787151 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Dec 16 12:28:40.787162 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Dec 16 12:28:40.787169 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 16 12:28:40.787175 kernel: Detected PIPT I-cache on CPU0 Dec 16 12:28:40.787181 kernel: CPU features: detected: GIC system register CPU interface Dec 16 12:28:40.787188 kernel: CPU features: detected: Spectre-v4 Dec 16 12:28:40.787194 kernel: CPU features: detected: Spectre-BHB Dec 16 12:28:40.787200 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 16 12:28:40.787207 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 16 12:28:40.787213 kernel: CPU features: detected: ARM erratum 1418040 Dec 16 12:28:40.787219 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 16 12:28:40.787226 kernel: alternatives: applying boot alternatives Dec 16 12:28:40.787233 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=361f5baddf90aee3bc7ee7e9be879bc0cc94314f224faa1e2791d9b44cd3ec52 Dec 16 12:28:40.787241 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 16 12:28:40.787247 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 16 12:28:40.787254 kernel: Fallback order for Node 0: 0 Dec 16 12:28:40.787260 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Dec 16 12:28:40.787266 kernel: Policy zone: DMA Dec 16 12:28:40.787273 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 16 12:28:40.787279 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Dec 16 12:28:40.787285 kernel: software IO TLB: area num 4. Dec 16 12:28:40.787291 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Dec 16 12:28:40.787298 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Dec 16 12:28:40.787304 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 16 12:28:40.787312 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 16 12:28:40.787319 kernel: rcu: RCU event tracing is enabled. Dec 16 12:28:40.787325 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 16 12:28:40.787332 kernel: Trampoline variant of Tasks RCU enabled. Dec 16 12:28:40.787338 kernel: Tracing variant of Tasks RCU enabled. Dec 16 12:28:40.787345 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 16 12:28:40.787351 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 16 12:28:40.788917 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 16 12:28:40.788926 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 16 12:28:40.788933 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 16 12:28:40.788940 kernel: GICv3: 256 SPIs implemented Dec 16 12:28:40.788954 kernel: GICv3: 0 Extended SPIs implemented Dec 16 12:28:40.788960 kernel: Root IRQ handler: gic_handle_irq Dec 16 12:28:40.788967 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Dec 16 12:28:40.788973 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Dec 16 12:28:40.788980 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 16 12:28:40.788986 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 16 12:28:40.788993 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Dec 16 12:28:40.789000 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Dec 16 12:28:40.789006 kernel: GICv3: using LPI property table @0x0000000040130000 Dec 16 12:28:40.789013 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Dec 16 12:28:40.789019 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 16 12:28:40.789026 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:28:40.789034 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 16 12:28:40.789041 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 16 12:28:40.789048 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 16 12:28:40.789059 kernel: arm-pv: using stolen time PV Dec 16 12:28:40.789066 kernel: Console: colour dummy device 80x25 Dec 16 12:28:40.789072 kernel: ACPI: Core revision 20240827 Dec 16 12:28:40.789080 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 16 12:28:40.789094 kernel: pid_max: default: 32768 minimum: 301 Dec 16 12:28:40.789100 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Dec 16 12:28:40.789107 kernel: landlock: Up and running. Dec 16 12:28:40.789115 kernel: SELinux: Initializing. Dec 16 12:28:40.789122 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:28:40.789129 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:28:40.789135 kernel: rcu: Hierarchical SRCU implementation. Dec 16 12:28:40.789142 kernel: rcu: Max phase no-delay instances is 400. Dec 16 12:28:40.789149 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Dec 16 12:28:40.789155 kernel: Remapping and enabling EFI services. Dec 16 12:28:40.789162 kernel: smp: Bringing up secondary CPUs ... Dec 16 12:28:40.789169 kernel: Detected PIPT I-cache on CPU1 Dec 16 12:28:40.789182 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 16 12:28:40.789189 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Dec 16 12:28:40.789196 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:28:40.789205 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 16 12:28:40.789212 kernel: Detected PIPT I-cache on CPU2 Dec 16 12:28:40.789219 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 16 12:28:40.789226 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Dec 16 12:28:40.789233 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:28:40.789241 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 16 12:28:40.789248 kernel: Detected PIPT I-cache on CPU3 Dec 16 12:28:40.789255 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 16 12:28:40.789262 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Dec 16 12:28:40.789269 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:28:40.789276 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 16 12:28:40.789283 kernel: smp: Brought up 1 node, 4 CPUs Dec 16 12:28:40.789290 kernel: SMP: Total of 4 processors activated. Dec 16 12:28:40.789296 kernel: CPU: All CPU(s) started at EL1 Dec 16 12:28:40.789305 kernel: CPU features: detected: 32-bit EL0 Support Dec 16 12:28:40.789312 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 16 12:28:40.789319 kernel: CPU features: detected: Common not Private translations Dec 16 12:28:40.789326 kernel: CPU features: detected: CRC32 instructions Dec 16 12:28:40.789333 kernel: CPU features: detected: Enhanced Virtualization Traps Dec 16 12:28:40.789340 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 16 12:28:40.789347 kernel: CPU features: detected: LSE atomic instructions Dec 16 12:28:40.789398 kernel: CPU features: detected: Privileged Access Never Dec 16 12:28:40.789408 kernel: CPU features: detected: RAS Extension Support Dec 16 12:28:40.789418 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 16 12:28:40.789425 kernel: alternatives: applying system-wide alternatives Dec 16 12:28:40.789432 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Dec 16 12:28:40.789440 kernel: Memory: 2423776K/2572288K available (11200K kernel code, 2456K rwdata, 9084K rodata, 39552K init, 1038K bss, 126176K reserved, 16384K cma-reserved) Dec 16 12:28:40.789447 kernel: devtmpfs: initialized Dec 16 12:28:40.789454 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 16 12:28:40.789461 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 16 12:28:40.789468 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 16 12:28:40.789475 kernel: 0 pages in range for non-PLT usage Dec 16 12:28:40.789483 kernel: 508400 pages in range for PLT usage Dec 16 12:28:40.789490 kernel: pinctrl core: initialized pinctrl subsystem Dec 16 12:28:40.789497 kernel: SMBIOS 3.0.0 present. Dec 16 12:28:40.789504 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 16 12:28:40.789511 kernel: DMI: Memory slots populated: 1/1 Dec 16 12:28:40.789518 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 16 12:28:40.789524 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 16 12:28:40.789532 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 16 12:28:40.789539 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 16 12:28:40.789547 kernel: audit: initializing netlink subsys (disabled) Dec 16 12:28:40.789555 kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Dec 16 12:28:40.789562 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 16 12:28:40.789569 kernel: cpuidle: using governor menu Dec 16 12:28:40.789576 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 16 12:28:40.789582 kernel: ASID allocator initialised with 32768 entries Dec 16 12:28:40.789589 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 16 12:28:40.789597 kernel: Serial: AMBA PL011 UART driver Dec 16 12:28:40.789604 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 16 12:28:40.789612 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 16 12:28:40.789619 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 16 12:28:40.789626 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 16 12:28:40.789633 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 16 12:28:40.789641 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 16 12:28:40.789648 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 16 12:28:40.789655 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 16 12:28:40.789662 kernel: ACPI: Added _OSI(Module Device) Dec 16 12:28:40.789669 kernel: ACPI: Added _OSI(Processor Device) Dec 16 12:28:40.789677 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 16 12:28:40.789685 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 16 12:28:40.789691 kernel: ACPI: Interpreter enabled Dec 16 12:28:40.789699 kernel: ACPI: Using GIC for interrupt routing Dec 16 12:28:40.789706 kernel: ACPI: MCFG table detected, 1 entries Dec 16 12:28:40.789712 kernel: ACPI: CPU0 has been hot-added Dec 16 12:28:40.789719 kernel: ACPI: CPU1 has been hot-added Dec 16 12:28:40.789726 kernel: ACPI: CPU2 has been hot-added Dec 16 12:28:40.789733 kernel: ACPI: CPU3 has been hot-added Dec 16 12:28:40.789740 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 16 12:28:40.789749 kernel: printk: legacy console [ttyAMA0] enabled Dec 16 12:28:40.789757 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 16 12:28:40.789988 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 16 12:28:40.790062 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 16 12:28:40.790123 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 16 12:28:40.790180 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 16 12:28:40.790238 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 16 12:28:40.790252 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 16 12:28:40.790260 kernel: PCI host bridge to bus 0000:00 Dec 16 12:28:40.790329 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 16 12:28:40.790398 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 16 12:28:40.790453 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 16 12:28:40.790504 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 16 12:28:40.790581 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Dec 16 12:28:40.790654 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Dec 16 12:28:40.790731 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Dec 16 12:28:40.790798 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Dec 16 12:28:40.790890 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Dec 16 12:28:40.791058 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Dec 16 12:28:40.791153 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Dec 16 12:28:40.791234 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Dec 16 12:28:40.791316 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 16 12:28:40.791377 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 16 12:28:40.791430 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 16 12:28:40.791440 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 16 12:28:40.791447 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 16 12:28:40.791454 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 16 12:28:40.791461 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 16 12:28:40.791471 kernel: iommu: Default domain type: Translated Dec 16 12:28:40.791478 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 16 12:28:40.791485 kernel: efivars: Registered efivars operations Dec 16 12:28:40.791492 kernel: vgaarb: loaded Dec 16 12:28:40.791499 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 16 12:28:40.791506 kernel: VFS: Disk quotas dquot_6.6.0 Dec 16 12:28:40.791513 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 16 12:28:40.791520 kernel: pnp: PnP ACPI init Dec 16 12:28:40.791607 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 16 12:28:40.791621 kernel: pnp: PnP ACPI: found 1 devices Dec 16 12:28:40.791630 kernel: NET: Registered PF_INET protocol family Dec 16 12:28:40.791639 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 16 12:28:40.791647 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 16 12:28:40.791656 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 16 12:28:40.791665 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 16 12:28:40.791676 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 16 12:28:40.791685 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 16 12:28:40.791696 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:28:40.791704 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:28:40.791713 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 16 12:28:40.791721 kernel: PCI: CLS 0 bytes, default 64 Dec 16 12:28:40.791729 kernel: kvm [1]: HYP mode not available Dec 16 12:28:40.791737 kernel: Initialise system trusted keyrings Dec 16 12:28:40.791745 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 16 12:28:40.791753 kernel: Key type asymmetric registered Dec 16 12:28:40.791760 kernel: Asymmetric key parser 'x509' registered Dec 16 12:28:40.791772 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Dec 16 12:28:40.791780 kernel: io scheduler mq-deadline registered Dec 16 12:28:40.791789 kernel: io scheduler kyber registered Dec 16 12:28:40.791798 kernel: io scheduler bfq registered Dec 16 12:28:40.791806 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 16 12:28:40.791817 kernel: ACPI: button: Power Button [PWRB] Dec 16 12:28:40.791824 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 16 12:28:40.791945 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 16 12:28:40.792012 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 16 12:28:40.792026 kernel: thunder_xcv, ver 1.0 Dec 16 12:28:40.792033 kernel: thunder_bgx, ver 1.0 Dec 16 12:28:40.792039 kernel: nicpf, ver 1.0 Dec 16 12:28:40.792046 kernel: nicvf, ver 1.0 Dec 16 12:28:40.792135 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 16 12:28:40.792194 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-16T12:28:40 UTC (1765888120) Dec 16 12:28:40.792203 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 16 12:28:40.792210 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Dec 16 12:28:40.792220 kernel: watchdog: NMI not fully supported Dec 16 12:28:40.792227 kernel: watchdog: Hard watchdog permanently disabled Dec 16 12:28:40.792233 kernel: NET: Registered PF_INET6 protocol family Dec 16 12:28:40.792241 kernel: Segment Routing with IPv6 Dec 16 12:28:40.792247 kernel: In-situ OAM (IOAM) with IPv6 Dec 16 12:28:40.792255 kernel: NET: Registered PF_PACKET protocol family Dec 16 12:28:40.792262 kernel: Key type dns_resolver registered Dec 16 12:28:40.792268 kernel: registered taskstats version 1 Dec 16 12:28:40.792275 kernel: Loading compiled-in X.509 certificates Dec 16 12:28:40.792283 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.61-flatcar: 92f3a94fb747a7ba7cbcfde1535be91b86f9429a' Dec 16 12:28:40.792291 kernel: Demotion targets for Node 0: null Dec 16 12:28:40.792298 kernel: Key type .fscrypt registered Dec 16 12:28:40.792304 kernel: Key type fscrypt-provisioning registered Dec 16 12:28:40.792311 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 16 12:28:40.792318 kernel: ima: Allocated hash algorithm: sha1 Dec 16 12:28:40.792326 kernel: ima: No architecture policies found Dec 16 12:28:40.792333 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 16 12:28:40.792340 kernel: clk: Disabling unused clocks Dec 16 12:28:40.792347 kernel: PM: genpd: Disabling unused power domains Dec 16 12:28:40.792364 kernel: Warning: unable to open an initial console. Dec 16 12:28:40.792372 kernel: Freeing unused kernel memory: 39552K Dec 16 12:28:40.792380 kernel: Run /init as init process Dec 16 12:28:40.792387 kernel: with arguments: Dec 16 12:28:40.792394 kernel: /init Dec 16 12:28:40.792401 kernel: with environment: Dec 16 12:28:40.792408 kernel: HOME=/ Dec 16 12:28:40.792415 kernel: TERM=linux Dec 16 12:28:40.792423 systemd[1]: Successfully made /usr/ read-only. Dec 16 12:28:40.792435 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) Dec 16 12:28:40.792444 systemd[1]: Detected virtualization kvm. Dec 16 12:28:40.792451 systemd[1]: Detected architecture arm64. Dec 16 12:28:40.792458 systemd[1]: Running in initrd. Dec 16 12:28:40.792466 systemd[1]: No hostname configured, using default hostname. Dec 16 12:28:40.792473 systemd[1]: Hostname set to . Dec 16 12:28:40.792481 systemd[1]: Initializing machine ID from VM UUID. Dec 16 12:28:40.792489 systemd[1]: Queued start job for default target initrd.target. Dec 16 12:28:40.792497 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:28:40.792505 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:28:40.792513 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Dec 16 12:28:40.792520 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:28:40.792528 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 16 12:28:40.792537 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 16 12:28:40.792547 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Dec 16 12:28:40.792554 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Dec 16 12:28:40.792562 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:28:40.792570 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:28:40.792578 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:28:40.792586 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:28:40.792593 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:28:40.792601 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:28:40.792611 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:28:40.792618 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:28:40.792626 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 16 12:28:40.792633 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Dec 16 12:28:40.792641 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:28:40.792649 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:28:40.792656 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:28:40.792664 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:28:40.792673 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 16 12:28:40.792681 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:28:40.792688 systemd[1]: Finished network-cleanup.service - Network Cleanup. Dec 16 12:28:40.792696 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). Dec 16 12:28:40.792704 systemd[1]: Starting systemd-fsck-usr.service... Dec 16 12:28:40.792712 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:28:40.792719 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:28:40.792727 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:28:40.792735 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 16 12:28:40.792744 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:28:40.792752 systemd[1]: Finished systemd-fsck-usr.service. Dec 16 12:28:40.792780 systemd-journald[247]: Collecting audit messages is disabled. Dec 16 12:28:40.792801 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 16 12:28:40.792810 systemd-journald[247]: Journal started Dec 16 12:28:40.792829 systemd-journald[247]: Runtime Journal (/run/log/journal/6b094bea78054e9ab4b8d9e201e14416) is 6M, max 48.5M, 42.4M free. Dec 16 12:28:40.783316 systemd-modules-load[248]: Inserted module 'overlay' Dec 16 12:28:40.794605 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:28:40.797614 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:28:40.800966 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:28:40.804926 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 16 12:28:40.803726 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 16 12:28:40.807141 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:28:40.812798 kernel: Bridge firewalling registered Dec 16 12:28:40.809189 systemd-modules-load[248]: Inserted module 'br_netfilter' Dec 16 12:28:40.811691 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:28:40.818010 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:28:40.821773 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:28:40.827935 systemd-tmpfiles[268]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Dec 16 12:28:40.831813 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:28:40.833585 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:28:40.836906 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:28:40.839113 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:28:40.842243 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 16 12:28:40.846474 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:28:40.867415 dracut-cmdline[289]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=361f5baddf90aee3bc7ee7e9be879bc0cc94314f224faa1e2791d9b44cd3ec52 Dec 16 12:28:40.882177 systemd-resolved[290]: Positive Trust Anchors: Dec 16 12:28:40.882199 systemd-resolved[290]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:28:40.882231 systemd-resolved[290]: 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 Dec 16 12:28:40.887255 systemd-resolved[290]: Defaulting to hostname 'linux'. Dec 16 12:28:40.888340 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:28:40.892189 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:28:40.949876 kernel: SCSI subsystem initialized Dec 16 12:28:40.954857 kernel: Loading iSCSI transport class v2.0-870. Dec 16 12:28:40.962870 kernel: iscsi: registered transport (tcp) Dec 16 12:28:40.975908 kernel: iscsi: registered transport (qla4xxx) Dec 16 12:28:40.975947 kernel: QLogic iSCSI HBA Driver Dec 16 12:28:40.993365 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:28:41.015134 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:28:41.017459 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:28:41.064551 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 16 12:28:41.067149 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 16 12:28:41.138888 kernel: raid6: neonx8 gen() 15647 MB/s Dec 16 12:28:41.155876 kernel: raid6: neonx4 gen() 15779 MB/s Dec 16 12:28:41.172992 kernel: raid6: neonx2 gen() 13202 MB/s Dec 16 12:28:41.189892 kernel: raid6: neonx1 gen() 10403 MB/s Dec 16 12:28:41.206883 kernel: raid6: int64x8 gen() 6874 MB/s Dec 16 12:28:41.223885 kernel: raid6: int64x4 gen() 7343 MB/s Dec 16 12:28:41.240888 kernel: raid6: int64x2 gen() 6099 MB/s Dec 16 12:28:41.258007 kernel: raid6: int64x1 gen() 5028 MB/s Dec 16 12:28:41.258057 kernel: raid6: using algorithm neonx4 gen() 15779 MB/s Dec 16 12:28:41.275984 kernel: raid6: .... xor() 12266 MB/s, rmw enabled Dec 16 12:28:41.276049 kernel: raid6: using neon recovery algorithm Dec 16 12:28:41.283400 kernel: xor: measuring software checksum speed Dec 16 12:28:41.283460 kernel: 8regs : 21584 MB/sec Dec 16 12:28:41.283481 kernel: 32regs : 21681 MB/sec Dec 16 12:28:41.283490 kernel: arm64_neon : 24564 MB/sec Dec 16 12:28:41.283499 kernel: xor: using function: arm64_neon (24564 MB/sec) Dec 16 12:28:41.339895 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 16 12:28:41.348960 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:28:41.355633 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:28:41.384641 systemd-udevd[501]: Using default interface naming scheme 'v255'. Dec 16 12:28:41.388950 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:28:41.391412 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 16 12:28:41.424054 dracut-pre-trigger[509]: rd.md=0: removing MD RAID activation Dec 16 12:28:41.450248 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:28:41.452664 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:28:41.532630 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:28:41.534552 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 16 12:28:41.608861 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Dec 16 12:28:41.614450 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 16 12:28:41.616297 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:28:41.616433 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:28:41.623906 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:28:41.625758 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:28:41.628856 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:28:41.657117 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:28:41.666411 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Dec 16 12:28:41.669183 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 16 12:28:41.678079 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Dec 16 12:28:41.685226 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Dec 16 12:28:41.686411 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 16 12:28:41.694977 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 16 12:28:41.696111 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:28:41.697824 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:28:41.699998 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:28:41.702877 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 16 12:28:41.704806 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 16 12:28:41.741951 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:28:41.743887 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:28:42.752897 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:28:42.753863 disk-uuid[595]: The operation has completed successfully. Dec 16 12:28:42.798035 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 16 12:28:42.798172 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 16 12:28:42.819963 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Dec 16 12:28:42.853649 sh[612]: Success Dec 16 12:28:42.867182 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 16 12:28:42.867242 kernel: device-mapper: uevent: version 1.0.3 Dec 16 12:28:42.867261 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Dec 16 12:28:42.875874 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Dec 16 12:28:42.907669 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Dec 16 12:28:42.910765 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Dec 16 12:28:42.924750 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Dec 16 12:28:42.931607 kernel: BTRFS: device fsid 6d6d314d-b8a1-4727-8a34-8525e276a248 devid 1 transid 38 /dev/mapper/usr (253:0) scanned by mount (624) Dec 16 12:28:42.931656 kernel: BTRFS info (device dm-0): first mount of filesystem 6d6d314d-b8a1-4727-8a34-8525e276a248 Dec 16 12:28:42.931668 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:28:42.936862 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 16 12:28:42.936915 kernel: BTRFS info (device dm-0): enabling free space tree Dec 16 12:28:42.937823 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Dec 16 12:28:42.939055 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:28:42.940293 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Dec 16 12:28:42.941135 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Dec 16 12:28:42.942734 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Dec 16 12:28:42.969864 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (655) Dec 16 12:28:42.970574 kernel: BTRFS info (device vda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:28:42.971881 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:28:42.976564 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:28:42.976613 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:28:42.980859 kernel: BTRFS info (device vda6): last unmount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:28:42.981649 systemd[1]: Finished ignition-setup.service - Ignition (setup). Dec 16 12:28:42.985618 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Dec 16 12:28:43.060108 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:28:43.063903 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:28:43.100455 systemd-networkd[801]: lo: Link UP Dec 16 12:28:43.100467 systemd-networkd[801]: lo: Gained carrier Dec 16 12:28:43.101367 systemd-networkd[801]: Enumeration completed Dec 16 12:28:43.101489 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:28:43.102167 systemd-networkd[801]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:28:43.103788 ignition[703]: Ignition 2.22.0 Dec 16 12:28:43.102170 systemd-networkd[801]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:28:43.103794 ignition[703]: Stage: fetch-offline Dec 16 12:28:43.102832 systemd-networkd[801]: eth0: Link UP Dec 16 12:28:43.103825 ignition[703]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:28:43.102884 systemd[1]: Reached target network.target - Network. Dec 16 12:28:43.103832 ignition[703]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:28:43.102989 systemd-networkd[801]: eth0: Gained carrier Dec 16 12:28:43.103931 ignition[703]: parsed url from cmdline: "" Dec 16 12:28:43.102998 systemd-networkd[801]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:28:43.103934 ignition[703]: no config URL provided Dec 16 12:28:43.103939 ignition[703]: reading system config file "/usr/lib/ignition/user.ign" Dec 16 12:28:43.103945 ignition[703]: no config at "/usr/lib/ignition/user.ign" Dec 16 12:28:43.119901 systemd-networkd[801]: eth0: DHCPv4 address 10.0.0.63/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 16 12:28:43.103964 ignition[703]: op(1): [started] loading QEMU firmware config module Dec 16 12:28:43.103968 ignition[703]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 16 12:28:43.111190 ignition[703]: op(1): [finished] loading QEMU firmware config module Dec 16 12:28:43.122284 ignition[703]: parsing config with SHA512: 89e59b91ffd08e3b2c1d3839d56c77912f78f7db8ec80ff2c09890cb4203cba351285868a37ff5077632db9694aa0ca4498098d8cddde70069ab4dda3c4577d9 Dec 16 12:28:43.129099 unknown[703]: fetched base config from "system" Dec 16 12:28:43.129287 ignition[703]: fetch-offline: fetch-offline passed Dec 16 12:28:43.129113 unknown[703]: fetched user config from "qemu" Dec 16 12:28:43.129372 ignition[703]: Ignition finished successfully Dec 16 12:28:43.131817 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:28:43.133474 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Dec 16 12:28:43.134265 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Dec 16 12:28:43.167999 ignition[811]: Ignition 2.22.0 Dec 16 12:28:43.168019 ignition[811]: Stage: kargs Dec 16 12:28:43.168158 ignition[811]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:28:43.168167 ignition[811]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:28:43.168688 ignition[811]: kargs: kargs passed Dec 16 12:28:43.171440 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Dec 16 12:28:43.168731 ignition[811]: Ignition finished successfully Dec 16 12:28:43.173987 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Dec 16 12:28:43.211174 ignition[819]: Ignition 2.22.0 Dec 16 12:28:43.211193 ignition[819]: Stage: disks Dec 16 12:28:43.211355 ignition[819]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:28:43.214618 systemd[1]: Finished ignition-disks.service - Ignition (disks). Dec 16 12:28:43.211365 ignition[819]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:28:43.215624 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 16 12:28:43.211981 ignition[819]: disks: disks passed Dec 16 12:28:43.217202 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 16 12:28:43.212027 ignition[819]: Ignition finished successfully Dec 16 12:28:43.219286 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:28:43.220950 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:28:43.222460 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:28:43.225246 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 16 12:28:43.250846 systemd-fsck[828]: ROOT: clean, 15/553520 files, 52789/553472 blocks Dec 16 12:28:43.255906 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 16 12:28:43.259962 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 16 12:28:43.327866 kernel: EXT4-fs (vda9): mounted filesystem 895d7845-d0e8-43ae-a778-7804b473b868 r/w with ordered data mode. Quota mode: none. Dec 16 12:28:43.328601 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 16 12:28:43.330913 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 16 12:28:43.333552 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:28:43.335638 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 16 12:28:43.336576 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Dec 16 12:28:43.336619 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 16 12:28:43.336643 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:28:43.350954 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 16 12:28:43.354027 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 16 12:28:43.356437 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (836) Dec 16 12:28:43.356460 kernel: BTRFS info (device vda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:28:43.356469 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:28:43.359981 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:28:43.360010 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:28:43.361705 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:28:43.396001 initrd-setup-root[860]: cut: /sysroot/etc/passwd: No such file or directory Dec 16 12:28:43.400256 initrd-setup-root[867]: cut: /sysroot/etc/group: No such file or directory Dec 16 12:28:43.404237 initrd-setup-root[874]: cut: /sysroot/etc/shadow: No such file or directory Dec 16 12:28:43.407769 initrd-setup-root[881]: cut: /sysroot/etc/gshadow: No such file or directory Dec 16 12:28:43.480699 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 16 12:28:43.482670 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Dec 16 12:28:43.484235 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Dec 16 12:28:43.516871 kernel: BTRFS info (device vda6): last unmount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:28:43.529474 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Dec 16 12:28:43.543186 ignition[950]: INFO : Ignition 2.22.0 Dec 16 12:28:43.543186 ignition[950]: INFO : Stage: mount Dec 16 12:28:43.544714 ignition[950]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:28:43.544714 ignition[950]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:28:43.544714 ignition[950]: INFO : mount: mount passed Dec 16 12:28:43.544714 ignition[950]: INFO : Ignition finished successfully Dec 16 12:28:43.549494 systemd[1]: Finished ignition-mount.service - Ignition (mount). Dec 16 12:28:43.551430 systemd[1]: Starting ignition-files.service - Ignition (files)... Dec 16 12:28:43.929682 systemd[1]: sysroot-oem.mount: Deactivated successfully. Dec 16 12:28:43.931200 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:28:43.954876 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (962) Dec 16 12:28:43.957209 kernel: BTRFS info (device vda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:28:43.957254 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:28:43.960066 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:28:43.960109 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:28:43.961519 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:28:43.993333 ignition[979]: INFO : Ignition 2.22.0 Dec 16 12:28:43.993333 ignition[979]: INFO : Stage: files Dec 16 12:28:43.994894 ignition[979]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:28:43.994894 ignition[979]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:28:43.994894 ignition[979]: DEBUG : files: compiled without relabeling support, skipping Dec 16 12:28:43.994894 ignition[979]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 16 12:28:43.994894 ignition[979]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 16 12:28:44.000734 ignition[979]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 16 12:28:44.000734 ignition[979]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 16 12:28:44.000734 ignition[979]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 16 12:28:43.996852 unknown[979]: wrote ssh authorized keys file for user: core Dec 16 12:28:44.006070 ignition[979]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:28:44.006070 ignition[979]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:28:44.006070 ignition[979]: INFO : files: op(4): [started] processing unit "etcd-member.service" Dec 16 12:28:44.006070 ignition[979]: 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" Dec 16 12:28:44.014161 ignition[979]: 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" Dec 16 12:28:44.014161 ignition[979]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Dec 16 12:28:44.014161 ignition[979]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Dec 16 12:28:44.019573 ignition[979]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 16 12:28:44.019573 ignition[979]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 16 12:28:44.019573 ignition[979]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Dec 16 12:28:44.019573 ignition[979]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Dec 16 12:28:44.030687 ignition[979]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Dec 16 12:28:44.034358 ignition[979]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Dec 16 12:28:44.036871 ignition[979]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Dec 16 12:28:44.036871 ignition[979]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Dec 16 12:28:44.036871 ignition[979]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Dec 16 12:28:44.036871 ignition[979]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:28:44.036871 ignition[979]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:28:44.036871 ignition[979]: INFO : files: files passed Dec 16 12:28:44.036871 ignition[979]: INFO : Ignition finished successfully Dec 16 12:28:44.037612 systemd[1]: Finished ignition-files.service - Ignition (files). Dec 16 12:28:44.040150 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Dec 16 12:28:44.042192 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 16 12:28:44.057375 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 16 12:28:44.057482 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Dec 16 12:28:44.060827 initrd-setup-root-after-ignition[1007]: grep: /sysroot/oem/oem-release: No such file or directory Dec 16 12:28:44.062697 initrd-setup-root-after-ignition[1010]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:28:44.062697 initrd-setup-root-after-ignition[1010]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:28:44.066088 initrd-setup-root-after-ignition[1014]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:28:44.065412 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:28:44.068495 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Dec 16 12:28:44.070975 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 16 12:28:44.113320 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 16 12:28:44.113458 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 16 12:28:44.115384 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 16 12:28:44.116933 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 16 12:28:44.118479 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 16 12:28:44.119397 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 16 12:28:44.144873 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:28:44.147257 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 16 12:28:44.173089 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:28:44.175471 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:28:44.176686 systemd[1]: Stopped target timers.target - Timer Units. Dec 16 12:28:44.178387 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 16 12:28:44.178522 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:28:44.181270 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 16 12:28:44.183078 systemd[1]: Stopped target basic.target - Basic System. Dec 16 12:28:44.184617 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Dec 16 12:28:44.186215 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:28:44.187936 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 16 12:28:44.190003 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:28:44.191940 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 16 12:28:44.193877 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:28:44.195617 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 16 12:28:44.197390 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 16 12:28:44.199121 systemd[1]: Stopped target swap.target - Swaps. Dec 16 12:28:44.200578 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 16 12:28:44.200718 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:28:44.203135 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:28:44.204893 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:28:44.206770 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 16 12:28:44.209925 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:28:44.211094 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 16 12:28:44.211218 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 16 12:28:44.213771 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 16 12:28:44.213920 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:28:44.215823 systemd[1]: Stopped target paths.target - Path Units. Dec 16 12:28:44.217475 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 16 12:28:44.220961 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:28:44.222143 systemd[1]: Stopped target slices.target - Slice Units. Dec 16 12:28:44.224057 systemd[1]: Stopped target sockets.target - Socket Units. Dec 16 12:28:44.225571 systemd[1]: iscsid.socket: Deactivated successfully. Dec 16 12:28:44.225661 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:28:44.227033 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 16 12:28:44.227112 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:28:44.228547 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 16 12:28:44.228666 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:28:44.230408 systemd[1]: ignition-files.service: Deactivated successfully. Dec 16 12:28:44.230513 systemd[1]: Stopped ignition-files.service - Ignition (files). Dec 16 12:28:44.232815 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Dec 16 12:28:44.235599 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Dec 16 12:28:44.236633 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 16 12:28:44.236767 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:28:44.238617 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 16 12:28:44.238719 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:28:44.243994 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 16 12:28:44.245012 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 16 12:28:44.254475 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 16 12:28:44.258123 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 16 12:28:44.258286 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Dec 16 12:28:44.263180 ignition[1035]: INFO : Ignition 2.22.0 Dec 16 12:28:44.263180 ignition[1035]: INFO : Stage: umount Dec 16 12:28:44.265673 ignition[1035]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:28:44.265673 ignition[1035]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:28:44.265673 ignition[1035]: INFO : umount: umount passed Dec 16 12:28:44.265673 ignition[1035]: INFO : Ignition finished successfully Dec 16 12:28:44.266076 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 16 12:28:44.266180 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Dec 16 12:28:44.267725 systemd[1]: Stopped target network.target - Network. Dec 16 12:28:44.269367 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 16 12:28:44.269431 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Dec 16 12:28:44.270380 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 16 12:28:44.270425 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Dec 16 12:28:44.271927 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 16 12:28:44.271980 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Dec 16 12:28:44.273493 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 16 12:28:44.273536 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 16 12:28:44.275400 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 16 12:28:44.275454 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 16 12:28:44.277279 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Dec 16 12:28:44.278852 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Dec 16 12:28:44.285540 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 16 12:28:44.285657 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Dec 16 12:28:44.288619 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Dec 16 12:28:44.288904 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 16 12:28:44.288944 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:28:44.292651 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Dec 16 12:28:44.292917 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 16 12:28:44.293028 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Dec 16 12:28:44.295771 systemd[1]: Stopped target network-pre.target - Preparation for Network. Dec 16 12:28:44.297351 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 16 12:28:44.297394 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:28:44.299650 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Dec 16 12:28:44.300749 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 16 12:28:44.300808 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:28:44.302880 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 16 12:28:44.302921 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:28:44.305365 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 16 12:28:44.305501 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 16 12:28:44.307213 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:28:44.318576 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 16 12:28:44.318728 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:28:44.320489 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 16 12:28:44.320525 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 16 12:28:44.321951 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 16 12:28:44.321984 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:28:44.323728 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 16 12:28:44.323781 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:28:44.326487 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 16 12:28:44.326556 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 16 12:28:44.329926 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 16 12:28:44.329985 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:28:44.335487 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 16 12:28:44.337100 systemd[1]: systemd-network-generator.service: Deactivated successfully. Dec 16 12:28:44.337159 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:28:44.340212 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 16 12:28:44.340262 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:28:44.343045 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Dec 16 12:28:44.343093 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:28:44.346177 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 16 12:28:44.346223 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:28:44.348289 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:28:44.348337 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:28:44.351921 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 16 12:28:44.352022 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Dec 16 12:28:44.353903 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 16 12:28:44.353979 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 16 12:28:44.356291 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 16 12:28:44.358731 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 16 12:28:44.377987 systemd[1]: Switching root. Dec 16 12:28:44.420623 systemd-journald[247]: Journal stopped Dec 16 12:28:45.145326 systemd-journald[247]: Received SIGTERM from PID 1 (systemd). Dec 16 12:28:45.145405 kernel: SELinux: policy capability network_peer_controls=1 Dec 16 12:28:45.145422 kernel: SELinux: policy capability open_perms=1 Dec 16 12:28:45.145434 kernel: SELinux: policy capability extended_socket_class=1 Dec 16 12:28:45.145460 kernel: SELinux: policy capability always_check_network=0 Dec 16 12:28:45.145477 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 16 12:28:45.145486 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 16 12:28:45.145495 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 16 12:28:45.145505 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 16 12:28:45.145515 kernel: SELinux: policy capability userspace_initial_context=0 Dec 16 12:28:45.145526 kernel: audit: type=1403 audit(1765888124.509:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 16 12:28:45.145541 systemd[1]: Successfully loaded SELinux policy in 59.357ms. Dec 16 12:28:45.145558 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.581ms. Dec 16 12:28:45.145569 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) Dec 16 12:28:45.145580 systemd[1]: Detected virtualization kvm. Dec 16 12:28:45.145591 systemd[1]: Detected architecture arm64. Dec 16 12:28:45.145601 systemd[1]: Detected first boot. Dec 16 12:28:45.145611 systemd[1]: Initializing machine ID from VM UUID. Dec 16 12:28:45.145621 zram_generator::config[1089]: No configuration found. Dec 16 12:28:45.145635 kernel: NET: Registered PF_VSOCK protocol family Dec 16 12:28:45.145646 systemd[1]: Populated /etc with preset unit settings. Dec 16 12:28:45.145658 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Dec 16 12:28:45.145669 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 16 12:28:45.145679 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 16 12:28:45.145689 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 16 12:28:45.145701 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 16 12:28:45.145711 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 16 12:28:45.145721 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 16 12:28:45.145731 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 16 12:28:45.145743 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 16 12:28:45.145753 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 16 12:28:45.145764 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 16 12:28:45.145774 systemd[1]: Created slice user.slice - User and Session Slice. Dec 16 12:28:45.145784 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:28:45.145794 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:28:45.145805 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 16 12:28:45.145815 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 16 12:28:45.145825 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 16 12:28:45.145836 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:28:45.145882 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 16 12:28:45.145896 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:28:45.145907 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:28:45.145918 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 16 12:28:45.145929 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 16 12:28:45.145955 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 16 12:28:45.145971 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 16 12:28:45.145981 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:28:45.145992 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:28:45.146002 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:28:45.146012 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:28:45.146022 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 16 12:28:45.146032 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 16 12:28:45.146042 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Dec 16 12:28:45.146052 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:28:45.146063 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:28:45.146075 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:28:45.146085 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 16 12:28:45.146095 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 16 12:28:45.146105 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 16 12:28:45.146115 systemd[1]: Mounting media.mount - External Media Directory... Dec 16 12:28:45.146125 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 16 12:28:45.146135 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 16 12:28:45.146145 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 16 12:28:45.146156 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). Dec 16 12:28:45.146167 systemd[1]: Reached target machines.target - Containers. Dec 16 12:28:45.146177 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 16 12:28:45.146186 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:28:45.146197 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:28:45.146207 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 16 12:28:45.146216 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:28:45.146226 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:28:45.146238 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:28:45.146250 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 16 12:28:45.146260 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:28:45.146270 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 16 12:28:45.146280 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 16 12:28:45.146290 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 16 12:28:45.146301 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 16 12:28:45.146323 systemd[1]: Stopped systemd-fsck-usr.service. Dec 16 12:28:45.146343 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). Dec 16 12:28:45.146378 kernel: fuse: init (API version 7.41) Dec 16 12:28:45.146404 kernel: loop: module loaded Dec 16 12:28:45.146420 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:28:45.146431 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:28:45.146441 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:28:45.146454 kernel: ACPI: bus type drm_connector registered Dec 16 12:28:45.146464 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 16 12:28:45.146474 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Dec 16 12:28:45.146484 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:28:45.146494 systemd[1]: verity-setup.service: Deactivated successfully. Dec 16 12:28:45.146507 systemd[1]: Stopped verity-setup.service. Dec 16 12:28:45.146517 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 16 12:28:45.146528 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 16 12:28:45.146538 systemd[1]: Mounted media.mount - External Media Directory. Dec 16 12:28:45.146549 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 16 12:28:45.146559 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 16 12:28:45.146568 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 16 12:28:45.146604 systemd-journald[1152]: Collecting audit messages is disabled. Dec 16 12:28:45.146625 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 16 12:28:45.146636 systemd-journald[1152]: Journal started Dec 16 12:28:45.146659 systemd-journald[1152]: Runtime Journal (/run/log/journal/6b094bea78054e9ab4b8d9e201e14416) is 6M, max 48.5M, 42.4M free. Dec 16 12:28:44.925134 systemd[1]: Queued start job for default target multi-user.target. Dec 16 12:28:44.944381 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Dec 16 12:28:44.945542 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 16 12:28:45.149859 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:28:45.151504 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:28:45.152252 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 16 12:28:45.153906 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 16 12:28:45.155188 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:28:45.155361 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:28:45.156769 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:28:45.156983 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:28:45.158361 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:28:45.158552 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:28:45.160005 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 16 12:28:45.160163 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 16 12:28:45.161405 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:28:45.161578 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:28:45.163137 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:28:45.164478 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:28:45.165834 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 16 12:28:45.167272 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Dec 16 12:28:45.179909 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:28:45.182195 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 16 12:28:45.186941 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 16 12:28:45.187881 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 16 12:28:45.187922 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:28:45.189561 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Dec 16 12:28:45.192619 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 16 12:28:45.193680 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:28:45.194691 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 16 12:28:45.196590 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 16 12:28:45.197824 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:28:45.200993 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 16 12:28:45.202124 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:28:45.203441 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:28:45.207200 systemd-journald[1152]: Time spent on flushing to /var/log/journal/6b094bea78054e9ab4b8d9e201e14416 is 17.504ms for 854 entries. Dec 16 12:28:45.207200 systemd-journald[1152]: System Journal (/var/log/journal/6b094bea78054e9ab4b8d9e201e14416) is 8M, max 195.6M, 187.6M free. Dec 16 12:28:45.242497 systemd-journald[1152]: Received client request to flush runtime journal. Dec 16 12:28:45.207005 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 16 12:28:45.211063 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 16 12:28:45.214876 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:28:45.216251 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 16 12:28:45.217705 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 16 12:28:45.219177 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 16 12:28:45.224084 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Dec 16 12:28:45.226582 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Dec 16 12:28:45.246052 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 16 12:28:45.249115 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Dec 16 12:28:45.249830 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:28:45.249931 kernel: loop0: detected capacity change from 0 to 100632 Dec 16 12:28:45.249919 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Dec 16 12:28:45.254168 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:28:45.259313 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 16 12:28:45.268049 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Dec 16 12:28:45.271867 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 16 12:28:45.288256 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 16 12:28:45.290529 kernel: loop1: detected capacity change from 0 to 119840 Dec 16 12:28:45.291986 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:28:45.312424 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Dec 16 12:28:45.312720 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Dec 16 12:28:45.316915 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:28:45.319896 kernel: loop2: detected capacity change from 0 to 100632 Dec 16 12:28:45.325967 kernel: loop3: detected capacity change from 0 to 119840 Dec 16 12:28:45.329624 (sd-merge)[1227]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Dec 16 12:28:45.329985 (sd-merge)[1227]: Merged extensions into '/usr'. Dec 16 12:28:45.332631 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 16 12:28:45.339208 systemd[1]: Starting ensure-sysext.service... Dec 16 12:28:45.343560 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:28:45.356234 systemd[1]: Reload requested from client PID 1229 ('systemctl') (unit ensure-sysext.service)... Dec 16 12:28:45.356252 systemd[1]: Reloading... Dec 16 12:28:45.363045 systemd-tmpfiles[1230]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Dec 16 12:28:45.363116 systemd-tmpfiles[1230]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Dec 16 12:28:45.363519 systemd-tmpfiles[1230]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 16 12:28:45.363880 systemd-tmpfiles[1230]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Dec 16 12:28:45.365008 systemd-tmpfiles[1230]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 16 12:28:45.365381 systemd-tmpfiles[1230]: ACLs are not supported, ignoring. Dec 16 12:28:45.365475 systemd-tmpfiles[1230]: ACLs are not supported, ignoring. Dec 16 12:28:45.370636 systemd-tmpfiles[1230]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:28:45.370650 systemd-tmpfiles[1230]: Skipping /boot Dec 16 12:28:45.380918 systemd-tmpfiles[1230]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:28:45.380963 systemd-tmpfiles[1230]: Skipping /boot Dec 16 12:28:45.418873 zram_generator::config[1258]: No configuration found. Dec 16 12:28:45.491187 ldconfig[1195]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 16 12:28:45.565604 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 16 12:28:45.566166 systemd[1]: Reloading finished in 209 ms. Dec 16 12:28:45.593883 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 16 12:28:45.605871 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:28:45.613404 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:28:45.615831 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 16 12:28:45.628444 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 16 12:28:45.631312 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:28:45.633437 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 16 12:28:45.636746 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:28:45.638497 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:28:45.640883 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:28:45.645037 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:28:45.646034 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:28:45.646136 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). Dec 16 12:28:45.650124 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:28:45.650282 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:28:45.650368 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). Dec 16 12:28:45.656240 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 16 12:28:45.658537 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 16 12:28:45.662884 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 16 12:28:45.664943 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 16 12:28:45.666825 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:28:45.667622 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:28:45.669239 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:28:45.669425 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:28:45.671365 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:28:45.671622 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:28:45.681492 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:28:45.684176 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:28:45.686149 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:28:45.691067 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:28:45.697577 augenrules[1334]: No rules Dec 16 12:28:45.698684 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:28:45.701075 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:28:45.701213 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). Dec 16 12:28:45.702586 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:28:45.704644 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 16 12:28:45.706828 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 16 12:28:45.708484 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:28:45.724905 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:28:45.726431 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 16 12:28:45.727941 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:28:45.728099 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:28:45.729459 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:28:45.729615 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:28:45.731140 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:28:45.731304 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:28:45.732756 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:28:45.733140 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:28:45.734556 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 16 12:28:45.739313 systemd[1]: Finished ensure-sysext.service. Dec 16 12:28:45.744938 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:28:45.745005 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:28:45.747608 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Dec 16 12:28:45.748208 systemd-resolved[1297]: Positive Trust Anchors: Dec 16 12:28:45.748451 systemd-resolved[1297]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:28:45.748534 systemd-resolved[1297]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Dec 16 12:28:45.748637 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). Dec 16 12:28:45.748683 systemd-udevd[1342]: Using default interface naming scheme 'v255'. Dec 16 12:28:45.754804 systemd-resolved[1297]: Defaulting to hostname 'linux'. Dec 16 12:28:45.756239 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:28:45.757429 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:28:45.766672 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:28:45.772058 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:28:45.802026 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 16 12:28:45.857646 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 16 12:28:45.862282 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 16 12:28:45.894281 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 16 12:28:45.905155 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Dec 16 12:28:45.906747 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:28:45.908331 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 16 12:28:45.909940 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 16 12:28:45.911185 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 16 12:28:45.912779 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 16 12:28:45.912811 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:28:45.913640 systemd[1]: Reached target time-set.target - System Time Set. Dec 16 12:28:45.915104 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 16 12:28:45.916829 systemd-networkd[1370]: lo: Link UP Dec 16 12:28:45.916860 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 16 12:28:45.917158 systemd-networkd[1370]: lo: Gained carrier Dec 16 12:28:45.918026 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:28:45.918029 systemd-networkd[1370]: Enumeration completed Dec 16 12:28:45.918472 systemd-networkd[1370]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:28:45.918475 systemd-networkd[1370]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:28:45.919563 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 16 12:28:45.922176 systemd-networkd[1370]: eth0: Link UP Dec 16 12:28:45.922199 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 16 12:28:45.922809 systemd-networkd[1370]: eth0: Gained carrier Dec 16 12:28:45.922915 systemd-networkd[1370]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:28:45.925047 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Dec 16 12:28:45.927048 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Dec 16 12:28:45.928222 systemd[1]: Reached target ssh-access.target - SSH Access Available. Dec 16 12:28:45.934484 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 16 12:28:45.935889 systemd-networkd[1370]: eth0: DHCPv4 address 10.0.0.63/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 16 12:28:45.936747 systemd-timesyncd[1352]: Network configuration changed, trying to establish connection. Dec 16 12:28:45.937300 systemd-timesyncd[1352]: Contacted time server 10.0.0.1:123 (10.0.0.1). Dec 16 12:28:45.937362 systemd-timesyncd[1352]: Initial clock synchronization to Tue 2025-12-16 12:28:46.186212 UTC. Dec 16 12:28:45.937487 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Dec 16 12:28:45.939222 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:28:45.940545 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 16 12:28:45.941769 systemd[1]: Reached target network.target - Network. Dec 16 12:28:45.942746 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:28:45.943721 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:28:45.944663 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:28:45.944695 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:28:45.945729 systemd[1]: Starting containerd.service - containerd container runtime... Dec 16 12:28:45.949025 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 16 12:28:45.953045 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 16 12:28:45.954969 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 16 12:28:45.959061 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 16 12:28:45.959907 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). Dec 16 12:28:45.963741 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 16 12:28:45.966024 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 16 12:28:45.971151 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 16 12:28:45.974803 jq[1410]: false Dec 16 12:28:45.975614 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 16 12:28:45.977972 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Dec 16 12:28:45.978182 extend-filesystems[1412]: Found /dev/vda6 Dec 16 12:28:45.982395 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 16 12:28:45.985608 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 16 12:28:45.986130 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 16 12:28:45.986980 systemd[1]: Starting update-engine.service - Update Engine... Dec 16 12:28:45.990153 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 16 12:28:46.007372 extend-filesystems[1412]: Found /dev/vda9 Dec 16 12:28:46.008377 extend-filesystems[1412]: Checking size of /dev/vda9 Dec 16 12:28:46.009975 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 16 12:28:46.012456 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 16 12:28:46.012653 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 16 12:28:46.012993 systemd[1]: motdgen.service: Deactivated successfully. Dec 16 12:28:46.013166 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 16 12:28:46.014397 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 16 12:28:46.014583 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 16 12:28:46.021891 jq[1430]: true Dec 16 12:28:46.032602 update_engine[1428]: I20251216 12:28:46.032387 1428 main.cc:92] Flatcar Update Engine starting Dec 16 12:28:46.034801 extend-filesystems[1412]: Old size kept for /dev/vda9 Dec 16 12:28:46.036173 (ntainerd)[1439]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 16 12:28:46.043900 jq[1445]: true Dec 16 12:28:46.042250 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:28:46.043811 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 16 12:28:46.044035 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 16 12:28:46.058172 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Dec 16 12:28:46.088007 systemd-logind[1420]: Watching system buttons on /dev/input/event0 (Power Button) Dec 16 12:28:46.089366 dbus-daemon[1408]: [system] SELinux support is enabled Dec 16 12:28:46.091028 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 16 12:28:46.093002 systemd-logind[1420]: New seat seat0. Dec 16 12:28:46.099200 bash[1472]: Updated "/home/core/.ssh/authorized_keys" Dec 16 12:28:46.098894 dbus-daemon[1408]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 16 12:28:46.097142 systemd[1]: Started systemd-logind.service - User Login Management. Dec 16 12:28:46.099450 update_engine[1428]: I20251216 12:28:46.097640 1428 update_check_scheduler.cc:74] Next update check in 4m57s Dec 16 12:28:46.098192 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). Dec 16 12:28:46.098215 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 16 12:28:46.099900 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). Dec 16 12:28:46.099922 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 16 12:28:46.103377 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Dec 16 12:28:46.105690 systemd[1]: Started update-engine.service - Update Engine. Dec 16 12:28:46.108071 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 16 12:28:46.110187 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 16 12:28:46.144361 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:28:46.160050 locksmithd[1474]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 16 12:28:46.222919 containerd[1439]: time="2025-12-16T12:28:46Z" 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 Dec 16 12:28:46.224356 containerd[1439]: time="2025-12-16T12:28:46.224314435Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234483248Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.517µs" Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234532742Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234552540Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234720943Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234736245Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234761445Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234807557Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:28:46.234899 containerd[1439]: time="2025-12-16T12:28:46.234818487Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Dec 16 12:28:46.235378 containerd[1439]: time="2025-12-16T12:28:46.235351578Z" 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 Dec 16 12:28:46.235465 containerd[1439]: time="2025-12-16T12:28:46.235448338Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:28:46.235519 containerd[1439]: time="2025-12-16T12:28:46.235505339Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:28:46.235565 containerd[1439]: time="2025-12-16T12:28:46.235553183Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Dec 16 12:28:46.235713 containerd[1439]: time="2025-12-16T12:28:46.235692756Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Dec 16 12:28:46.236003 containerd[1439]: time="2025-12-16T12:28:46.235980274Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Dec 16 12:28:46.236089 containerd[1439]: time="2025-12-16T12:28:46.236073405Z" 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 Dec 16 12:28:46.236144 containerd[1439]: time="2025-12-16T12:28:46.236131725Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Dec 16 12:28:46.236228 containerd[1439]: time="2025-12-16T12:28:46.236212070Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Dec 16 12:28:46.236539 containerd[1439]: time="2025-12-16T12:28:46.236515716Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Dec 16 12:28:46.236675 containerd[1439]: time="2025-12-16T12:28:46.236655660Z" level=info msg="metadata content store policy set" policy=shared Dec 16 12:28:46.240198 containerd[1439]: time="2025-12-16T12:28:46.240165149Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Dec 16 12:28:46.240330 containerd[1439]: time="2025-12-16T12:28:46.240313260Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Dec 16 12:28:46.240386 containerd[1439]: time="2025-12-16T12:28:46.240374756Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Dec 16 12:28:46.240437 containerd[1439]: time="2025-12-16T12:28:46.240425528Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Dec 16 12:28:46.240487 containerd[1439]: time="2025-12-16T12:28:46.240475311Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Dec 16 12:28:46.240555 containerd[1439]: time="2025-12-16T12:28:46.240540767Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Dec 16 12:28:46.240652 containerd[1439]: time="2025-12-16T12:28:46.240636249Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Dec 16 12:28:46.240708 containerd[1439]: time="2025-12-16T12:28:46.240695600Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Dec 16 12:28:46.240760 containerd[1439]: time="2025-12-16T12:28:46.240748023Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Dec 16 12:28:46.240811 containerd[1439]: time="2025-12-16T12:28:46.240799455Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Dec 16 12:28:46.240859 containerd[1439]: time="2025-12-16T12:28:46.240847052Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Dec 16 12:28:46.240947 containerd[1439]: time="2025-12-16T12:28:46.240933955Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Dec 16 12:28:46.241125 containerd[1439]: time="2025-12-16T12:28:46.241105327Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Dec 16 12:28:46.241196 containerd[1439]: time="2025-12-16T12:28:46.241182332Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Dec 16 12:28:46.241251 containerd[1439]: time="2025-12-16T12:28:46.241238796Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Dec 16 12:28:46.241304 containerd[1439]: time="2025-12-16T12:28:46.241291754Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Dec 16 12:28:46.241357 containerd[1439]: time="2025-12-16T12:28:46.241345373Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Dec 16 12:28:46.241409 containerd[1439]: time="2025-12-16T12:28:46.241396516Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Dec 16 12:28:46.241474 containerd[1439]: time="2025-12-16T12:28:46.241460446Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Dec 16 12:28:46.241531 containerd[1439]: time="2025-12-16T12:28:46.241518601Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Dec 16 12:28:46.241583 containerd[1439]: time="2025-12-16T12:28:46.241571395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Dec 16 12:28:46.241648 containerd[1439]: time="2025-12-16T12:28:46.241635366Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Dec 16 12:28:46.241711 containerd[1439]: time="2025-12-16T12:28:46.241698017Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Dec 16 12:28:46.241967 containerd[1439]: time="2025-12-16T12:28:46.241950848Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Dec 16 12:28:46.242028 containerd[1439]: time="2025-12-16T12:28:46.242016881Z" level=info msg="Start snapshots syncer" Dec 16 12:28:46.242102 containerd[1439]: time="2025-12-16T12:28:46.242088029Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Dec 16 12:28:46.242422 containerd[1439]: time="2025-12-16T12:28:46.242382806Z" 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\"}" Dec 16 12:28:46.242577 containerd[1439]: time="2025-12-16T12:28:46.242559500Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Dec 16 12:28:46.242720 containerd[1439]: time="2025-12-16T12:28:46.242700599Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Dec 16 12:28:46.242911 containerd[1439]: time="2025-12-16T12:28:46.242889459Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Dec 16 12:28:46.242990 containerd[1439]: time="2025-12-16T12:28:46.242974671Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Dec 16 12:28:46.243066 containerd[1439]: time="2025-12-16T12:28:46.243053078Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Dec 16 12:28:46.243120 containerd[1439]: time="2025-12-16T12:28:46.243107315Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Dec 16 12:28:46.243175 containerd[1439]: time="2025-12-16T12:28:46.243160686Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Dec 16 12:28:46.243227 containerd[1439]: time="2025-12-16T12:28:46.243215005Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Dec 16 12:28:46.243280 containerd[1439]: time="2025-12-16T12:28:46.243268211Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Dec 16 12:28:46.243349 containerd[1439]: time="2025-12-16T12:28:46.243335193Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Dec 16 12:28:46.243416 containerd[1439]: time="2025-12-16T12:28:46.243401886Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Dec 16 12:28:46.243466 containerd[1439]: time="2025-12-16T12:28:46.243454680Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Dec 16 12:28:46.243566 containerd[1439]: time="2025-12-16T12:28:46.243551275Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Dec 16 12:28:46.243630 containerd[1439]: time="2025-12-16T12:28:46.243615040Z" 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 Dec 16 12:28:46.243685 containerd[1439]: time="2025-12-16T12:28:46.243672741Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:28:46.243735 containerd[1439]: time="2025-12-16T12:28:46.243722895Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:28:46.243789 containerd[1439]: time="2025-12-16T12:28:46.243776679Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Dec 16 12:28:46.243841 containerd[1439]: time="2025-12-16T12:28:46.243829513Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Dec 16 12:28:46.243907 containerd[1439]: time="2025-12-16T12:28:46.243893031Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Dec 16 12:28:46.244027 containerd[1439]: time="2025-12-16T12:28:46.244015858Z" level=info msg="runtime interface created" Dec 16 12:28:46.244069 containerd[1439]: time="2025-12-16T12:28:46.244059454Z" level=info msg="created NRI interface" Dec 16 12:28:46.244119 containerd[1439]: time="2025-12-16T12:28:46.244106844Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Dec 16 12:28:46.244169 containerd[1439]: time="2025-12-16T12:28:46.244158648Z" level=info msg="Connect containerd service" Dec 16 12:28:46.244251 containerd[1439]: time="2025-12-16T12:28:46.244237550Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 16 12:28:46.245506 containerd[1439]: time="2025-12-16T12:28:46.245082699Z" 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" Dec 16 12:28:46.316613 containerd[1439]: time="2025-12-16T12:28:46.316467521Z" level=info msg="Start subscribing containerd event" Dec 16 12:28:46.316613 containerd[1439]: time="2025-12-16T12:28:46.316547041Z" level=info msg="Start recovering state" Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316644461Z" level=info msg="Start event monitor" Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316657701Z" level=info msg="Start cni network conf syncer for default" Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316665950Z" level=info msg="Start streaming server" Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316674818Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316682159Z" level=info msg="runtime interface starting up..." Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316687191Z" level=info msg="starting plugins..." Dec 16 12:28:46.316716 containerd[1439]: time="2025-12-16T12:28:46.316699812Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Dec 16 12:28:46.317053 containerd[1439]: time="2025-12-16T12:28:46.317025193Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 16 12:28:46.317104 containerd[1439]: time="2025-12-16T12:28:46.317076626Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 16 12:28:46.317139 containerd[1439]: time="2025-12-16T12:28:46.317124635Z" level=info msg="containerd successfully booted in 0.095562s" Dec 16 12:28:46.317237 systemd[1]: Started containerd.service - containerd container runtime. Dec 16 12:28:46.985805 sshd_keygen[1431]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 16 12:28:47.006879 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 16 12:28:47.009504 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 16 12:28:47.030936 systemd[1]: issuegen.service: Deactivated successfully. Dec 16 12:28:47.031147 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 16 12:28:47.033787 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 16 12:28:47.054625 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 16 12:28:47.058354 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 16 12:28:47.060694 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 16 12:28:47.062035 systemd[1]: Reached target getty.target - Login Prompts. Dec 16 12:28:47.963230 systemd-networkd[1370]: eth0: Gained IPv6LL Dec 16 12:28:47.965764 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 16 12:28:47.967463 systemd[1]: Reached target network-online.target - Network is Online. Dec 16 12:28:47.969781 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 16 12:28:47.971838 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 16 12:28:48.001114 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 16 12:28:48.002946 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 16 12:28:48.003151 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 16 12:28:48.006351 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Dec 16 12:28:48.007620 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Dec 16 12:28:48.024895 (-wrapper)[1537]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Dec 16 12:28:48.131016 systemd[1]: Starting docker.service - Docker Application Container Engine... Dec 16 12:28:48.152248 (dockerd)[1549]: 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 Dec 16 12:28:48.360648 dockerd[1549]: time="2025-12-16T12:28:48.360516250Z" level=info msg="Starting up" Dec 16 12:28:48.361444 dockerd[1549]: time="2025-12-16T12:28:48.361380730Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Dec 16 12:28:48.372042 dockerd[1549]: time="2025-12-16T12:28:48.372001355Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Dec 16 12:28:48.402316 dockerd[1549]: time="2025-12-16T12:28:48.402255247Z" level=info msg="Loading containers: start." Dec 16 12:28:48.410890 kernel: Initializing XFRM netlink socket Dec 16 12:28:48.617992 systemd-networkd[1370]: docker0: Link UP Dec 16 12:28:48.621944 dockerd[1549]: time="2025-12-16T12:28:48.621776768Z" level=info msg="Loading containers: done." Dec 16 12:28:48.635901 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck230888778-merged.mount: Deactivated successfully. Dec 16 12:28:48.636963 dockerd[1549]: time="2025-12-16T12:28:48.636919726Z" 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 Dec 16 12:28:48.637035 dockerd[1549]: time="2025-12-16T12:28:48.637012895Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Dec 16 12:28:48.637116 dockerd[1549]: time="2025-12-16T12:28:48.637096644Z" level=info msg="Initializing buildkit" Dec 16 12:28:48.660439 dockerd[1549]: time="2025-12-16T12:28:48.660383545Z" level=info msg="Completed buildkit initialization" Dec 16 12:28:48.666460 dockerd[1549]: time="2025-12-16T12:28:48.666405419Z" level=info msg="Daemon has completed initialization" Dec 16 12:28:48.666726 systemd[1]: Started docker.service - Docker Application Container Engine. Dec 16 12:28:48.667919 dockerd[1549]: time="2025-12-16T12:28:48.666503133Z" level=info msg="API listen on /run/docker.sock" Dec 16 12:28:48.670642 etcd-wrapper[1541]: Error response from daemon: No such container: etcd-member Dec 16 12:28:48.685708 etcd-wrapper[1750]: Error response from daemon: No such container: etcd-member Dec 16 12:28:48.710885 etcd-wrapper[1771]: Unable to find image 'quay.io/coreos/etcd:v3.5.22' locally Dec 16 12:28:49.454773 etcd-wrapper[1771]: v3.5.22: Pulling from coreos/etcd Dec 16 12:28:49.631946 etcd-wrapper[1771]: 6c170d3e2c27: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 2ae710cd8bfe: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: d462aa345367: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 0f8b424aa0b9: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: d557676654e5: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 0f8b424aa0b9: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: d557676654e5: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: c8022d07192e: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: d858cbc252ad: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 1069fc2daed1: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: b40161cd83fc: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 5318d93a3a65: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 307c1adadb60: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: 43e901b84b4f: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: e248ce7059b2: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: d9c3ebce7174: Pulling fs layer Dec 16 12:28:49.631946 etcd-wrapper[1771]: c8022d07192e: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: d858cbc252ad: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: 1069fc2daed1: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: b40161cd83fc: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: 5318d93a3a65: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: 307c1adadb60: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: 43e901b84b4f: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: e248ce7059b2: Waiting Dec 16 12:28:49.631946 etcd-wrapper[1771]: d9c3ebce7174: Waiting Dec 16 12:28:49.978583 etcd-wrapper[1771]: 2ae710cd8bfe: Verifying Checksum Dec 16 12:28:49.978583 etcd-wrapper[1771]: 2ae710cd8bfe: Download complete Dec 16 12:28:49.982307 etcd-wrapper[1771]: d462aa345367: Verifying Checksum Dec 16 12:28:49.982307 etcd-wrapper[1771]: d462aa345367: Download complete Dec 16 12:28:49.995500 etcd-wrapper[1771]: 6c170d3e2c27: Download complete Dec 16 12:28:50.024528 etcd-wrapper[1771]: 6c170d3e2c27: Pull complete Dec 16 12:28:50.040098 systemd[1]: var-lib-docker-overlay2-b1d7ef14bea0f0610f7269e321d1132f8185ab76ac6f0a30c16109cb0ccb4ae2-merged.mount: Deactivated successfully. Dec 16 12:28:50.062439 etcd-wrapper[1771]: 2ae710cd8bfe: Pull complete Dec 16 12:28:50.122132 etcd-wrapper[1771]: d557676654e5: Verifying Checksum Dec 16 12:28:50.122132 etcd-wrapper[1771]: d557676654e5: Download complete Dec 16 12:28:50.136429 etcd-wrapper[1771]: 0f8b424aa0b9: Verifying Checksum Dec 16 12:28:50.136429 etcd-wrapper[1771]: 0f8b424aa0b9: Download complete Dec 16 12:28:50.159052 etcd-wrapper[1771]: c8022d07192e: Verifying Checksum Dec 16 12:28:50.159052 etcd-wrapper[1771]: c8022d07192e: Download complete Dec 16 12:28:50.254792 etcd-wrapper[1771]: d858cbc252ad: Download complete Dec 16 12:28:50.285891 etcd-wrapper[1771]: 1069fc2daed1: Verifying Checksum Dec 16 12:28:50.286018 etcd-wrapper[1771]: 1069fc2daed1: Download complete Dec 16 12:28:50.358698 etcd-wrapper[1771]: b40161cd83fc: Download complete Dec 16 12:28:50.400822 systemd[1]: var-lib-docker-overlay2-85bf7966e7f440dc1eb027a2d814239074bd55ee6d57f5c1dc019c07916294c0-merged.mount: Deactivated successfully. Dec 16 12:28:50.445080 etcd-wrapper[1771]: d462aa345367: Pull complete Dec 16 12:28:50.446719 etcd-wrapper[1771]: 307c1adadb60: Verifying Checksum Dec 16 12:28:50.446719 etcd-wrapper[1771]: 307c1adadb60: Download complete Dec 16 12:28:50.468519 etcd-wrapper[1771]: 0f8b424aa0b9: Pull complete Dec 16 12:28:50.480129 etcd-wrapper[1771]: 5318d93a3a65: Verifying Checksum Dec 16 12:28:50.480129 etcd-wrapper[1771]: 5318d93a3a65: Download complete Dec 16 12:28:50.492398 etcd-wrapper[1771]: d557676654e5: Pull complete Dec 16 12:28:50.521397 etcd-wrapper[1771]: c8022d07192e: Pull complete Dec 16 12:28:50.551704 etcd-wrapper[1771]: 43e901b84b4f: Verifying Checksum Dec 16 12:28:50.551704 etcd-wrapper[1771]: 43e901b84b4f: Download complete Dec 16 12:28:50.555527 etcd-wrapper[1771]: d858cbc252ad: Pull complete Dec 16 12:28:50.586151 etcd-wrapper[1771]: 1069fc2daed1: Pull complete Dec 16 12:28:50.614229 etcd-wrapper[1771]: b40161cd83fc: Pull complete Dec 16 12:28:50.650133 etcd-wrapper[1771]: 5318d93a3a65: Pull complete Dec 16 12:28:50.650299 etcd-wrapper[1771]: e248ce7059b2: Verifying Checksum Dec 16 12:28:50.650299 etcd-wrapper[1771]: e248ce7059b2: Download complete Dec 16 12:28:50.680802 etcd-wrapper[1771]: 307c1adadb60: Pull complete Dec 16 12:28:50.824285 etcd-wrapper[1771]: d9c3ebce7174: Verifying Checksum Dec 16 12:28:50.824285 etcd-wrapper[1771]: d9c3ebce7174: Download complete Dec 16 12:28:50.844133 etcd-wrapper[1771]: 43e901b84b4f: Pull complete Dec 16 12:28:50.957880 etcd-wrapper[1771]: e248ce7059b2: Pull complete Dec 16 12:28:51.035552 systemd[1]: var-lib-docker-overlay2-690bd507eafe4c4a0757ab7fb98c50b5f509ddc4aee540cae5c5417fde502f9c-merged.mount: Deactivated successfully. Dec 16 12:28:51.040676 systemd[1]: var-lib-docker-overlay2-1deb21fcb2e05acf97cb10f36032663c77f5f920349b2fa7da6fffb408aa0d33-merged.mount: Deactivated successfully. Dec 16 12:28:51.068231 etcd-wrapper[1771]: d9c3ebce7174: Pull complete Dec 16 12:28:51.078807 etcd-wrapper[1771]: Digest: sha256:51efcfc4f3a863c072ebe745942f790878c2a268e713a6d140c4f2593271adc6 Dec 16 12:28:51.082295 etcd-wrapper[1771]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.22 Dec 16 12:28:51.093691 systemd[1]: var-lib-docker-overlay2-cfe8ac0adbdc26ff66ff019872bfc6cfdfcf75738414c4263fe1c81e141c52d2\x2dinit-merged.mount: Deactivated successfully. Dec 16 12:28:51.139687 containerd[1439]: time="2025-12-16T12:28:51.139479749Z" level=info msg="connecting to shim fa8edec9770bad7a4c28460f527342bec93340a646cc191c1ddd47c4d41ac516" address="unix:///run/containerd/s/dac35fbf2875811c1aad196b5afff619b8b2e737cdb3d27002c3f38809011984" namespace=moby protocol=ttrpc version=3 Dec 16 12:28:51.162093 systemd[1]: Started docker-fa8edec9770bad7a4c28460f527342bec93340a646cc191c1ddd47c4d41ac516.scope - libcontainer container fa8edec9770bad7a4c28460f527342bec93340a646cc191c1ddd47c4d41ac516. Dec 16 12:28:51.176763 systemd-resolved[1297]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:28:51.228336 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.227844Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Dec 16 12:28:51.228336 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.228054Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"6b094bea78054e9ab4b8d9e201e14416"} Dec 16 12:28:51.228336 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.228082Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Dec 16 12:28:51.228336 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.228095Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.22"} Dec 16 12:28:51.228336 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.228101Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Dec 16 12:28:51.228336 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.228107Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Dec 16 12:28:51.228669 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.228507Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Dec 16 12:28:51.228669 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.228535Z","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.63:2379"]} Dec 16 12:28:51.228822 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.228615Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Dec 16 12:28:51.228822 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.228639Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Dec 16 12:28:51.229492 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.229332Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Dec 16 12:28:51.229828 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.229680Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.22","git-sha":"7862c85","go-version":"go1.23.11","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"6b094bea78054e9ab4b8d9e201e14416","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.63:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"6b094bea78054e9ab4b8d9e201e14416=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"} Dec 16 12:28:51.233831 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.233303Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.02497ms"} Dec 16 12:28:51.239223 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.238973Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Dec 16 12:28:51.239430 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.239254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Dec 16 12:28:51.239430 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.239294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Dec 16 12:28:51.239430 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.239305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Dec 16 12:28:51.239430 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.239317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Dec 16 12:28:51.239544 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.239405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Dec 16 12:28:51.244122 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:28:51.243915Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Dec 16 12:28:51.245902 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.245677Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Dec 16 12:28:51.246002 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.245723Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Dec 16 12:28:51.247132 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.246893Z","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"} Dec 16 12:28:51.248367 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.247674Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.22","cluster-version":"to_be_decided"} Dec 16 12:28:51.248367 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.247810Z","caller":"etcdserver/server.go:759","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"} Dec 16 12:28:51.248367 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.247919Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Dec 16 12:28:51.249087 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.248127Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Dec 16 12:28:51.249087 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.248191Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Dec 16 12:28:51.249087 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.248199Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Dec 16 12:28:51.249087 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.248787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Dec 16 12:28:51.249087 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.248947Z","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"],"added-peer-is-learner":false} Dec 16 12:28:51.250197 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.249999Z","caller":"embed/etcd.go:292","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.63:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Dec 16 12:28:51.250358 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.250037Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Dec 16 12:28:51.250358 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.250147Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Dec 16 12:28:51.941093 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Dec 16 12:28:51.941093 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Dec 16 12:28:51.941350 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Dec 16 12:28:51.941350 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Dec 16 12:28:51.941350 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Dec 16 12:28:51.941350 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Dec 16 12:28:51.941350 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.940924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Dec 16 12:28:51.941949 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.941737Z","caller":"etcdserver/server.go:2697","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Dec 16 12:28:51.943615 systemd[1]: Started etcd-member.service - etcd (System Application Container). Dec 16 12:28:51.944813 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.943054Z","caller":"etcdserver/server.go:2144","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:6b094bea78054e9ab4b8d9e201e14416 ClientURLs:[http://10.0.0.63:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Dec 16 12:28:51.944813 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.943087Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Dec 16 12:28:51.944813 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.943276Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Dec 16 12:28:51.944813 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.943385Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Dec 16 12:28:51.945420 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.943754Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Dec 16 12:28:51.945420 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.944204Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Dec 16 12:28:51.945420 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.944479Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Dec 16 12:28:51.945420 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.944547Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Dec 16 12:28:51.945420 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:28:51.944570Z","caller":"etcdserver/server.go:2721","msg":"cluster version is updated","cluster-version":"3.5"} Dec 16 12:28:51.945243 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 16 12:28:51.950037 systemd[1]: Startup finished in 2.098s (kernel) + 3.893s (initrd) + 7.500s (userspace) = 13.492s. Dec 16 12:28:53.870041 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 16 12:28:53.871396 systemd[1]: Started sshd@0-10.0.0.63:22-10.0.0.1:57228.service - OpenSSH per-connection server daemon (10.0.0.1:57228). Dec 16 12:28:53.959366 sshd[1912]: Accepted publickey for core from 10.0.0.1 port 57228 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:53.961525 sshd-session[1912]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:53.970910 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 16 12:28:53.972049 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 16 12:28:53.977986 systemd-logind[1420]: New session 1 of user core. Dec 16 12:28:53.993426 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 16 12:28:53.998542 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 16 12:28:54.023301 (systemd)[1917]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 16 12:28:54.025725 systemd-logind[1420]: New session c1 of user core. Dec 16 12:28:54.171301 systemd[1917]: Queued start job for default target default.target. Dec 16 12:28:54.193997 systemd[1917]: Created slice app.slice - User Application Slice. Dec 16 12:28:54.194032 systemd[1917]: Reached target paths.target - Paths. Dec 16 12:28:54.194071 systemd[1917]: Reached target timers.target - Timers. Dec 16 12:28:54.195649 systemd[1917]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 16 12:28:54.216633 systemd[1917]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 16 12:28:54.216763 systemd[1917]: Reached target sockets.target - Sockets. Dec 16 12:28:54.216808 systemd[1917]: Reached target basic.target - Basic System. Dec 16 12:28:54.216837 systemd[1917]: Reached target default.target - Main User Target. Dec 16 12:28:54.216889 systemd[1917]: Startup finished in 182ms. Dec 16 12:28:54.217047 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 16 12:28:54.225096 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 16 12:28:54.290213 systemd[1]: Started sshd@1-10.0.0.63:22-10.0.0.1:57234.service - OpenSSH per-connection server daemon (10.0.0.1:57234). Dec 16 12:28:54.364971 sshd[1928]: Accepted publickey for core from 10.0.0.1 port 57234 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:54.366535 sshd-session[1928]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:54.370813 systemd-logind[1420]: New session 2 of user core. Dec 16 12:28:54.378466 systemd[1]: Started session-2.scope - Session 2 of User core. Dec 16 12:28:54.432370 sshd[1931]: Connection closed by 10.0.0.1 port 57234 Dec 16 12:28:54.432556 sshd-session[1928]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:54.452017 systemd[1]: sshd@1-10.0.0.63:22-10.0.0.1:57234.service: Deactivated successfully. Dec 16 12:28:54.458157 systemd[1]: session-2.scope: Deactivated successfully. Dec 16 12:28:54.459953 systemd-logind[1420]: Session 2 logged out. Waiting for processes to exit. Dec 16 12:28:54.462703 systemd[1]: Started sshd@2-10.0.0.63:22-10.0.0.1:57242.service - OpenSSH per-connection server daemon (10.0.0.1:57242). Dec 16 12:28:54.465130 systemd-logind[1420]: Removed session 2. Dec 16 12:28:54.531142 sshd[1937]: Accepted publickey for core from 10.0.0.1 port 57242 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:54.536836 sshd-session[1937]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:54.543610 systemd-logind[1420]: New session 3 of user core. Dec 16 12:28:54.553111 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 16 12:28:54.604178 sshd[1940]: Connection closed by 10.0.0.1 port 57242 Dec 16 12:28:54.603604 sshd-session[1937]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:54.614475 systemd[1]: sshd@2-10.0.0.63:22-10.0.0.1:57242.service: Deactivated successfully. Dec 16 12:28:54.617124 systemd[1]: session-3.scope: Deactivated successfully. Dec 16 12:28:54.618490 systemd-logind[1420]: Session 3 logged out. Waiting for processes to exit. Dec 16 12:28:54.620642 systemd[1]: Started sshd@3-10.0.0.63:22-10.0.0.1:57244.service - OpenSSH per-connection server daemon (10.0.0.1:57244). Dec 16 12:28:54.625164 systemd-logind[1420]: Removed session 3. Dec 16 12:28:54.692059 sshd[1946]: Accepted publickey for core from 10.0.0.1 port 57244 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:54.694698 sshd-session[1946]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:54.699992 systemd-logind[1420]: New session 4 of user core. Dec 16 12:28:54.711088 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 16 12:28:54.766904 sshd[1949]: Connection closed by 10.0.0.1 port 57244 Dec 16 12:28:54.767535 sshd-session[1946]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:54.777385 systemd[1]: sshd@3-10.0.0.63:22-10.0.0.1:57244.service: Deactivated successfully. Dec 16 12:28:54.779527 systemd[1]: session-4.scope: Deactivated successfully. Dec 16 12:28:54.780336 systemd-logind[1420]: Session 4 logged out. Waiting for processes to exit. Dec 16 12:28:54.783151 systemd[1]: Started sshd@4-10.0.0.63:22-10.0.0.1:57248.service - OpenSSH per-connection server daemon (10.0.0.1:57248). Dec 16 12:28:54.783712 systemd-logind[1420]: Removed session 4. Dec 16 12:28:54.870425 sshd[1955]: Accepted publickey for core from 10.0.0.1 port 57248 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:54.873561 sshd-session[1955]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:54.879904 systemd-logind[1420]: New session 5 of user core. Dec 16 12:28:54.890058 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 16 12:28:54.962121 sudo[1959]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 16 12:28:54.962483 sudo[1959]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:28:54.983071 sudo[1959]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:54.986116 sshd[1958]: Connection closed by 10.0.0.1 port 57248 Dec 16 12:28:54.985658 sshd-session[1955]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:54.997680 systemd[1]: sshd@4-10.0.0.63:22-10.0.0.1:57248.service: Deactivated successfully. Dec 16 12:28:55.000448 systemd[1]: session-5.scope: Deactivated successfully. Dec 16 12:28:55.001778 systemd-logind[1420]: Session 5 logged out. Waiting for processes to exit. Dec 16 12:28:55.006056 systemd[1]: Started sshd@5-10.0.0.63:22-10.0.0.1:57250.service - OpenSSH per-connection server daemon (10.0.0.1:57250). Dec 16 12:28:55.007362 systemd-logind[1420]: Removed session 5. Dec 16 12:28:55.098590 sshd[1965]: Accepted publickey for core from 10.0.0.1 port 57250 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:55.100510 sshd-session[1965]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:55.108975 systemd-logind[1420]: New session 6 of user core. Dec 16 12:28:55.120126 systemd[1]: Started session-6.scope - Session 6 of User core. Dec 16 12:28:55.176221 sudo[1970]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 16 12:28:55.176543 sudo[1970]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:28:55.183587 sudo[1970]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:55.190322 sudo[1969]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Dec 16 12:28:55.190648 sudo[1969]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:28:55.202470 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:28:55.262665 augenrules[1992]: No rules Dec 16 12:28:55.264387 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:28:55.264711 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:28:55.267187 sudo[1969]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:55.268722 sshd[1968]: Connection closed by 10.0.0.1 port 57250 Dec 16 12:28:55.269521 sshd-session[1965]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:55.292651 systemd[1]: sshd@5-10.0.0.63:22-10.0.0.1:57250.service: Deactivated successfully. Dec 16 12:28:55.294965 systemd[1]: session-6.scope: Deactivated successfully. Dec 16 12:28:55.296028 systemd-logind[1420]: Session 6 logged out. Waiting for processes to exit. Dec 16 12:28:55.299247 systemd[1]: Started sshd@6-10.0.0.63:22-10.0.0.1:57254.service - OpenSSH per-connection server daemon (10.0.0.1:57254). Dec 16 12:28:55.300370 systemd-logind[1420]: Removed session 6. Dec 16 12:28:55.361012 sshd[2001]: Accepted publickey for core from 10.0.0.1 port 57254 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:55.362494 sshd-session[2001]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:55.370274 systemd-logind[1420]: New session 7 of user core. Dec 16 12:28:55.385111 systemd[1]: Started session-7.scope - Session 7 of User core. Dec 16 12:28:55.438377 sshd[2004]: Connection closed by 10.0.0.1 port 57254 Dec 16 12:28:55.438872 sshd-session[2001]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:55.450603 systemd[1]: sshd@6-10.0.0.63:22-10.0.0.1:57254.service: Deactivated successfully. Dec 16 12:28:55.453658 systemd[1]: session-7.scope: Deactivated successfully. Dec 16 12:28:55.454891 systemd-logind[1420]: Session 7 logged out. Waiting for processes to exit. Dec 16 12:28:55.460641 systemd[1]: Started sshd@7-10.0.0.63:22-10.0.0.1:57270.service - OpenSSH per-connection server daemon (10.0.0.1:57270). Dec 16 12:28:55.461155 systemd-logind[1420]: Removed session 7. Dec 16 12:28:55.522449 sshd[2012]: Accepted publickey for core from 10.0.0.1 port 57270 ssh2: RSA SHA256:BaSANVIxG0UVtpwpaUGngK+MAJAznN//djAQgRKnLS8 Dec 16 12:28:55.523933 sshd-session[2012]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:55.529054 systemd-logind[1420]: New session 8 of user core. Dec 16 12:28:55.543110 systemd[1]: Started session-8.scope - Session 8 of User core. Dec 16 12:28:55.672803 sshd[2015]: Connection closed by 10.0.0.1 port 57270 Dec 16 12:28:55.673324 sshd-session[2012]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:55.683481 systemd[1]: sshd@7-10.0.0.63:22-10.0.0.1:57270.service: Deactivated successfully. Dec 16 12:28:55.685584 systemd[1]: session-8.scope: Deactivated successfully. Dec 16 12:28:55.688311 systemd-logind[1420]: Session 8 logged out. Waiting for processes to exit. Dec 16 12:28:55.690381 systemd-logind[1420]: Removed session 8. Dec 16 12:29:31.493816 update_engine[1428]: I20251216 12:29:31.493705 1428 update_attempter.cc:509] Updating boot flags... Dec 16 12:31:01.459739 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:31:01.459225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.826683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Dec 16 12:31:01.464131 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459464Z","caller":"traceutil/trace.go:171","msg":"trace[1464182740] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"112.893819ms","start":"2025-12-16T12:31:01.346559Z","end":"2025-12-16T12:31:01.459453Z","steps":["trace[1464182740] 'process raft request' (duration: 112.860659ms)"],"step_count":1} Dec 16 12:31:01.464131 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459534Z","caller":"traceutil/trace.go:171","msg":"trace[1676564420] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"141.728291ms","start":"2025-12-16T12:31:01.317793Z","end":"2025-12-16T12:31:01.459521Z","steps":["trace[1676564420] 'process raft request' (duration: 141.553489ms)"],"step_count":1} Dec 16 12:31:01.464131 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459599Z","caller":"traceutil/trace.go:171","msg":"trace[2055376247] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"143.76119ms","start":"2025-12-16T12:31:01.315833Z","end":"2025-12-16T12:31:01.459594Z","steps":["trace[2055376247] 'process raft request' (duration: 143.464227ms)"],"step_count":1} Dec 16 12:31:01.464131 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459591Z","caller":"traceutil/trace.go:171","msg":"trace[1765020709] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"124.645491ms","start":"2025-12-16T12:31:01.334932Z","end":"2025-12-16T12:31:01.459578Z","steps":["trace[1765020709] 'process raft request' (duration: 124.437329ms)"],"step_count":1} Dec 16 12:31:01.464131 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459625Z","caller":"traceutil/trace.go:171","msg":"trace[1089263531] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"143.78595ms","start":"2025-12-16T12:31:01.315833Z","end":"2025-12-16T12:31:01.459619Z","steps":["trace[1089263531] 'process raft request' (duration: 36.139779ms)","trace[1089263531] 'compare' (duration: 106.748283ms)"],"step_count":2} Dec 16 12:31:01.464441 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459650Z","caller":"traceutil/trace.go:171","msg":"trace[635667020] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:835; }","duration":"142.635899ms","start":"2025-12-16T12:31:01.317007Z","end":"2025-12-16T12:31:01.459643Z","steps":["trace[635667020] 'read index received' (duration: 12.410037ms)","trace[635667020] 'applied index is now lower than readState.Index' (duration: 130.224982ms)"],"step_count":2} Dec 16 12:31:01.464441 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459678Z","caller":"traceutil/trace.go:171","msg":"trace[2049122436] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"122.46947ms","start":"2025-12-16T12:31:01.337204Z","end":"2025-12-16T12:31:01.459674Z","steps":["trace[2049122436] 'process raft request' (duration: 122.189467ms)"],"step_count":1} Dec 16 12:31:01.464441 etcd-wrapper[1771]: {"level":"warn","ts":"2025-12-16T12:31:01.459739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.72006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" limit:1 ","response":"range_response_count:1 size:3522"} Dec 16 12:31:01.464441 etcd-wrapper[1771]: {"level":"info","ts":"2025-12-16T12:31:01.459756Z","caller":"traceutil/trace.go:171","msg":"trace[2087930205] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:812; }","duration":"142.75274ms","start":"2025-12-16T12:31:01.316997Z","end":"2025-12-16T12:31:01.459750Z","steps":["trace[2087930205] 'agreement among raft nodes before linearized reading' (duration: 142.664779ms)"],"step_count":1}