Jul 9 10:26:54.020781 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 9 10:26:54.020820 kernel: Linux version 6.6.96-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.43 p3) 2.43.1) #1 SMP PREEMPT Wed Jul 9 08:43:25 -00 2025 Jul 9 10:26:54.020835 kernel: KASLR enabled Jul 9 10:26:54.020841 kernel: efi: EFI v2.7 by EDK II Jul 9 10:26:54.020847 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbae018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40218 Jul 9 10:26:54.020853 kernel: random: crng init done Jul 9 10:26:54.020860 kernel: secureboot: Secure boot disabled Jul 9 10:26:54.020866 kernel: ACPI: Early table checksum verification disabled Jul 9 10:26:54.020872 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Jul 9 10:26:54.020879 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 9 10:26:54.020885 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020891 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020897 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020903 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020910 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020918 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020924 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020930 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020936 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 9 10:26:54.020942 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 9 10:26:54.020948 kernel: NUMA: Failed to initialise from firmware Jul 9 10:26:54.020955 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 9 10:26:54.020961 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Jul 9 10:26:54.020967 kernel: Zone ranges: Jul 9 10:26:54.020973 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 9 10:26:54.020981 kernel: DMA32 empty Jul 9 10:26:54.020987 kernel: Normal empty Jul 9 10:26:54.020992 kernel: Movable zone start for each node Jul 9 10:26:54.020998 kernel: Early memory node ranges Jul 9 10:26:54.021005 kernel: node 0: [mem 0x0000000040000000-0x00000000d967ffff] Jul 9 10:26:54.021011 kernel: node 0: [mem 0x00000000d9680000-0x00000000d968ffff] Jul 9 10:26:54.021017 kernel: node 0: [mem 0x00000000d9690000-0x00000000d976ffff] Jul 9 10:26:54.021023 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Jul 9 10:26:54.021029 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jul 9 10:26:54.021035 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jul 9 10:26:54.021041 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jul 9 10:26:54.021047 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jul 9 10:26:54.021054 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jul 9 10:26:54.021060 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 9 10:26:54.021067 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 9 10:26:54.021082 kernel: psci: probing for conduit method from ACPI. Jul 9 10:26:54.021090 kernel: psci: PSCIv1.1 detected in firmware. Jul 9 10:26:54.021096 kernel: psci: Using standard PSCI v0.2 function IDs Jul 9 10:26:54.021104 kernel: psci: Trusted OS migration not required Jul 9 10:26:54.021110 kernel: psci: SMC Calling Convention v1.1 Jul 9 10:26:54.021117 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 9 10:26:54.021124 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jul 9 10:26:54.021130 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jul 9 10:26:54.021137 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 9 10:26:54.021143 kernel: Detected PIPT I-cache on CPU0 Jul 9 10:26:54.021150 kernel: CPU features: detected: GIC system register CPU interface Jul 9 10:26:54.021157 kernel: CPU features: detected: Hardware dirty bit management Jul 9 10:26:54.021163 kernel: CPU features: detected: Spectre-v4 Jul 9 10:26:54.021171 kernel: CPU features: detected: Spectre-BHB Jul 9 10:26:54.021178 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 9 10:26:54.021184 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 9 10:26:54.021191 kernel: CPU features: detected: ARM erratum 1418040 Jul 9 10:26:54.021197 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 9 10:26:54.021203 kernel: alternatives: applying boot alternatives Jul 9 10:26:54.021211 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=8106bab0e8f7b2aae0f933bb3a5b6e118e9ee32381eb8a383d83464922eeb861 Jul 9 10:26:54.021217 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 9 10:26:54.021224 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 9 10:26:54.021230 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 9 10:26:54.021237 kernel: Fallback order for Node 0: 0 Jul 9 10:26:54.021245 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jul 9 10:26:54.021251 kernel: Policy zone: DMA Jul 9 10:26:54.021257 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 9 10:26:54.021264 kernel: software IO TLB: area num 4. Jul 9 10:26:54.021270 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jul 9 10:26:54.021277 kernel: Memory: 2387476K/2572288K available (10368K kernel code, 2186K rwdata, 8104K rodata, 38336K init, 897K bss, 184812K reserved, 0K cma-reserved) Jul 9 10:26:54.021284 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 9 10:26:54.021290 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 9 10:26:54.021297 kernel: rcu: RCU event tracing is enabled. Jul 9 10:26:54.021304 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 9 10:26:54.021311 kernel: Trampoline variant of Tasks RCU enabled. Jul 9 10:26:54.021317 kernel: Tracing variant of Tasks RCU enabled. Jul 9 10:26:54.021325 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 9 10:26:54.021331 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 9 10:26:54.021338 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 9 10:26:54.021344 kernel: GICv3: 256 SPIs implemented Jul 9 10:26:54.021350 kernel: GICv3: 0 Extended SPIs implemented Jul 9 10:26:54.021357 kernel: Root IRQ handler: gic_handle_irq Jul 9 10:26:54.021363 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jul 9 10:26:54.021369 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 9 10:26:54.021376 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 9 10:26:54.021382 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Jul 9 10:26:54.021389 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Jul 9 10:26:54.021396 kernel: GICv3: using LPI property table @0x00000000400f0000 Jul 9 10:26:54.021403 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jul 9 10:26:54.021410 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 9 10:26:54.021416 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 9 10:26:54.021423 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 9 10:26:54.021429 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 9 10:26:54.021436 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 9 10:26:54.021442 kernel: arm-pv: using stolen time PV Jul 9 10:26:54.021449 kernel: Console: colour dummy device 80x25 Jul 9 10:26:54.021456 kernel: ACPI: Core revision 20230628 Jul 9 10:26:54.021463 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 9 10:26:54.021471 kernel: pid_max: default: 32768 minimum: 301 Jul 9 10:26:54.021477 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jul 9 10:26:54.021484 kernel: landlock: Up and running. Jul 9 10:26:54.021490 kernel: SELinux: Initializing. Jul 9 10:26:54.021497 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 9 10:26:54.021503 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 9 10:26:54.021510 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 9 10:26:54.021517 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 9 10:26:54.021523 kernel: rcu: Hierarchical SRCU implementation. Jul 9 10:26:54.021531 kernel: rcu: Max phase no-delay instances is 400. Jul 9 10:26:54.021538 kernel: Platform MSI: ITS@0x8080000 domain created Jul 9 10:26:54.021544 kernel: PCI/MSI: ITS@0x8080000 domain created Jul 9 10:26:54.021551 kernel: Remapping and enabling EFI services. Jul 9 10:26:54.021558 kernel: smp: Bringing up secondary CPUs ... Jul 9 10:26:54.021565 kernel: Detected PIPT I-cache on CPU1 Jul 9 10:26:54.021571 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 9 10:26:54.021584 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jul 9 10:26:54.021591 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 9 10:26:54.021599 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 9 10:26:54.021606 kernel: Detected PIPT I-cache on CPU2 Jul 9 10:26:54.021617 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 9 10:26:54.021625 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jul 9 10:26:54.021632 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 9 10:26:54.021639 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 9 10:26:54.021646 kernel: Detected PIPT I-cache on CPU3 Jul 9 10:26:54.021653 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 9 10:26:54.021660 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jul 9 10:26:54.021668 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 9 10:26:54.021675 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 9 10:26:54.021683 kernel: smp: Brought up 1 node, 4 CPUs Jul 9 10:26:54.021690 kernel: SMP: Total of 4 processors activated. Jul 9 10:26:54.021697 kernel: CPU features: detected: 32-bit EL0 Support Jul 9 10:26:54.021704 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 9 10:26:54.021711 kernel: CPU features: detected: Common not Private translations Jul 9 10:26:54.021718 kernel: CPU features: detected: CRC32 instructions Jul 9 10:26:54.021726 kernel: CPU features: detected: Enhanced Virtualization Traps Jul 9 10:26:54.021733 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 9 10:26:54.021741 kernel: CPU features: detected: LSE atomic instructions Jul 9 10:26:54.021748 kernel: CPU features: detected: Privileged Access Never Jul 9 10:26:54.021755 kernel: CPU features: detected: RAS Extension Support Jul 9 10:26:54.021762 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 9 10:26:54.021769 kernel: CPU: All CPU(s) started at EL1 Jul 9 10:26:54.021775 kernel: alternatives: applying system-wide alternatives Jul 9 10:26:54.021782 kernel: devtmpfs: initialized Jul 9 10:26:54.021803 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 9 10:26:54.021815 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 9 10:26:54.021822 kernel: pinctrl core: initialized pinctrl subsystem Jul 9 10:26:54.021829 kernel: SMBIOS 3.0.0 present. Jul 9 10:26:54.021837 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jul 9 10:26:54.021844 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 9 10:26:54.021851 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 9 10:26:54.021858 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 9 10:26:54.021865 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 9 10:26:54.021873 kernel: audit: initializing netlink subsys (disabled) Jul 9 10:26:54.021881 kernel: audit: type=2000 audit(0.018:1): state=initialized audit_enabled=0 res=1 Jul 9 10:26:54.021887 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 9 10:26:54.021894 kernel: cpuidle: using governor menu Jul 9 10:26:54.021901 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 9 10:26:54.021908 kernel: ASID allocator initialised with 32768 entries Jul 9 10:26:54.021915 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 9 10:26:54.021922 kernel: Serial: AMBA PL011 UART driver Jul 9 10:26:54.021929 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jul 9 10:26:54.021937 kernel: Modules: 0 pages in range for non-PLT usage Jul 9 10:26:54.021946 kernel: Modules: 509264 pages in range for PLT usage Jul 9 10:26:54.021953 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 9 10:26:54.021960 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 9 10:26:54.021967 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 9 10:26:54.021974 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 9 10:26:54.021981 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 9 10:26:54.021989 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 9 10:26:54.021996 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 9 10:26:54.022003 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 9 10:26:54.022012 kernel: ACPI: Added _OSI(Module Device) Jul 9 10:26:54.022019 kernel: ACPI: Added _OSI(Processor Device) Jul 9 10:26:54.022026 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 9 10:26:54.022046 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 9 10:26:54.022053 kernel: ACPI: Interpreter enabled Jul 9 10:26:54.022060 kernel: ACPI: Using GIC for interrupt routing Jul 9 10:26:54.022067 kernel: ACPI: MCFG table detected, 1 entries Jul 9 10:26:54.022078 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 9 10:26:54.022086 kernel: printk: console [ttyAMA0] enabled Jul 9 10:26:54.022095 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 9 10:26:54.022247 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 9 10:26:54.022321 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 9 10:26:54.022386 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 9 10:26:54.022451 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 9 10:26:54.022516 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 9 10:26:54.022526 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 9 10:26:54.022536 kernel: PCI host bridge to bus 0000:00 Jul 9 10:26:54.022605 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 9 10:26:54.022665 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 9 10:26:54.022723 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 9 10:26:54.022780 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 9 10:26:54.022885 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jul 9 10:26:54.022967 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jul 9 10:26:54.023040 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jul 9 10:26:54.023124 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jul 9 10:26:54.023203 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jul 9 10:26:54.023275 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jul 9 10:26:54.023341 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jul 9 10:26:54.023407 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jul 9 10:26:54.023473 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 9 10:26:54.023532 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 9 10:26:54.023591 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 9 10:26:54.023600 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 9 10:26:54.023607 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 9 10:26:54.023615 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 9 10:26:54.023622 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 9 10:26:54.023629 kernel: iommu: Default domain type: Translated Jul 9 10:26:54.023638 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 9 10:26:54.023645 kernel: efivars: Registered efivars operations Jul 9 10:26:54.023652 kernel: vgaarb: loaded Jul 9 10:26:54.023659 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 9 10:26:54.023666 kernel: VFS: Disk quotas dquot_6.6.0 Jul 9 10:26:54.023673 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 9 10:26:54.023681 kernel: pnp: PnP ACPI init Jul 9 10:26:54.023804 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 9 10:26:54.023816 kernel: pnp: PnP ACPI: found 1 devices Jul 9 10:26:54.023826 kernel: NET: Registered PF_INET protocol family Jul 9 10:26:54.023834 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 9 10:26:54.023841 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 9 10:26:54.023848 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 9 10:26:54.023856 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 9 10:26:54.023863 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 9 10:26:54.023870 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 9 10:26:54.023877 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 9 10:26:54.023886 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 9 10:26:54.023893 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 9 10:26:54.023901 kernel: PCI: CLS 0 bytes, default 64 Jul 9 10:26:54.023908 kernel: kvm [1]: HYP mode not available Jul 9 10:26:54.023915 kernel: Initialise system trusted keyrings Jul 9 10:26:54.023922 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 9 10:26:54.023929 kernel: Key type asymmetric registered Jul 9 10:26:54.023935 kernel: Asymmetric key parser 'x509' registered Jul 9 10:26:54.023942 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 9 10:26:54.023951 kernel: io scheduler mq-deadline registered Jul 9 10:26:54.023958 kernel: io scheduler kyber registered Jul 9 10:26:54.023965 kernel: io scheduler bfq registered Jul 9 10:26:54.023972 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 9 10:26:54.023979 kernel: ACPI: button: Power Button [PWRB] Jul 9 10:26:54.023987 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 9 10:26:54.024060 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 9 10:26:54.024070 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 9 10:26:54.024084 kernel: thunder_xcv, ver 1.0 Jul 9 10:26:54.024091 kernel: thunder_bgx, ver 1.0 Jul 9 10:26:54.024100 kernel: nicpf, ver 1.0 Jul 9 10:26:54.024108 kernel: nicvf, ver 1.0 Jul 9 10:26:54.024190 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 9 10:26:54.024254 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-09T10:26:53 UTC (1752056813) Jul 9 10:26:54.024264 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 9 10:26:54.024271 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jul 9 10:26:54.024278 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jul 9 10:26:54.024285 kernel: watchdog: Hard watchdog permanently disabled Jul 9 10:26:54.024294 kernel: NET: Registered PF_INET6 protocol family Jul 9 10:26:54.024301 kernel: Segment Routing with IPv6 Jul 9 10:26:54.024308 kernel: In-situ OAM (IOAM) with IPv6 Jul 9 10:26:54.024315 kernel: NET: Registered PF_PACKET protocol family Jul 9 10:26:54.024322 kernel: Key type dns_resolver registered Jul 9 10:26:54.024329 kernel: registered taskstats version 1 Jul 9 10:26:54.024336 kernel: Loading compiled-in X.509 certificates Jul 9 10:26:54.024343 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.96-flatcar: 41c1c5381fe8e35ae22346a08da6d25fbc0dc23e' Jul 9 10:26:54.024350 kernel: Key type .fscrypt registered Jul 9 10:26:54.024358 kernel: Key type fscrypt-provisioning registered Jul 9 10:26:54.024365 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 9 10:26:54.024372 kernel: ima: Allocated hash algorithm: sha1 Jul 9 10:26:54.024380 kernel: ima: No architecture policies found Jul 9 10:26:54.024387 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 9 10:26:54.024394 kernel: clk: Disabling unused clocks Jul 9 10:26:54.024401 kernel: Freeing unused kernel memory: 38336K Jul 9 10:26:54.024408 kernel: Run /init as init process Jul 9 10:26:54.024416 kernel: with arguments: Jul 9 10:26:54.024423 kernel: /init Jul 9 10:26:54.024430 kernel: with environment: Jul 9 10:26:54.024437 kernel: HOME=/ Jul 9 10:26:54.024444 kernel: TERM=linux Jul 9 10:26:54.024451 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 9 10:26:54.024459 systemd[1]: Successfully made /usr/ read-only. Jul 9 10:26:54.024473 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jul 9 10:26:54.024484 systemd[1]: Detected virtualization kvm. Jul 9 10:26:54.024492 systemd[1]: Detected architecture arm64. Jul 9 10:26:54.024503 systemd[1]: Running in initrd. Jul 9 10:26:54.024513 systemd[1]: No hostname configured, using default hostname. Jul 9 10:26:54.024521 systemd[1]: Hostname set to . Jul 9 10:26:54.024529 systemd[1]: Initializing machine ID from VM UUID. Jul 9 10:26:54.024536 systemd[1]: Queued start job for default target initrd.target. Jul 9 10:26:54.024544 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 9 10:26:54.024554 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 9 10:26:54.024562 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 9 10:26:54.024572 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 9 10:26:54.024579 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 9 10:26:54.024588 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 9 10:26:54.024597 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 9 10:26:54.024609 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 9 10:26:54.024622 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 9 10:26:54.024632 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 9 10:26:54.024640 systemd[1]: Reached target paths.target - Path Units. Jul 9 10:26:54.024651 systemd[1]: Reached target slices.target - Slice Units. Jul 9 10:26:54.024658 systemd[1]: Reached target swap.target - Swaps. Jul 9 10:26:54.024666 systemd[1]: Reached target timers.target - Timer Units. Jul 9 10:26:54.024673 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 9 10:26:54.024681 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 9 10:26:54.024688 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 9 10:26:54.024697 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 9 10:26:54.024705 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 9 10:26:54.024713 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 9 10:26:54.024720 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 9 10:26:54.024728 systemd[1]: Reached target sockets.target - Socket Units. Jul 9 10:26:54.024735 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 9 10:26:54.024743 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 9 10:26:54.024751 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 9 10:26:54.024761 systemd[1]: Starting systemd-fsck-usr.service... Jul 9 10:26:54.024769 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 9 10:26:54.024777 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 9 10:26:54.024784 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 9 10:26:54.024801 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 9 10:26:54.024809 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 9 10:26:54.024819 systemd[1]: Finished systemd-fsck-usr.service. Jul 9 10:26:54.024827 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 9 10:26:54.024835 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 9 10:26:54.024861 systemd-journald[238]: Collecting audit messages is disabled. Jul 9 10:26:54.024882 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 9 10:26:54.024891 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 9 10:26:54.024900 systemd-journald[238]: Journal started Jul 9 10:26:54.024918 systemd-journald[238]: Runtime Journal (/run/log/journal/d04298f685f743f5949fdf8f6a9cd9db) is 5.9M, max 47.3M, 41.4M free. Jul 9 10:26:54.008387 systemd-modules-load[239]: Inserted module 'overlay' Jul 9 10:26:54.029864 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 9 10:26:54.029912 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 9 10:26:54.031639 kernel: Bridge firewalling registered Jul 9 10:26:54.031658 systemd-modules-load[239]: Inserted module 'br_netfilter' Jul 9 10:26:54.033811 systemd[1]: Started systemd-journald.service - Journal Service. Jul 9 10:26:54.035462 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 9 10:26:54.038903 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 9 10:26:54.041549 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 9 10:26:54.053953 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 9 10:26:54.055695 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 9 10:26:54.059423 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 9 10:26:54.068199 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 9 10:26:54.069504 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 9 10:26:54.073034 dracut-cmdline[270]: dracut-dracut-053 Jul 9 10:26:54.073965 dracut-cmdline[270]: Using kernel command line parameters: rd.driver.pre=btrfs 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=8106bab0e8f7b2aae0f933bb3a5b6e118e9ee32381eb8a383d83464922eeb861 Jul 9 10:26:54.081011 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 9 10:26:54.115619 systemd-resolved[292]: Positive Trust Anchors: Jul 9 10:26:54.115643 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 9 10:26:54.115675 systemd-resolved[292]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 9 10:26:54.121308 systemd-resolved[292]: Defaulting to hostname 'linux'. Jul 9 10:26:54.122307 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 9 10:26:54.125562 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 9 10:26:54.153855 kernel: SCSI subsystem initialized Jul 9 10:26:54.160804 kernel: Loading iSCSI transport class v2.0-870. Jul 9 10:26:54.168818 kernel: iscsi: registered transport (tcp) Jul 9 10:26:54.182052 kernel: iscsi: registered transport (qla4xxx) Jul 9 10:26:54.182090 kernel: QLogic iSCSI HBA Driver Jul 9 10:26:54.225777 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 9 10:26:54.234959 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 9 10:26:54.255901 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 9 10:26:54.255947 kernel: device-mapper: uevent: version 1.0.3 Jul 9 10:26:54.257557 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jul 9 10:26:54.302819 kernel: raid6: neonx8 gen() 15782 MB/s Jul 9 10:26:54.319814 kernel: raid6: neonx4 gen() 15793 MB/s Jul 9 10:26:54.336813 kernel: raid6: neonx2 gen() 13207 MB/s Jul 9 10:26:54.353820 kernel: raid6: neonx1 gen() 10502 MB/s Jul 9 10:26:54.370819 kernel: raid6: int64x8 gen() 6780 MB/s Jul 9 10:26:54.387818 kernel: raid6: int64x4 gen() 7343 MB/s Jul 9 10:26:54.404819 kernel: raid6: int64x2 gen() 6106 MB/s Jul 9 10:26:54.421883 kernel: raid6: int64x1 gen() 5052 MB/s Jul 9 10:26:54.421897 kernel: raid6: using algorithm neonx4 gen() 15793 MB/s Jul 9 10:26:54.439884 kernel: raid6: .... xor() 12383 MB/s, rmw enabled Jul 9 10:26:54.439897 kernel: raid6: using neon recovery algorithm Jul 9 10:26:54.445233 kernel: xor: measuring software checksum speed Jul 9 10:26:54.445252 kernel: 8regs : 21618 MB/sec Jul 9 10:26:54.445881 kernel: 32regs : 21681 MB/sec Jul 9 10:26:54.447099 kernel: arm64_neon : 27729 MB/sec Jul 9 10:26:54.447111 kernel: xor: using function: arm64_neon (27729 MB/sec) Jul 9 10:26:54.499816 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 9 10:26:54.510576 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 9 10:26:54.520940 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 9 10:26:54.536222 systemd-udevd[466]: Using default interface naming scheme 'v255'. Jul 9 10:26:54.540027 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 9 10:26:54.551966 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 9 10:26:54.563167 dracut-pre-trigger[474]: rd.md=0: removing MD RAID activation Jul 9 10:26:54.589913 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 9 10:26:54.599940 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 9 10:26:54.642261 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 9 10:26:54.650996 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 9 10:26:54.662579 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 9 10:26:54.664269 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 9 10:26:54.667896 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 9 10:26:54.670012 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 9 10:26:54.680929 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 9 10:26:54.688901 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 9 10:26:54.704574 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jul 9 10:26:54.705609 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 9 10:26:54.712738 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 9 10:26:54.713870 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 9 10:26:54.712915 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 9 10:26:54.716754 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 9 10:26:54.718493 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 9 10:26:54.718694 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 9 10:26:54.723135 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 9 10:26:54.734811 kernel: BTRFS: device fsid c58bb8ce-1b39-452b-9f5f-454a5cd013ab devid 1 transid 36 /dev/vda3 scanned by (udev-worker) (509) Jul 9 10:26:54.737089 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 9 10:26:54.739142 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (512) Jul 9 10:26:54.752846 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 9 10:26:54.765588 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 9 10:26:54.777462 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 9 10:26:54.783705 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 9 10:26:54.785016 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 9 10:26:54.793920 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 9 10:26:54.806983 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 9 10:26:54.809019 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 9 10:26:54.820551 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 9 10:26:54.831177 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 9 10:26:55.826816 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 9 10:26:55.827174 disk-uuid[556]: The operation has completed successfully. Jul 9 10:26:55.855233 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 9 10:26:55.855353 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 9 10:26:55.887939 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 9 10:26:55.893033 sh[577]: Success Jul 9 10:26:55.911832 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jul 9 10:26:55.954776 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 9 10:26:55.956740 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 9 10:26:55.959217 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 9 10:26:55.970907 kernel: BTRFS info (device dm-0): first mount of filesystem c58bb8ce-1b39-452b-9f5f-454a5cd013ab Jul 9 10:26:55.970946 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 9 10:26:55.972017 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jul 9 10:26:55.972033 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jul 9 10:26:55.973381 kernel: BTRFS info (device dm-0): using free space tree Jul 9 10:26:55.976584 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 9 10:26:55.977960 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 9 10:26:55.985937 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 9 10:26:55.987611 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 9 10:26:56.002870 kernel: BTRFS info (device vda6): first mount of filesystem 1c7652f0-6738-4f88-afc7-d770f62208e3 Jul 9 10:26:56.002922 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 9 10:26:56.003807 kernel: BTRFS info (device vda6): using free space tree Jul 9 10:26:56.007051 kernel: BTRFS info (device vda6): auto enabling async discard Jul 9 10:26:56.010826 kernel: BTRFS info (device vda6): last unmount of filesystem 1c7652f0-6738-4f88-afc7-d770f62208e3 Jul 9 10:26:56.013487 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 9 10:26:56.021005 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 9 10:26:56.097847 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 9 10:26:56.120470 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 9 10:26:56.162142 systemd-networkd[761]: lo: Link UP Jul 9 10:26:56.162151 systemd-networkd[761]: lo: Gained carrier Jul 9 10:26:56.163120 systemd-networkd[761]: Enumeration completed Jul 9 10:26:56.163374 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 9 10:26:56.165108 systemd[1]: Reached target network.target - Network. Jul 9 10:26:56.166767 systemd-networkd[761]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 9 10:26:56.166772 systemd-networkd[761]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 9 10:26:56.168844 systemd-networkd[761]: eth0: Link UP Jul 9 10:26:56.168847 systemd-networkd[761]: eth0: Gained carrier Jul 9 10:26:56.168855 systemd-networkd[761]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 9 10:26:56.183451 ignition[669]: Ignition 2.20.0 Jul 9 10:26:56.183467 ignition[669]: Stage: fetch-offline Jul 9 10:26:56.183528 ignition[669]: no configs at "/usr/lib/ignition/base.d" Jul 9 10:26:56.183538 ignition[669]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 9 10:26:56.183877 ignition[669]: parsed url from cmdline: "" Jul 9 10:26:56.186845 systemd-networkd[761]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 9 10:26:56.183881 ignition[669]: no config URL provided Jul 9 10:26:56.183886 ignition[669]: reading system config file "/usr/lib/ignition/user.ign" Jul 9 10:26:56.183893 ignition[669]: no config at "/usr/lib/ignition/user.ign" Jul 9 10:26:56.183916 ignition[669]: op(1): [started] loading QEMU firmware config module Jul 9 10:26:56.183920 ignition[669]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 9 10:26:56.200032 ignition[669]: op(1): [finished] loading QEMU firmware config module Jul 9 10:26:56.204357 ignition[669]: parsing config with SHA512: f39ac6912d8af7841c376f57f1135e42bf3267516572e7924069a19605bf29a3252cb7cce8a15386d3ca99897014049a43a4c5112ab95d14bd132d8121f8e447 Jul 9 10:26:56.211393 unknown[669]: fetched base config from "system" Jul 9 10:26:56.211405 unknown[669]: fetched user config from "qemu" Jul 9 10:26:56.211615 ignition[669]: fetch-offline: fetch-offline passed Jul 9 10:26:56.213682 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 9 10:26:56.211695 ignition[669]: Ignition finished successfully Jul 9 10:26:56.215151 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 9 10:26:56.224946 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 9 10:26:56.237501 ignition[774]: Ignition 2.20.0 Jul 9 10:26:56.237513 ignition[774]: Stage: kargs Jul 9 10:26:56.237678 ignition[774]: no configs at "/usr/lib/ignition/base.d" Jul 9 10:26:56.237688 ignition[774]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 9 10:26:56.240396 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 9 10:26:56.238316 ignition[774]: kargs: kargs passed Jul 9 10:26:56.238360 ignition[774]: Ignition finished successfully Jul 9 10:26:56.253960 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 9 10:26:56.263608 ignition[783]: Ignition 2.20.0 Jul 9 10:26:56.263619 ignition[783]: Stage: disks Jul 9 10:26:56.263822 ignition[783]: no configs at "/usr/lib/ignition/base.d" Jul 9 10:26:56.263833 ignition[783]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 9 10:26:56.266882 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 9 10:26:56.264472 ignition[783]: disks: disks passed Jul 9 10:26:56.268142 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 9 10:26:56.264516 ignition[783]: Ignition finished successfully Jul 9 10:26:56.269837 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 9 10:26:56.271539 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 9 10:26:56.273558 systemd[1]: Reached target sysinit.target - System Initialization. Jul 9 10:26:56.275211 systemd[1]: Reached target basic.target - Basic System. Jul 9 10:26:56.288942 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 9 10:26:56.296640 systemd-resolved[292]: Detected conflict on linux IN A 10.0.0.5 Jul 9 10:26:56.296655 systemd-resolved[292]: Hostname conflict, changing published hostname from 'linux' to 'linux6'. Jul 9 10:26:56.299483 systemd-fsck[794]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jul 9 10:26:56.303173 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 9 10:26:56.306510 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 9 10:26:56.354813 kernel: EXT4-fs (vda9): mounted filesystem 2188e201-95c4-4c53-8dbf-8a24eaac44bf r/w with ordered data mode. Quota mode: none. Jul 9 10:26:56.354969 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 9 10:26:56.356286 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 9 10:26:56.375901 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 9 10:26:56.377775 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 9 10:26:56.379282 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 9 10:26:56.379334 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 9 10:26:56.389701 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (802) Jul 9 10:26:56.389726 kernel: BTRFS info (device vda6): first mount of filesystem 1c7652f0-6738-4f88-afc7-d770f62208e3 Jul 9 10:26:56.389736 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 9 10:26:56.389745 kernel: BTRFS info (device vda6): using free space tree Jul 9 10:26:56.379359 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 9 10:26:56.384024 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 9 10:26:56.386381 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 9 10:26:56.395803 kernel: BTRFS info (device vda6): auto enabling async discard Jul 9 10:26:56.396940 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 9 10:26:56.446215 initrd-setup-root[826]: cut: /sysroot/etc/passwd: No such file or directory Jul 9 10:26:56.450108 initrd-setup-root[833]: cut: /sysroot/etc/group: No such file or directory Jul 9 10:26:56.453835 initrd-setup-root[840]: cut: /sysroot/etc/shadow: No such file or directory Jul 9 10:26:56.457476 initrd-setup-root[847]: cut: /sysroot/etc/gshadow: No such file or directory Jul 9 10:26:56.529610 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 9 10:26:56.538883 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 9 10:26:56.541333 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 9 10:26:56.546810 kernel: BTRFS info (device vda6): last unmount of filesystem 1c7652f0-6738-4f88-afc7-d770f62208e3 Jul 9 10:26:56.562347 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 9 10:26:56.564241 ignition[916]: INFO : Ignition 2.20.0 Jul 9 10:26:56.564241 ignition[916]: INFO : Stage: mount Jul 9 10:26:56.564241 ignition[916]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 9 10:26:56.564241 ignition[916]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 9 10:26:56.569013 ignition[916]: INFO : mount: mount passed Jul 9 10:26:56.569013 ignition[916]: INFO : Ignition finished successfully Jul 9 10:26:56.565483 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 9 10:26:56.577907 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 9 10:26:57.126234 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 9 10:26:57.139961 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 9 10:26:57.145801 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (929) Jul 9 10:26:57.145839 kernel: BTRFS info (device vda6): first mount of filesystem 1c7652f0-6738-4f88-afc7-d770f62208e3 Jul 9 10:26:57.148365 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 9 10:26:57.148380 kernel: BTRFS info (device vda6): using free space tree Jul 9 10:26:57.150799 kernel: BTRFS info (device vda6): auto enabling async discard Jul 9 10:26:57.151704 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 9 10:26:57.166663 ignition[946]: INFO : Ignition 2.20.0 Jul 9 10:26:57.166663 ignition[946]: INFO : Stage: files Jul 9 10:26:57.168377 ignition[946]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 9 10:26:57.168377 ignition[946]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 9 10:26:57.168377 ignition[946]: DEBUG : files: compiled without relabeling support, skipping Jul 9 10:26:57.171934 ignition[946]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 9 10:26:57.171934 ignition[946]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 9 10:26:57.174764 ignition[946]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 9 10:26:57.174764 ignition[946]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 9 10:26:57.174764 ignition[946]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 9 10:26:57.174764 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 9 10:26:57.174764 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jul 9 10:26:57.174764 ignition[946]: 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" Jul 9 10:26:57.174764 ignition[946]: 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" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jul 9 10:26:57.174764 ignition[946]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Jul 9 10:26:57.172581 unknown[946]: wrote ssh authorized keys file for user: core Jul 9 10:26:57.201307 ignition[946]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 9 10:26:57.201307 ignition[946]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 9 10:26:57.201307 ignition[946]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Jul 9 10:26:57.201307 ignition[946]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Jul 9 10:26:57.201307 ignition[946]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Jul 9 10:26:57.201307 ignition[946]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 9 10:26:57.201307 ignition[946]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 9 10:26:57.201307 ignition[946]: INFO : files: files passed Jul 9 10:26:57.201307 ignition[946]: INFO : Ignition finished successfully Jul 9 10:26:57.197361 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 9 10:26:57.207946 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 9 10:26:57.210453 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 9 10:26:57.212672 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 9 10:26:57.222558 initrd-setup-root-after-ignition[974]: grep: /sysroot/oem/oem-release: No such file or directory Jul 9 10:26:57.212801 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 9 10:26:57.226042 initrd-setup-root-after-ignition[977]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 9 10:26:57.226042 initrd-setup-root-after-ignition[977]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 9 10:26:57.223464 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 9 10:26:57.231342 initrd-setup-root-after-ignition[981]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 9 10:26:57.225446 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 9 10:26:57.235920 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 9 10:26:57.254584 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 9 10:26:57.254722 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 9 10:26:57.257023 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 9 10:26:57.258866 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 9 10:26:57.260804 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 9 10:26:57.261569 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 9 10:26:57.276451 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 9 10:26:57.278871 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 9 10:26:57.289359 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 9 10:26:57.290635 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 9 10:26:57.292818 systemd[1]: Stopped target timers.target - Timer Units. Jul 9 10:26:57.294727 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 9 10:26:57.294856 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 9 10:26:57.297542 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 9 10:26:57.299687 systemd[1]: Stopped target basic.target - Basic System. Jul 9 10:26:57.301461 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 9 10:26:57.303280 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 9 10:26:57.305334 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 9 10:26:57.307417 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 9 10:26:57.309370 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 9 10:26:57.311425 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 9 10:26:57.313501 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 9 10:26:57.315323 systemd[1]: Stopped target swap.target - Swaps. Jul 9 10:26:57.316943 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 9 10:26:57.317055 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 9 10:26:57.319535 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 9 10:26:57.321603 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 9 10:26:57.323645 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 9 10:26:57.326858 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 9 10:26:57.328259 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 9 10:26:57.328367 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 9 10:26:57.331376 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 9 10:26:57.331498 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 9 10:26:57.333632 systemd[1]: Stopped target paths.target - Path Units. Jul 9 10:26:57.335311 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 9 10:26:57.339838 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 9 10:26:57.341305 systemd[1]: Stopped target slices.target - Slice Units. Jul 9 10:26:57.343711 systemd[1]: Stopped target sockets.target - Socket Units. Jul 9 10:26:57.345381 systemd[1]: iscsid.socket: Deactivated successfully. Jul 9 10:26:57.345505 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 9 10:26:57.347096 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 9 10:26:57.347215 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 9 10:26:57.348762 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 9 10:26:57.348942 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 9 10:26:57.350845 systemd[1]: ignition-files.service: Deactivated successfully. Jul 9 10:26:57.350999 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 9 10:26:57.360011 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 9 10:26:57.361051 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 9 10:26:57.361271 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 9 10:26:57.365641 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 9 10:26:57.366597 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 9 10:26:57.367877 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 9 10:26:57.372586 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 9 10:26:57.372701 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 9 10:26:57.376824 ignition[1001]: INFO : Ignition 2.20.0 Jul 9 10:26:57.376824 ignition[1001]: INFO : Stage: umount Jul 9 10:26:57.378648 ignition[1001]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 9 10:26:57.378648 ignition[1001]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 9 10:26:57.378648 ignition[1001]: INFO : umount: umount passed Jul 9 10:26:57.378648 ignition[1001]: INFO : Ignition finished successfully Jul 9 10:26:57.378614 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 9 10:26:57.378701 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 9 10:26:57.381963 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 9 10:26:57.382388 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 9 10:26:57.382471 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 9 10:26:57.385149 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 9 10:26:57.385230 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 9 10:26:57.386986 systemd[1]: Stopped target network.target - Network. Jul 9 10:26:57.387964 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 9 10:26:57.388023 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 9 10:26:57.389782 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 9 10:26:57.389849 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 9 10:26:57.391907 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 9 10:26:57.391952 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 9 10:26:57.393639 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 9 10:26:57.393681 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 9 10:26:57.395506 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 9 10:26:57.395553 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 9 10:26:57.397536 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 9 10:26:57.399336 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 9 10:26:57.403439 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 9 10:26:57.403543 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 9 10:26:57.406679 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 9 10:26:57.406944 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 9 10:26:57.406984 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 9 10:26:57.411744 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jul 9 10:26:57.411997 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 9 10:26:57.412102 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 9 10:26:57.414766 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 9 10:26:57.414847 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 9 10:26:57.425878 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 9 10:26:57.427351 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 9 10:26:57.427417 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 9 10:26:57.429917 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 9 10:26:57.429967 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 9 10:26:57.432741 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 9 10:26:57.432783 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 9 10:26:57.433995 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 9 10:26:57.444020 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 9 10:26:57.444134 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 9 10:26:57.455386 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 9 10:26:57.455539 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 9 10:26:57.457813 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 9 10:26:57.457853 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 9 10:26:57.459761 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 9 10:26:57.459808 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 9 10:26:57.461684 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 9 10:26:57.461735 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 9 10:26:57.464596 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 9 10:26:57.464642 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 9 10:26:57.467384 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 9 10:26:57.467430 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 9 10:26:57.480931 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 9 10:26:57.482027 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 9 10:26:57.482098 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 9 10:26:57.485220 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 9 10:26:57.485264 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 9 10:26:57.488590 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 9 10:26:57.488679 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 9 10:26:57.490824 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 9 10:26:57.493044 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 9 10:26:57.501624 systemd[1]: Switching root. Jul 9 10:26:57.525902 systemd-journald[238]: Journal stopped Jul 9 10:26:58.263741 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Jul 9 10:26:58.263824 kernel: SELinux: policy capability network_peer_controls=1 Jul 9 10:26:58.263839 kernel: SELinux: policy capability open_perms=1 Jul 9 10:26:58.263853 kernel: SELinux: policy capability extended_socket_class=1 Jul 9 10:26:58.263866 kernel: SELinux: policy capability always_check_network=0 Jul 9 10:26:58.263875 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 9 10:26:58.263884 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 9 10:26:58.263894 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 9 10:26:58.263902 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 9 10:26:58.263912 kernel: audit: type=1403 audit(1752056817.591:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 9 10:26:58.263922 systemd[1]: Successfully loaded SELinux policy in 37.860ms. Jul 9 10:26:58.263939 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.415ms. Jul 9 10:26:58.263951 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jul 9 10:26:58.263963 systemd[1]: Detected virtualization kvm. Jul 9 10:26:58.263973 systemd[1]: Detected architecture arm64. Jul 9 10:26:58.263983 systemd[1]: Detected first boot. Jul 9 10:26:58.263993 systemd[1]: Initializing machine ID from VM UUID. Jul 9 10:26:58.264003 zram_generator::config[1048]: No configuration found. Jul 9 10:26:58.264014 kernel: NET: Registered PF_VSOCK protocol family Jul 9 10:26:58.264024 systemd[1]: Populated /etc with preset unit settings. Jul 9 10:26:58.264040 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 9 10:26:58.264054 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 9 10:26:58.264073 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 9 10:26:58.264084 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 9 10:26:58.264095 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 9 10:26:58.264108 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 9 10:26:58.264118 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 9 10:26:58.264129 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 9 10:26:58.264139 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 9 10:26:58.264150 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 9 10:26:58.264160 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 9 10:26:58.264170 systemd[1]: Created slice user.slice - User and Session Slice. Jul 9 10:26:58.264180 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 9 10:26:58.264191 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 9 10:26:58.264203 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 9 10:26:58.264215 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 9 10:26:58.264230 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 9 10:26:58.264240 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 9 10:26:58.264250 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jul 9 10:26:58.264260 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 9 10:26:58.264271 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 9 10:26:58.264281 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 9 10:26:58.264293 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 9 10:26:58.264305 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 9 10:26:58.264315 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 9 10:26:58.264325 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 9 10:26:58.264335 systemd[1]: Reached target slices.target - Slice Units. Jul 9 10:26:58.264346 systemd[1]: Reached target swap.target - Swaps. Jul 9 10:26:58.264356 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 9 10:26:58.264366 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 9 10:26:58.264376 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 9 10:26:58.264386 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 9 10:26:58.264398 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 9 10:26:58.264408 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 9 10:26:58.264418 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 9 10:26:58.264429 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 9 10:26:58.264439 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 9 10:26:58.264449 systemd[1]: Mounting media.mount - External Media Directory... Jul 9 10:26:58.264459 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 9 10:26:58.264470 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 9 10:26:58.264480 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 9 10:26:58.264492 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jul 9 10:26:58.264502 systemd[1]: Reached target machines.target - Containers. Jul 9 10:26:58.264512 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 9 10:26:58.264523 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 9 10:26:58.264533 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 9 10:26:58.264544 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 9 10:26:58.264554 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 9 10:26:58.264564 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 9 10:26:58.264576 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 9 10:26:58.264586 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 9 10:26:58.264596 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 9 10:26:58.264606 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 9 10:26:58.264617 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 9 10:26:58.264627 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 9 10:26:58.264637 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 9 10:26:58.264647 systemd[1]: Stopped systemd-fsck-usr.service. Jul 9 10:26:58.264657 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 9 10:26:58.264669 kernel: fuse: init (API version 7.39) Jul 9 10:26:58.264679 kernel: loop: module loaded Jul 9 10:26:58.264688 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 9 10:26:58.264698 kernel: ACPI: bus type drm_connector registered Jul 9 10:26:58.264708 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 9 10:26:58.264719 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 9 10:26:58.264731 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 9 10:26:58.264741 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 9 10:26:58.264753 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 9 10:26:58.264764 systemd[1]: verity-setup.service: Deactivated successfully. Jul 9 10:26:58.264774 systemd[1]: Stopped verity-setup.service. Jul 9 10:26:58.264784 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 9 10:26:58.264827 systemd-journald[1123]: Collecting audit messages is disabled. Jul 9 10:26:58.264851 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 9 10:26:58.264862 systemd[1]: Mounted media.mount - External Media Directory. Jul 9 10:26:58.264872 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 9 10:26:58.264883 systemd-journald[1123]: Journal started Jul 9 10:26:58.264904 systemd-journald[1123]: Runtime Journal (/run/log/journal/d04298f685f743f5949fdf8f6a9cd9db) is 5.9M, max 47.3M, 41.4M free. Jul 9 10:26:58.014084 systemd[1]: Queued start job for default target multi-user.target. Jul 9 10:26:58.030865 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 9 10:26:58.031251 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 9 10:26:58.267232 systemd[1]: Started systemd-journald.service - Journal Service. Jul 9 10:26:58.268034 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 9 10:26:58.269360 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 9 10:26:58.271866 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 9 10:26:58.273432 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 9 10:26:58.275026 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 9 10:26:58.275224 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 9 10:26:58.276763 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 9 10:26:58.276971 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 9 10:26:58.278463 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 9 10:26:58.278659 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 9 10:26:58.280114 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 9 10:26:58.280282 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 9 10:26:58.281990 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 9 10:26:58.282172 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 9 10:26:58.283533 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 9 10:26:58.283702 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 9 10:26:58.285252 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 9 10:26:58.287021 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 9 10:26:58.288659 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 9 10:26:58.290328 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 9 10:26:58.304421 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 9 10:26:58.316959 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 9 10:26:58.319378 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 9 10:26:58.320631 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 9 10:26:58.320678 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 9 10:26:58.322890 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 9 10:26:58.325500 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 9 10:26:58.328003 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 9 10:26:58.329216 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 9 10:26:58.330883 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 9 10:26:58.333136 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 9 10:26:58.334583 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 9 10:26:58.336054 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 9 10:26:58.337306 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 9 10:26:58.338545 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 9 10:26:58.344267 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 9 10:26:58.344684 systemd-journald[1123]: Time spent on flushing to /var/log/journal/d04298f685f743f5949fdf8f6a9cd9db is 15.098ms for 837 entries. Jul 9 10:26:58.344684 systemd-journald[1123]: System Journal (/var/log/journal/d04298f685f743f5949fdf8f6a9cd9db) is 8M, max 195.6M, 187.6M free. Jul 9 10:26:58.377331 systemd-journald[1123]: Received client request to flush runtime journal. Jul 9 10:26:58.377383 kernel: loop0: detected capacity change from 0 to 113512 Jul 9 10:26:58.351031 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 9 10:26:58.354352 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 9 10:26:58.356010 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 9 10:26:58.358289 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 9 10:26:58.360181 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 9 10:26:58.365045 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 9 10:26:58.370107 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 9 10:26:58.380135 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 9 10:26:58.383818 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 9 10:26:58.387312 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jul 9 10:26:58.390836 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 9 10:26:58.396753 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 9 10:26:58.401003 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 9 10:26:58.405988 udevadm[1177]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 9 10:26:58.419001 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 9 10:26:58.428845 kernel: loop1: detected capacity change from 0 to 123192 Jul 9 10:26:58.430980 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 9 10:26:58.459262 systemd-tmpfiles[1185]: ACLs are not supported, ignoring. Jul 9 10:26:58.459280 systemd-tmpfiles[1185]: ACLs are not supported, ignoring. Jul 9 10:26:58.463978 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 9 10:26:58.467832 kernel: loop2: detected capacity change from 0 to 113512 Jul 9 10:26:58.473871 kernel: loop3: detected capacity change from 0 to 123192 Jul 9 10:26:58.477661 (sd-merge)[1189]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jul 9 10:26:58.478525 (sd-merge)[1189]: Merged extensions into '/usr'. Jul 9 10:26:58.482507 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 9 10:26:58.495096 systemd[1]: Starting ensure-sysext.service... Jul 9 10:26:58.500047 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 9 10:26:58.506651 systemd[1]: Reload requested from client PID 1192 ('systemctl') (unit ensure-sysext.service)... Jul 9 10:26:58.506667 systemd[1]: Reloading... Jul 9 10:26:58.532246 systemd-tmpfiles[1193]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 9 10:26:58.532453 systemd-tmpfiles[1193]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 9 10:26:58.533220 systemd-tmpfiles[1193]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 9 10:26:58.533424 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Jul 9 10:26:58.533486 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Jul 9 10:26:58.536372 systemd-tmpfiles[1193]: Detected autofs mount point /boot during canonicalization of boot. Jul 9 10:26:58.536384 systemd-tmpfiles[1193]: Skipping /boot Jul 9 10:26:58.546284 systemd-tmpfiles[1193]: Detected autofs mount point /boot during canonicalization of boot. Jul 9 10:26:58.546299 systemd-tmpfiles[1193]: Skipping /boot Jul 9 10:26:58.591817 zram_generator::config[1223]: No configuration found. Jul 9 10:26:58.671874 ldconfig[1160]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 9 10:26:58.696865 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 9 10:26:58.753846 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 9 10:26:58.754317 systemd[1]: Reloading finished in 247 ms. Jul 9 10:26:58.772852 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 9 10:26:58.789548 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 9 10:26:58.798578 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 9 10:26:58.801618 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 9 10:26:58.805696 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 9 10:26:58.808967 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 9 10:26:58.811394 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 9 10:26:58.814884 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 9 10:26:58.816247 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 9 10:26:58.818587 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 9 10:26:58.821013 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 9 10:26:58.822202 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 9 10:26:58.822339 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 9 10:26:58.823319 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 9 10:26:58.824832 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 9 10:26:58.826738 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 9 10:26:58.826916 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 9 10:26:58.828750 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 9 10:26:58.828940 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 9 10:26:58.835177 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 9 10:26:58.844100 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 9 10:26:58.849461 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 9 10:26:58.853119 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 9 10:26:58.856146 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 9 10:26:58.856305 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 9 10:26:58.858940 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 9 10:26:58.862831 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 9 10:26:58.865361 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 9 10:26:58.865584 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 9 10:26:58.868653 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 9 10:26:58.868989 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 9 10:26:58.873487 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 9 10:26:58.873686 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 9 10:26:58.879894 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 9 10:26:58.880170 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 9 10:26:58.886819 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 9 10:26:58.889216 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 9 10:26:58.894644 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 9 10:26:58.898889 systemd[1]: Finished ensure-sysext.service. Jul 9 10:26:58.904043 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 9 10:26:58.921901 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 9 10:26:58.924389 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 9 10:26:58.927320 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 9 10:26:58.931556 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 9 10:26:58.932840 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 9 10:26:58.932890 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 9 10:26:58.933168 augenrules[1307]: No rules Jul 9 10:26:58.935011 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 9 10:26:58.937890 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 9 10:26:58.940605 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 9 10:26:58.941727 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jul 9 10:26:58.942203 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 9 10:26:58.943734 systemd[1]: audit-rules.service: Deactivated successfully. Jul 9 10:26:58.945844 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 9 10:26:58.947334 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 9 10:26:58.947509 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 9 10:26:58.949095 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 9 10:26:58.949269 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 9 10:26:58.952294 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 9 10:26:58.952475 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 9 10:26:58.954260 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 9 10:26:58.954531 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 9 10:26:58.960138 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 9 10:26:58.960328 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 9 10:26:58.971489 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 9 10:26:58.973729 systemd-udevd[1316]: Using default interface naming scheme 'v255'. Jul 9 10:26:58.991774 systemd-resolved[1262]: Positive Trust Anchors: Jul 9 10:26:58.991988 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 9 10:26:58.993837 systemd-resolved[1262]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 9 10:26:58.993874 systemd-resolved[1262]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 9 10:26:59.001024 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 9 10:26:59.001044 systemd-resolved[1262]: Defaulting to hostname 'linux'. Jul 9 10:26:59.007277 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 9 10:26:59.009247 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 9 10:26:59.046246 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 9 10:26:59.049536 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jul 9 10:26:59.050152 systemd[1]: Reached target time-set.target - System Time Set. Jul 9 10:26:59.075549 systemd-networkd[1328]: lo: Link UP Jul 9 10:26:59.075881 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1340) Jul 9 10:26:59.075935 systemd-networkd[1328]: lo: Gained carrier Jul 9 10:26:59.076957 systemd-networkd[1328]: Enumeration completed Jul 9 10:26:59.077179 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 9 10:26:59.079030 systemd[1]: Reached target network.target - Network. Jul 9 10:26:59.088141 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 9 10:26:59.090926 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 9 10:26:59.107667 systemd-networkd[1328]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 9 10:26:59.107683 systemd-networkd[1328]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 9 10:26:59.112362 systemd-networkd[1328]: eth0: Link UP Jul 9 10:26:59.112370 systemd-networkd[1328]: eth0: Gained carrier Jul 9 10:26:59.112401 systemd-networkd[1328]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 9 10:26:59.120707 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 9 10:26:59.126232 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 9 10:26:59.128997 systemd-networkd[1328]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 9 10:26:59.129603 systemd-timesyncd[1315]: Network configuration changed, trying to establish connection. Jul 9 10:26:59.130183 systemd-timesyncd[1315]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 9 10:26:59.130233 systemd-timesyncd[1315]: Initial clock synchronization to Wed 2025-07-09 10:26:59.154531 UTC. Jul 9 10:26:59.136056 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 9 10:26:59.154996 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 9 10:26:59.180186 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 9 10:26:59.192930 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jul 9 10:26:59.205961 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jul 9 10:26:59.215496 lvm[1365]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 9 10:26:59.224589 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 9 10:26:59.254528 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jul 9 10:26:59.256145 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 9 10:26:59.257358 systemd[1]: Reached target sysinit.target - System Initialization. Jul 9 10:26:59.258598 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 9 10:26:59.259869 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 9 10:26:59.261366 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 9 10:26:59.262563 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 9 10:26:59.263831 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 9 10:26:59.265301 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 9 10:26:59.265346 systemd[1]: Reached target paths.target - Path Units. Jul 9 10:26:59.266265 systemd[1]: Reached target timers.target - Timer Units. Jul 9 10:26:59.268661 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 9 10:26:59.271320 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 9 10:26:59.274711 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 9 10:26:59.276297 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 9 10:26:59.277582 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 9 10:26:59.281036 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 9 10:26:59.282636 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 9 10:26:59.285177 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jul 9 10:26:59.287010 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 9 10:26:59.288259 systemd[1]: Reached target sockets.target - Socket Units. Jul 9 10:26:59.289301 systemd[1]: Reached target basic.target - Basic System. Jul 9 10:26:59.290418 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 9 10:26:59.290453 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 9 10:26:59.291562 systemd[1]: Starting containerd.service - containerd container runtime... Jul 9 10:26:59.293376 lvm[1372]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 9 10:26:59.293917 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 9 10:26:59.297987 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 9 10:26:59.303132 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 9 10:26:59.304101 jq[1375]: false Jul 9 10:26:59.304238 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jul 9 10:26:59.308023 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 9 10:26:59.313012 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 9 10:26:59.319053 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 9 10:26:59.325596 dbus-daemon[1374]: [system] SELinux support is enabled Jul 9 10:26:59.326925 extend-filesystems[1376]: Found loop2 Jul 9 10:26:59.327927 extend-filesystems[1376]: Found loop3 Jul 9 10:26:59.327927 extend-filesystems[1376]: Found vda Jul 9 10:26:59.327927 extend-filesystems[1376]: Found vda1 Jul 9 10:26:59.327927 extend-filesystems[1376]: Found vda2 Jul 9 10:26:59.327927 extend-filesystems[1376]: Found vda3 Jul 9 10:26:59.333721 extend-filesystems[1376]: Found usr Jul 9 10:26:59.333721 extend-filesystems[1376]: Found vda4 Jul 9 10:26:59.333721 extend-filesystems[1376]: Found vda6 Jul 9 10:26:59.333721 extend-filesystems[1376]: Found vda7 Jul 9 10:26:59.333721 extend-filesystems[1376]: Found vda9 Jul 9 10:26:59.333721 extend-filesystems[1376]: Checking size of /dev/vda9 Jul 9 10:26:59.332399 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 9 10:26:59.339354 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 9 10:26:59.339961 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 9 10:26:59.343039 systemd[1]: Starting update-engine.service - Update Engine... Jul 9 10:26:59.348638 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 9 10:26:59.351194 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 9 10:26:59.353253 jq[1393]: true Jul 9 10:26:59.356671 extend-filesystems[1376]: Old size kept for /dev/vda9 Jul 9 10:26:59.355436 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jul 9 10:26:59.366928 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1332) Jul 9 10:26:59.372577 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 9 10:26:59.375282 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 9 10:26:59.375726 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 9 10:26:59.376048 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 9 10:26:59.378269 systemd[1]: motdgen.service: Deactivated successfully. Jul 9 10:26:59.378625 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 9 10:26:59.380249 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 9 10:26:59.380594 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 9 10:26:59.407874 jq[1398]: true Jul 9 10:26:59.405711 (ntainerd)[1399]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 9 10:26:59.416966 systemd-logind[1384]: Watching system buttons on /dev/input/event0 (Power Button) Jul 9 10:26:59.419486 update_engine[1392]: I20250709 10:26:59.417445 1392 main.cc:92] Flatcar Update Engine starting Jul 9 10:26:59.417405 systemd-logind[1384]: New seat seat0. Jul 9 10:26:59.421906 systemd[1]: Started systemd-logind.service - User Login Management. Jul 9 10:26:59.427021 update_engine[1392]: I20250709 10:26:59.425395 1392 update_check_scheduler.cc:74] Next update check in 3m5s Jul 9 10:26:59.428328 systemd[1]: Started update-engine.service - Update Engine. Jul 9 10:26:59.430520 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jul 9 10:26:59.430934 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 9 10:26:59.432535 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jul 9 10:26:59.432774 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 9 10:26:59.439280 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 9 10:26:59.506199 bash[1424]: Updated "/home/core/.ssh/authorized_keys" Jul 9 10:26:59.507670 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 9 10:26:59.510054 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 9 10:26:59.515668 locksmithd[1410]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="etcd-lock" Jul 9 10:26:59.642448 containerd[1399]: time="2025-07-09T10:26:59.642360640Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jul 9 10:26:59.666594 containerd[1399]: time="2025-07-09T10:26:59.666534840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668001 containerd[1399]: time="2025-07-09T10:26:59.667959840Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.96-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668001 containerd[1399]: time="2025-07-09T10:26:59.667996640Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 9 10:26:59.668074 containerd[1399]: time="2025-07-09T10:26:59.668014880Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 9 10:26:59.668233 containerd[1399]: time="2025-07-09T10:26:59.668208160Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jul 9 10:26:59.668257 containerd[1399]: time="2025-07-09T10:26:59.668231800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668327 containerd[1399]: time="2025-07-09T10:26:59.668287520Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668327 containerd[1399]: time="2025-07-09T10:26:59.668299160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668527 containerd[1399]: time="2025-07-09T10:26:59.668497640Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668527 containerd[1399]: time="2025-07-09T10:26:59.668518280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668576 containerd[1399]: time="2025-07-09T10:26:59.668533080Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668576 containerd[1399]: time="2025-07-09T10:26:59.668542720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668625 containerd[1399]: time="2025-07-09T10:26:59.668611840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668861 containerd[1399]: time="2025-07-09T10:26:59.668842320Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 9 10:26:59.668987 containerd[1399]: time="2025-07-09T10:26:59.668970440Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 9 10:26:59.669016 containerd[1399]: time="2025-07-09T10:26:59.668989680Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 9 10:26:59.669086 containerd[1399]: time="2025-07-09T10:26:59.669071880Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 9 10:26:59.669130 containerd[1399]: time="2025-07-09T10:26:59.669119560Z" level=info msg="metadata content store policy set" policy=shared Jul 9 10:26:59.672549 containerd[1399]: time="2025-07-09T10:26:59.672516560Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 9 10:26:59.672622 containerd[1399]: time="2025-07-09T10:26:59.672571960Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 9 10:26:59.672622 containerd[1399]: time="2025-07-09T10:26:59.672589840Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jul 9 10:26:59.672622 containerd[1399]: time="2025-07-09T10:26:59.672606200Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jul 9 10:26:59.672622 containerd[1399]: time="2025-07-09T10:26:59.672622200Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 9 10:26:59.672821 containerd[1399]: time="2025-07-09T10:26:59.672779080Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 9 10:26:59.673086 containerd[1399]: time="2025-07-09T10:26:59.673068920Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 9 10:26:59.673196 containerd[1399]: time="2025-07-09T10:26:59.673180280Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jul 9 10:26:59.673218 containerd[1399]: time="2025-07-09T10:26:59.673203400Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jul 9 10:26:59.673236 containerd[1399]: time="2025-07-09T10:26:59.673219000Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jul 9 10:26:59.673236 containerd[1399]: time="2025-07-09T10:26:59.673232360Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673287 containerd[1399]: time="2025-07-09T10:26:59.673246320Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673287 containerd[1399]: time="2025-07-09T10:26:59.673261240Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673287 containerd[1399]: time="2025-07-09T10:26:59.673275600Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673341 containerd[1399]: time="2025-07-09T10:26:59.673290480Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673341 containerd[1399]: time="2025-07-09T10:26:59.673302960Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673341 containerd[1399]: time="2025-07-09T10:26:59.673316000Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673341 containerd[1399]: time="2025-07-09T10:26:59.673327640Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 9 10:26:59.673406 containerd[1399]: time="2025-07-09T10:26:59.673347320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673406 containerd[1399]: time="2025-07-09T10:26:59.673362480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673406 containerd[1399]: time="2025-07-09T10:26:59.673374760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673406 containerd[1399]: time="2025-07-09T10:26:59.673386440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673406 containerd[1399]: time="2025-07-09T10:26:59.673397960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673411440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673422840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673434520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673448400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673462080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673473640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673493 containerd[1399]: time="2025-07-09T10:26:59.673485440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673612 containerd[1399]: time="2025-07-09T10:26:59.673508160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673612 containerd[1399]: time="2025-07-09T10:26:59.673523480Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jul 9 10:26:59.673612 containerd[1399]: time="2025-07-09T10:26:59.673544920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673612 containerd[1399]: time="2025-07-09T10:26:59.673564040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673612 containerd[1399]: time="2025-07-09T10:26:59.673575440Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 9 10:26:59.673761 containerd[1399]: time="2025-07-09T10:26:59.673748800Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673770120Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673781240Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673812360Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673822360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673834440Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673844080Z" level=info msg="NRI interface is disabled by configuration." Jul 9 10:26:59.673801 containerd[1399]: time="2025-07-09T10:26:59.673854560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 9 10:26:59.674253 containerd[1399]: time="2025-07-09T10:26:59.674204440Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jul 9 10:26:59.674374 containerd[1399]: time="2025-07-09T10:26:59.674280560Z" level=info msg="Connect containerd service" Jul 9 10:26:59.674374 containerd[1399]: time="2025-07-09T10:26:59.674311200Z" level=info msg="using legacy CRI server" Jul 9 10:26:59.674374 containerd[1399]: time="2025-07-09T10:26:59.674318560Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 9 10:26:59.674565 containerd[1399]: time="2025-07-09T10:26:59.674548240Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 9 10:26:59.676989 containerd[1399]: time="2025-07-09T10:26:59.676963360Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jul 9 10:26:59.677466 containerd[1399]: time="2025-07-09T10:26:59.677197400Z" level=info msg="Start subscribing containerd event" Jul 9 10:26:59.677466 containerd[1399]: time="2025-07-09T10:26:59.677259320Z" level=info msg="Start recovering state" Jul 9 10:26:59.677466 containerd[1399]: time="2025-07-09T10:26:59.677327200Z" level=info msg="Start event monitor" Jul 9 10:26:59.677466 containerd[1399]: time="2025-07-09T10:26:59.677346320Z" level=info msg="Start snapshots syncer" Jul 9 10:26:59.677466 containerd[1399]: time="2025-07-09T10:26:59.677356440Z" level=info msg="Start cni network conf syncer for default" Jul 9 10:26:59.677466 containerd[1399]: time="2025-07-09T10:26:59.677364280Z" level=info msg="Start streaming server" Jul 9 10:26:59.677636 containerd[1399]: time="2025-07-09T10:26:59.677610160Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 9 10:26:59.677782 containerd[1399]: time="2025-07-09T10:26:59.677766200Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 9 10:26:59.678164 containerd[1399]: time="2025-07-09T10:26:59.678136440Z" level=info msg="containerd successfully booted in 0.037232s" Jul 9 10:26:59.678171 systemd[1]: Started containerd.service - containerd container runtime. Jul 9 10:27:00.929993 sshd_keygen[1391]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 9 10:27:00.949600 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 9 10:27:00.965128 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 9 10:27:00.971129 systemd[1]: issuegen.service: Deactivated successfully. Jul 9 10:27:00.972847 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 9 10:27:00.976301 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 9 10:27:00.988572 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 9 10:27:00.992987 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 9 10:27:00.995310 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jul 9 10:27:00.996695 systemd[1]: Reached target getty.target - Login Prompts. Jul 9 10:27:01.128937 systemd-networkd[1328]: eth0: Gained IPv6LL Jul 9 10:27:01.131585 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 9 10:27:01.133387 systemd[1]: Reached target network-online.target - Network is Online. Jul 9 10:27:01.143114 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 9 10:27:01.145470 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 9 10:27:01.161404 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 9 10:27:01.161666 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 9 10:27:01.164907 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jul 9 10:27:01.166244 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 9 10:27:01.169010 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 9 10:27:01.171185 (-wrapper)[1469]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jul 9 10:27:01.302069 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 9 10:27:01.302213 (dockerd)[1484]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Jul 9 10:27:01.557459 dockerd[1484]: time="2025-07-09T10:27:01.557333639Z" level=info msg="Starting up" Jul 9 10:27:01.650974 dockerd[1484]: time="2025-07-09T10:27:01.650879367Z" level=info msg="Loading containers: start." Jul 9 10:27:01.802827 kernel: Initializing XFRM netlink socket Jul 9 10:27:01.872303 systemd-networkd[1328]: docker0: Link UP Jul 9 10:27:01.908114 dockerd[1484]: time="2025-07-09T10:27:01.908072899Z" level=info msg="Loading containers: done." Jul 9 10:27:01.926626 dockerd[1484]: time="2025-07-09T10:27:01.926568094Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Jul 9 10:27:01.926783 dockerd[1484]: time="2025-07-09T10:27:01.926680697Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Jul 9 10:27:01.926913 dockerd[1484]: time="2025-07-09T10:27:01.926885049Z" level=info msg="Daemon has completed initialization" Jul 9 10:27:01.957814 dockerd[1484]: time="2025-07-09T10:27:01.957732017Z" level=info msg="API listen on /run/docker.sock" Jul 9 10:27:01.957919 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 9 10:27:01.959117 etcd-wrapper[1475]: Error response from daemon: No such container: etcd-member Jul 9 10:27:01.971229 etcd-wrapper[1664]: Error response from daemon: No such container: etcd-member Jul 9 10:27:01.999604 etcd-wrapper[1684]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally Jul 9 10:27:02.769772 etcd-wrapper[1684]: v3.5.0: Pulling from coreos/etcd Jul 9 10:27:02.927997 etcd-wrapper[1684]: 6022c6b01d76: Pulling fs layer Jul 9 10:27:02.927997 etcd-wrapper[1684]: 1d97b1ec77fc: Pulling fs layer Jul 9 10:27:02.927997 etcd-wrapper[1684]: 99ef4b690837: Pulling fs layer Jul 9 10:27:02.927997 etcd-wrapper[1684]: 435b7bf0967c: Pulling fs layer Jul 9 10:27:02.927997 etcd-wrapper[1684]: 17e4a5f7c1b5: Pulling fs layer Jul 9 10:27:02.927997 etcd-wrapper[1684]: 5b0292999756: Pulling fs layer Jul 9 10:27:02.927997 etcd-wrapper[1684]: 435b7bf0967c: Waiting Jul 9 10:27:02.927997 etcd-wrapper[1684]: 17e4a5f7c1b5: Waiting Jul 9 10:27:02.927997 etcd-wrapper[1684]: 5b0292999756: Waiting Jul 9 10:27:03.090871 etcd-wrapper[1684]: 99ef4b690837: Verifying Checksum Jul 9 10:27:03.090871 etcd-wrapper[1684]: 99ef4b690837: Download complete Jul 9 10:27:03.098562 etcd-wrapper[1684]: 1d97b1ec77fc: Verifying Checksum Jul 9 10:27:03.098562 etcd-wrapper[1684]: 1d97b1ec77fc: Download complete Jul 9 10:27:03.161136 etcd-wrapper[1684]: 6022c6b01d76: Verifying Checksum Jul 9 10:27:03.161136 etcd-wrapper[1684]: 6022c6b01d76: Download complete Jul 9 10:27:03.237296 etcd-wrapper[1684]: 435b7bf0967c: Verifying Checksum Jul 9 10:27:03.237296 etcd-wrapper[1684]: 435b7bf0967c: Download complete Jul 9 10:27:03.248349 etcd-wrapper[1684]: 17e4a5f7c1b5: Verifying Checksum Jul 9 10:27:03.248349 etcd-wrapper[1684]: 17e4a5f7c1b5: Download complete Jul 9 10:27:03.290004 etcd-wrapper[1684]: 5b0292999756: Verifying Checksum Jul 9 10:27:03.290004 etcd-wrapper[1684]: 5b0292999756: Download complete Jul 9 10:27:03.715992 etcd-wrapper[1684]: 6022c6b01d76: Pull complete Jul 9 10:27:03.808243 systemd[1]: var-lib-docker-overlay2-6351e06ff9f4abee6fba6dc39c95ed00019784a76d5982e336169dbc1a7f1db9-merged.mount: Deactivated successfully. Jul 9 10:27:03.956423 etcd-wrapper[1684]: 1d97b1ec77fc: Pull complete Jul 9 10:27:04.032063 systemd[1]: var-lib-docker-overlay2-cb7d5948f1a0a9ae3b4d26689fcd0fa1e6ee1db4f394d02bfa2e04554d657ce1-merged.mount: Deactivated successfully. Jul 9 10:27:04.057012 etcd-wrapper[1684]: 99ef4b690837: Pull complete Jul 9 10:27:04.163315 etcd-wrapper[1684]: 435b7bf0967c: Pull complete Jul 9 10:27:04.179891 etcd-wrapper[1684]: 17e4a5f7c1b5: Pull complete Jul 9 10:27:04.191932 etcd-wrapper[1684]: 5b0292999756: Pull complete Jul 9 10:27:04.198361 etcd-wrapper[1684]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b Jul 9 10:27:04.200388 etcd-wrapper[1684]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 Jul 9 10:27:04.320563 containerd[1399]: time="2025-07-09T10:27:04.320390483Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 9 10:27:04.320563 containerd[1399]: time="2025-07-09T10:27:04.320465693Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 9 10:27:04.321371 containerd[1399]: time="2025-07-09T10:27:04.320884375Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 9 10:27:04.321560 containerd[1399]: time="2025-07-09T10:27:04.321528128Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 9 10:27:04.344976 systemd[1]: Started docker-35edada917362b262231a452c1a3a434d69a14b8a20026d5f14857d957fc6bc9.scope - libcontainer container 35edada917362b262231a452c1a3a434d69a14b8a20026d5f14857d957fc6bc9. Jul 9 10:27:04.357556 systemd-resolved[1262]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"info","ts":1752056824.41086,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"info","ts":1752056824.41093,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"d04298f685f743f5949fdf8f6a9cd9db"} Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"warn","ts":1752056824.410954,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"warn","ts":1752056824.4109633,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"warn","ts":1752056824.41097,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"warn","ts":1752056824.4109743,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jul 9 10:27:04.411129 etcd-wrapper[1684]: {"level":"warn","ts":1752056824.4109795,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Jul 9 10:27:04.411738 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.411Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.5:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.5:2380","--advertise-client-urls=http://10.0.0.5:2379","--discovery=http://10.0.0.1:36561/v2/keys/discovery/5814403176195088283","--enable-v2=true"]} Jul 9 10:27:04.411738 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.411Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.5:2380"]} Jul 9 10:27:04.411738 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.411Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jul 9 10:27:04.411868 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.411Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"d04298f685f743f5949fdf8f6a9cd9db","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,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://10.0.0.5:2380"],"listen-peer-urls":["http://10.0.0.5:2380"],"advertise-client-urls":["http://10.0.0.5:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"d04298f685f743f5949fdf8f6a9cd9db=http://10.0.0.5:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:36561/v2/keys/discovery/5814403176195088283","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"http://10.0.0.1:36561/v2/keys/discovery/5814403176195088283","discovery-proxy":"","downgrade-check-interval":"5s"} Jul 9 10:27:04.413513 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.413Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.396339ms"} Jul 9 10:27:04.416570 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.416Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:36561","peer":"d9298fb4c7f215d8"} Jul 9 10:27:04.416570 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.416Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:36561","peer":"2896833331160c84"} Jul 9 10:27:04.416570 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.416Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:36561","self":"9b96a6d16bd6cee9"} Jul 9 10:27:04.416570 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.416Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:36561","found-peers":3} Jul 9 10:27:04.419629 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"9b96a6d16bd6cee9","cluster-id":"b8d6f3e6fc282dcf"} Jul 9 10:27:04.419752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=()"} Jul 9 10:27:04.419752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 became follower at term 0"} Jul 9 10:27:04.419752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9b96a6d16bd6cee9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jul 9 10:27:04.419752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 became follower at term 1"} Jul 9 10:27:04.420004 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=(2924669263913815172)"} Jul 9 10:27:04.420004 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=(2924669263913815172 11211331740773043945)"} Jul 9 10:27:04.420004 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=(2924669263913815172 11211331740773043945 15648196386886915544)"} Jul 9 10:27:04.421296 etcd-wrapper[1684]: {"level":"warn","ts":"2025-07-09T10:27:04.421Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Jul 9 10:27:04.422329 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.422Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Jul 9 10:27:04.422944 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.422Z","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"} Jul 9 10:27:04.423469 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.423Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.423469 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.423Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.424495 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.424Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.424804 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.424Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.425665 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.425665 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84","remote-peer-urls":["http://10.0.0.3:2380"]} Jul 9 10:27:04.425665 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.425665 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.425665 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.425665 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.426423 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.425Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.426590 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.426Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.427752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"2896833331160c84"} Jul 9 10:27:04.427752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.427752 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.428152 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.428152 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.428152 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8","remote-peer-urls":["http://10.0.0.4:2380"]} Jul 9 10:27:04.428152 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.427Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"9b96a6d16bd6cee9","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Jul 9 10:27:04.428152 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.428Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.428836 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.428Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Jul 9 10:27:04.428836 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=(2924669263913815172 11211331740773043945 15648196386886915544)"} Jul 9 10:27:04.429056 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.428Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.429056 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.428Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.429341 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.428Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"b8d6f3e6fc282dcf","local-member-id":"9b96a6d16bd6cee9","added-peer-id":"2896833331160c84","added-peer-peer-urls":["http://10.0.0.3:2380"]} Jul 9 10:27:04.429341 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.429Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.429341 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=(2924669263913815172 11211331740773043945 15648196386886915544)"} Jul 9 10:27:04.429341 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.429Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"b8d6f3e6fc282dcf","local-member-id":"9b96a6d16bd6cee9","added-peer-id":"9b96a6d16bd6cee9","added-peer-peer-urls":["http://10.0.0.5:2380"]} Jul 9 10:27:04.429341 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 switched to configuration voters=(2924669263913815172 11211331740773043945 15648196386886915544)"} Jul 9 10:27:04.429341 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.429Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"b8d6f3e6fc282dcf","local-member-id":"9b96a6d16bd6cee9","added-peer-id":"d9298fb4c7f215d8","added-peer-peer-urls":["http://10.0.0.4:2380"]} Jul 9 10:27:04.430164 etcd-wrapper[1684]: {"level":"warn","ts":"2025-07-09T10:27:04.430Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Jul 9 10:27:04.430378 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.5:2380"} Jul 9 10:27:04.430378 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.5:2380"} Jul 9 10:27:04.430378 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"9b96a6d16bd6cee9","initial-advertise-peer-urls":["http://10.0.0.5:2380"],"listen-peer-urls":["http://10.0.0.5:2380"],"advertise-client-urls":["http://10.0.0.5:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jul 9 10:27:04.430862 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"9b96a6d16bd6cee9","to":"d9298fb4c7f215d8","stream-type":"stream MsgApp v2"} Jul 9 10:27:04.430862 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"9b96a6d16bd6cee9","to":"d9298fb4c7f215d8","stream-type":"stream Message"} Jul 9 10:27:04.430862 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.431113 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"d9298fb4c7f215d8"} Jul 9 10:27:04.431113 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"9b96a6d16bd6cee9","to":"2896833331160c84","stream-type":"stream Message"} Jul 9 10:27:04.431113 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.431113 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"9b96a6d16bd6cee9","to":"2896833331160c84","stream-type":"stream MsgApp v2"} Jul 9 10:27:04.431113 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.430Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"9b96a6d16bd6cee9","remote-peer-id":"2896833331160c84"} Jul 9 10:27:04.478631 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.478Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"9b96a6d16bd6cee9","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Jul 9 10:27:04.620297 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 is starting a new election at term 1"} Jul 9 10:27:04.620297 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 became pre-candidate at term 1"} Jul 9 10:27:04.620297 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 received MsgPreVoteResp from 9b96a6d16bd6cee9 at term 1"} Jul 9 10:27:04.620297 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 [logterm: 1, index: 3] sent MsgPreVote request to 2896833331160c84 at term 1"} Jul 9 10:27:04.620297 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 [logterm: 1, index: 3] sent MsgPreVote request to d9298fb4c7f215d8 at term 1"} Jul 9 10:27:04.620896 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 received MsgPreVoteResp from 2896833331160c84 at term 1"} Jul 9 10:27:04.620896 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 has received 2 MsgPreVoteResp votes and 0 vote rejections"} Jul 9 10:27:04.620896 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 became candidate at term 2"} Jul 9 10:27:04.620896 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 received MsgVoteResp from 9b96a6d16bd6cee9 at term 2"} Jul 9 10:27:04.620896 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 [logterm: 1, index: 3] sent MsgVote request to 2896833331160c84 at term 2"} Jul 9 10:27:04.620896 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.620Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 [logterm: 1, index: 3] sent MsgVote request to d9298fb4c7f215d8 at term 2"} Jul 9 10:27:04.622161 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 received MsgVoteResp from 2896833331160c84 at term 2"} Jul 9 10:27:04.622161 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 has received 2 MsgVoteResp votes and 0 vote rejections"} Jul 9 10:27:04.622161 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9b96a6d16bd6cee9 became leader at term 2"} Jul 9 10:27:04.622161 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9b96a6d16bd6cee9 elected leader 9b96a6d16bd6cee9 at term 2"} Jul 9 10:27:04.625252 systemd[1]: Started etcd-member.service - etcd (System Application Container). Jul 9 10:27:04.627097 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.624Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"9b96a6d16bd6cee9","local-member-attributes":"{Name:d04298f685f743f5949fdf8f6a9cd9db ClientURLs:[http://10.0.0.5:2379]}","request-path":"/0/members/9b96a6d16bd6cee9/attributes","cluster-id":"b8d6f3e6fc282dcf","publish-timeout":"7s"} Jul 9 10:27:04.627097 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.624Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Jul 9 10:27:04.627097 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.624Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Jul 9 10:27:04.627097 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.624Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Jul 9 10:27:04.627097 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.625Z","caller":"etcdserver/server.go:2476","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Jul 9 10:27:04.627940 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.625Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Jul 9 10:27:04.627940 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.626Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"b8d6f3e6fc282dcf","local-member-id":"9b96a6d16bd6cee9","cluster-version":"3.5"} Jul 9 10:27:04.627940 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.626Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jul 9 10:27:04.627940 etcd-wrapper[1684]: {"level":"info","ts":"2025-07-09T10:27:04.626Z","caller":"etcdserver/server.go:2500","msg":"cluster version is updated","cluster-version":"3.5"} Jul 9 10:27:04.628293 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 9 10:27:04.630988 systemd[1]: Startup finished in 597ms (kernel) + 3.858s (initrd) + 7.077s (userspace) = 11.533s. Jul 9 10:27:04.726060 systemd[1]: var-lib-docker-overlay2-2d2d633dcf9efda90497f46d59455d6e81410e411047bc4f0e606774ac068a4d-merged.mount: Deactivated successfully. Jul 9 10:27:06.503329 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 9 10:27:06.504486 systemd[1]: Started sshd@0-10.0.0.5:22-10.0.0.1:34114.service - OpenSSH per-connection server daemon (10.0.0.1:34114). Jul 9 10:27:06.574342 sshd[1782]: Accepted publickey for core from 10.0.0.1 port 34114 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:06.576099 sshd-session[1782]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:06.595306 systemd-logind[1384]: New session 1 of user core. Jul 9 10:27:06.596292 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 9 10:27:06.606038 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 9 10:27:06.615902 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 9 10:27:06.619831 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 9 10:27:06.625290 (systemd)[1786]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 9 10:27:06.627401 systemd-logind[1384]: New session c1 of user core. Jul 9 10:27:06.742020 systemd[1786]: Queued start job for default target default.target. Jul 9 10:27:06.756683 systemd[1786]: Created slice app.slice - User Application Slice. Jul 9 10:27:06.756711 systemd[1786]: Reached target paths.target - Paths. Jul 9 10:27:06.756745 systemd[1786]: Reached target timers.target - Timers. Jul 9 10:27:06.758027 systemd[1786]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 9 10:27:06.767603 systemd[1786]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 9 10:27:06.767670 systemd[1786]: Reached target sockets.target - Sockets. Jul 9 10:27:06.767710 systemd[1786]: Reached target basic.target - Basic System. Jul 9 10:27:06.767739 systemd[1786]: Reached target default.target - Main User Target. Jul 9 10:27:06.767774 systemd[1786]: Startup finished in 134ms. Jul 9 10:27:06.767952 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 9 10:27:06.776963 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 9 10:27:06.843714 systemd[1]: Started sshd@1-10.0.0.5:22-10.0.0.1:34120.service - OpenSSH per-connection server daemon (10.0.0.1:34120). Jul 9 10:27:06.883292 sshd[1797]: Accepted publickey for core from 10.0.0.1 port 34120 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:06.884476 sshd-session[1797]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:06.888539 systemd-logind[1384]: New session 2 of user core. Jul 9 10:27:06.895954 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 9 10:27:06.946559 sshd[1799]: Connection closed by 10.0.0.1 port 34120 Jul 9 10:27:06.947061 sshd-session[1797]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:06.959110 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:34120.service: Deactivated successfully. Jul 9 10:27:06.960626 systemd[1]: session-2.scope: Deactivated successfully. Jul 9 10:27:06.962041 systemd-logind[1384]: Session 2 logged out. Waiting for processes to exit. Jul 9 10:27:06.969057 systemd[1]: Started sshd@2-10.0.0.5:22-10.0.0.1:34126.service - OpenSSH per-connection server daemon (10.0.0.1:34126). Jul 9 10:27:06.970052 systemd-logind[1384]: Removed session 2. Jul 9 10:27:07.004358 sshd[1804]: Accepted publickey for core from 10.0.0.1 port 34126 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.005412 sshd-session[1804]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.009592 systemd-logind[1384]: New session 3 of user core. Jul 9 10:27:07.021962 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 9 10:27:07.069246 sshd[1807]: Connection closed by 10.0.0.1 port 34126 Jul 9 10:27:07.069487 sshd-session[1804]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.088006 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:34126.service: Deactivated successfully. Jul 9 10:27:07.089425 systemd[1]: session-3.scope: Deactivated successfully. Jul 9 10:27:07.091303 systemd-logind[1384]: Session 3 logged out. Waiting for processes to exit. Jul 9 10:27:07.092976 systemd[1]: Started sshd@3-10.0.0.5:22-10.0.0.1:34136.service - OpenSSH per-connection server daemon (10.0.0.1:34136). Jul 9 10:27:07.093688 systemd-logind[1384]: Removed session 3. Jul 9 10:27:07.131739 sshd[1812]: Accepted publickey for core from 10.0.0.1 port 34136 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.132973 sshd-session[1812]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.137379 systemd-logind[1384]: New session 4 of user core. Jul 9 10:27:07.145014 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 9 10:27:07.195551 sshd[1815]: Connection closed by 10.0.0.1 port 34136 Jul 9 10:27:07.196005 sshd-session[1812]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.206919 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:34136.service: Deactivated successfully. Jul 9 10:27:07.208294 systemd[1]: session-4.scope: Deactivated successfully. Jul 9 10:27:07.211575 systemd-logind[1384]: Session 4 logged out. Waiting for processes to exit. Jul 9 10:27:07.212729 systemd[1]: Started sshd@4-10.0.0.5:22-10.0.0.1:34152.service - OpenSSH per-connection server daemon (10.0.0.1:34152). Jul 9 10:27:07.213510 systemd-logind[1384]: Removed session 4. Jul 9 10:27:07.251008 sshd[1820]: Accepted publickey for core from 10.0.0.1 port 34152 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.252198 sshd-session[1820]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.256478 systemd-logind[1384]: New session 5 of user core. Jul 9 10:27:07.266022 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 9 10:27:07.326928 sudo[1824]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 9 10:27:07.329036 sudo[1824]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 9 10:27:07.340617 sudo[1824]: pam_unix(sudo:session): session closed for user root Jul 9 10:27:07.342278 sshd[1823]: Connection closed by 10.0.0.1 port 34152 Jul 9 10:27:07.342670 sshd-session[1820]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.355494 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:34152.service: Deactivated successfully. Jul 9 10:27:07.357218 systemd[1]: session-5.scope: Deactivated successfully. Jul 9 10:27:07.359420 systemd-logind[1384]: Session 5 logged out. Waiting for processes to exit. Jul 9 10:27:07.380093 systemd[1]: Started sshd@5-10.0.0.5:22-10.0.0.1:34162.service - OpenSSH per-connection server daemon (10.0.0.1:34162). Jul 9 10:27:07.381066 systemd-logind[1384]: Removed session 5. Jul 9 10:27:07.415565 sshd[1829]: Accepted publickey for core from 10.0.0.1 port 34162 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.416716 sshd-session[1829]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.420893 systemd-logind[1384]: New session 6 of user core. Jul 9 10:27:07.426942 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 9 10:27:07.476613 sudo[1834]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jul 9 10:27:07.476899 sudo[1834]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 9 10:27:07.479734 sudo[1834]: pam_unix(sudo:session): session closed for user root Jul 9 10:27:07.484319 sudo[1833]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 9 10:27:07.484599 sudo[1833]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 9 10:27:07.502158 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 9 10:27:07.524165 augenrules[1856]: No rules Jul 9 10:27:07.525312 systemd[1]: audit-rules.service: Deactivated successfully. Jul 9 10:27:07.526832 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 9 10:27:07.527708 sudo[1833]: pam_unix(sudo:session): session closed for user root Jul 9 10:27:07.529431 sshd[1832]: Connection closed by 10.0.0.1 port 34162 Jul 9 10:27:07.529299 sshd-session[1829]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.533075 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:34162.service: Deactivated successfully. Jul 9 10:27:07.534612 systemd[1]: session-6.scope: Deactivated successfully. Jul 9 10:27:07.535246 systemd-logind[1384]: Session 6 logged out. Waiting for processes to exit. Jul 9 10:27:07.536199 systemd-logind[1384]: Removed session 6. Jul 9 10:27:07.555948 systemd[1]: Started sshd@6-10.0.0.5:22-10.0.0.1:34172.service - OpenSSH per-connection server daemon (10.0.0.1:34172). Jul 9 10:27:07.594412 sshd[1865]: Accepted publickey for core from 10.0.0.1 port 34172 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.595550 sshd-session[1865]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.599055 systemd-logind[1384]: New session 7 of user core. Jul 9 10:27:07.614915 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 9 10:27:07.718571 sshd[1867]: Connection closed by 10.0.0.1 port 34172 Jul 9 10:27:07.718996 sshd-session[1865]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.728947 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:34172.service: Deactivated successfully. Jul 9 10:27:07.730254 systemd[1]: session-7.scope: Deactivated successfully. Jul 9 10:27:07.732296 systemd-logind[1384]: Session 7 logged out. Waiting for processes to exit. Jul 9 10:27:07.741085 systemd[1]: Started sshd@7-10.0.0.5:22-10.0.0.1:34182.service - OpenSSH per-connection server daemon (10.0.0.1:34182). Jul 9 10:27:07.742152 systemd-logind[1384]: Removed session 7. Jul 9 10:27:07.776138 sshd[1878]: Accepted publickey for core from 10.0.0.1 port 34182 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.777215 sshd-session[1878]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.781331 systemd-logind[1384]: New session 8 of user core. Jul 9 10:27:07.797963 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 9 10:27:07.848777 sshd[1881]: Connection closed by 10.0.0.1 port 34182 Jul 9 10:27:07.849247 sshd-session[1878]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.866341 systemd[1]: sshd@7-10.0.0.5:22-10.0.0.1:34182.service: Deactivated successfully. Jul 9 10:27:07.868037 systemd[1]: session-8.scope: Deactivated successfully. Jul 9 10:27:07.868697 systemd-logind[1384]: Session 8 logged out. Waiting for processes to exit. Jul 9 10:27:07.877051 systemd[1]: Started sshd@8-10.0.0.5:22-10.0.0.1:34186.service - OpenSSH per-connection server daemon (10.0.0.1:34186). Jul 9 10:27:07.878174 systemd-logind[1384]: Removed session 8. Jul 9 10:27:07.912255 sshd[1891]: Accepted publickey for core from 10.0.0.1 port 34186 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:07.913327 sshd-session[1891]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:07.917505 systemd-logind[1384]: New session 9 of user core. Jul 9 10:27:07.933995 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 9 10:27:07.985926 sshd[1894]: Connection closed by 10.0.0.1 port 34186 Jul 9 10:27:07.986364 sshd-session[1891]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:07.999043 systemd[1]: sshd@8-10.0.0.5:22-10.0.0.1:34186.service: Deactivated successfully. Jul 9 10:27:08.000533 systemd[1]: session-9.scope: Deactivated successfully. Jul 9 10:27:08.001829 systemd-logind[1384]: Session 9 logged out. Waiting for processes to exit. Jul 9 10:27:08.002935 systemd[1]: Started sshd@9-10.0.0.5:22-10.0.0.1:34194.service - OpenSSH per-connection server daemon (10.0.0.1:34194). Jul 9 10:27:08.003589 systemd-logind[1384]: Removed session 9. Jul 9 10:27:08.041660 sshd[1904]: Accepted publickey for core from 10.0.0.1 port 34194 ssh2: RSA SHA256:NeFP73XYdWOniQ8wCeuc/4Fab+U7xIo46M7Ohnoabbg Jul 9 10:27:08.042950 sshd-session[1904]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 9 10:27:08.046674 systemd-logind[1384]: New session 10 of user core. Jul 9 10:27:08.056951 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 9 10:27:08.107348 sudo[1909]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl stop sshd.socket Jul 9 10:27:08.107643 sudo[1909]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 9 10:27:08.116926 systemd[1]: sshd.socket: Deactivated successfully. Jul 9 10:27:08.117272 systemd[1]: Closed sshd.socket - OpenSSH Server Socket. Jul 9 10:27:08.122469 sudo[1909]: pam_unix(sudo:session): session closed for user root Jul 9 10:27:08.127187 sudo[1908]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/locksmithctl send-need-reboot Jul 9 10:27:08.127709 sudo[1908]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 9 10:27:08.135627 locksmithd[1410]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_UPDATED_NEED_REBOOT" NewVersion= NewSize=0 Jul 9 10:27:08.135636 locksmithd[1410]: No configured reboot window Jul 9 10:27:08.140497 locksmithd[1410]: Logins detected, delaying reboot for 5 minutes. Jul 9 10:27:09.136019 sudo[1908]: pam_unix(sudo:session): session closed for user root Jul 9 10:27:09.137356 sshd[1907]: Connection closed by 10.0.0.1 port 34194 Jul 9 10:27:09.137689 sshd-session[1904]: pam_unix(sshd:session): session closed for user core Jul 9 10:27:09.141747 systemd[1]: sshd@9-10.0.0.5:22-10.0.0.1:34194.service: Deactivated successfully. Jul 9 10:27:09.143496 systemd[1]: session-10.scope: Deactivated successfully. Jul 9 10:27:09.145356 systemd-logind[1384]: Session 10 logged out. Waiting for processes to exit. Jul 9 10:27:09.146519 systemd-logind[1384]: Removed session 10. Jul 9 10:27:45.115125 update_engine[1392]: I20250709 10:27:45.115028 1392 update_attempter.cc:509] Updating boot flags... Jul 9 10:27:45.136854 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1927) Jul 9 10:27:45.170816 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1926) Jul 9 10:27:45.191828 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1926) Jul 9 10:30:05.161829 update_engine[1392]: I20250709 10:30:05.160912 1392 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Jul 9 10:30:05.161829 update_engine[1392]: I20250709 10:30:05.160981 1392 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Jul 9 10:30:05.161829 update_engine[1392]: I20250709 10:30:05.161271 1392 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Jul 9 10:30:05.161829 update_engine[1392]: I20250709 10:30:05.161722 1392 omaha_request_params.cc:62] Current group set to stable Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161836 1392 update_attempter.cc:499] Already updated boot flags. Skipping. Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161849 1392 update_attempter.cc:643] Scheduling an action processor start. Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161866 1392 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161898 1392 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161963 1392 omaha_request_action.cc:271] Posting an Omaha request to disabled Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161975 1392 omaha_request_action.cc:272] Request: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: Jul 9 10:30:05.162312 update_engine[1392]: I20250709 10:30:05.161983 1392 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jul 9 10:30:05.163784 update_engine[1392]: I20250709 10:30:05.163746 1392 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jul 9 10:30:05.164175 update_engine[1392]: I20250709 10:30:05.164139 1392 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jul 9 10:30:05.219645 update_engine[1392]: E20250709 10:30:05.219568 1392 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jul 9 10:30:05.219741 update_engine[1392]: I20250709 10:30:05.219663 1392 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Jul 9 10:30:15.108702 update_engine[1392]: I20250709 10:30:15.108616 1392 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jul 9 10:30:15.109113 update_engine[1392]: I20250709 10:30:15.108914 1392 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jul 9 10:30:15.109113 update_engine[1392]: I20250709 10:30:15.109090 1392 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jul 9 10:30:15.114011 update_engine[1392]: E20250709 10:30:15.113965 1392 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jul 9 10:30:15.114067 update_engine[1392]: I20250709 10:30:15.114048 1392 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 Jul 9 10:30:25.108134 update_engine[1392]: I20250709 10:30:25.107950 1392 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jul 9 10:30:25.108933 update_engine[1392]: I20250709 10:30:25.108426 1392 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jul 9 10:30:25.108933 update_engine[1392]: I20250709 10:30:25.108743 1392 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jul 9 10:30:25.118783 update_engine[1392]: E20250709 10:30:25.118736 1392 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jul 9 10:30:25.118869 update_engine[1392]: I20250709 10:30:25.118801 1392 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 Jul 9 10:30:35.108111 update_engine[1392]: I20250709 10:30:35.107926 1392 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jul 9 10:30:35.108837 update_engine[1392]: I20250709 10:30:35.108412 1392 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jul 9 10:30:35.108837 update_engine[1392]: I20250709 10:30:35.108719 1392 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jul 9 10:30:35.117543 update_engine[1392]: E20250709 10:30:35.117475 1392 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jul 9 10:30:35.117609 update_engine[1392]: I20250709 10:30:35.117563 1392 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Jul 9 10:30:35.117609 update_engine[1392]: I20250709 10:30:35.117576 1392 omaha_request_action.cc:617] Omaha request response: Jul 9 10:30:35.117671 update_engine[1392]: E20250709 10:30:35.117657 1392 omaha_request_action.cc:636] Omaha request network transfer failed. Jul 9 10:30:35.117701 update_engine[1392]: I20250709 10:30:35.117677 1392 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Jul 9 10:30:35.117701 update_engine[1392]: I20250709 10:30:35.117686 1392 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jul 9 10:30:35.117701 update_engine[1392]: I20250709 10:30:35.117692 1392 update_attempter.cc:306] Processing Done. Jul 9 10:30:35.117800 update_engine[1392]: E20250709 10:30:35.117709 1392 update_attempter.cc:619] Update failed. Jul 9 10:30:35.117800 update_engine[1392]: I20250709 10:30:35.117717 1392 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Jul 9 10:30:35.117800 update_engine[1392]: I20250709 10:30:35.117723 1392 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Jul 9 10:30:35.117800 update_engine[1392]: I20250709 10:30:35.117731 1392 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Jul 9 10:30:35.117911 update_engine[1392]: I20250709 10:30:35.117834 1392 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jul 9 10:30:35.117911 update_engine[1392]: I20250709 10:30:35.117863 1392 omaha_request_action.cc:271] Posting an Omaha request to disabled Jul 9 10:30:35.117911 update_engine[1392]: I20250709 10:30:35.117871 1392 omaha_request_action.cc:272] Request: Jul 9 10:30:35.117911 update_engine[1392]: Jul 9 10:30:35.117911 update_engine[1392]: Jul 9 10:30:35.117911 update_engine[1392]: Jul 9 10:30:35.117911 update_engine[1392]: Jul 9 10:30:35.117911 update_engine[1392]: Jul 9 10:30:35.117911 update_engine[1392]: Jul 9 10:30:35.117911 update_engine[1392]: I20250709 10:30:35.117879 1392 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jul 9 10:30:35.118165 update_engine[1392]: I20250709 10:30:35.118033 1392 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jul 9 10:30:35.118252 update_engine[1392]: I20250709 10:30:35.118212 1392 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jul 9 10:30:35.149162 update_engine[1392]: E20250709 10:30:35.149060 1392 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149165 1392 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149180 1392 omaha_request_action.cc:617] Omaha request response: Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149190 1392 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149199 1392 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149205 1392 update_attempter.cc:306] Processing Done. Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149214 1392 update_attempter.cc:310] Error event sent. Jul 9 10:30:35.149286 update_engine[1392]: I20250709 10:30:35.149232 1392 update_check_scheduler.cc:74] Next update check in 47m42s