Sep 9 04:45:56.784215 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 9 04:45:56.784236 kernel: Linux version 6.12.45-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Tue Sep 9 03:38:34 -00 2025 Sep 9 04:45:56.784246 kernel: KASLR enabled Sep 9 04:45:56.784251 kernel: efi: EFI v2.7 by EDK II Sep 9 04:45:56.784257 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb228018 ACPI 2.0=0xdb9b8018 RNG=0xdb9b8a18 MEMRESERVE=0xdb221f18 Sep 9 04:45:56.784262 kernel: random: crng init done Sep 9 04:45:56.784269 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Sep 9 04:45:56.784274 kernel: secureboot: Secure boot enabled Sep 9 04:45:56.784280 kernel: ACPI: Early table checksum verification disabled Sep 9 04:45:56.784287 kernel: ACPI: RSDP 0x00000000DB9B8018 000024 (v02 BOCHS ) Sep 9 04:45:56.784293 kernel: ACPI: XSDT 0x00000000DB9B8F18 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 9 04:45:56.784299 kernel: ACPI: FACP 0x00000000DB9B8B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784304 kernel: ACPI: DSDT 0x00000000DB904018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784310 kernel: ACPI: APIC 0x00000000DB9B8C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784318 kernel: ACPI: PPTT 0x00000000DB9B8098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784325 kernel: ACPI: GTDT 0x00000000DB9B8818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784331 kernel: ACPI: MCFG 0x00000000DB9B8A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784337 kernel: ACPI: SPCR 0x00000000DB9B8918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784343 kernel: ACPI: DBG2 0x00000000DB9B8998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784349 kernel: ACPI: IORT 0x00000000DB9B8198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 04:45:56.784355 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 9 04:45:56.784361 kernel: ACPI: Use ACPI SPCR as default console: No Sep 9 04:45:56.784367 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 04:45:56.784373 kernel: NODE_DATA(0) allocated [mem 0xdc737a00-0xdc73efff] Sep 9 04:45:56.784379 kernel: Zone ranges: Sep 9 04:45:56.784386 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 04:45:56.784393 kernel: DMA32 empty Sep 9 04:45:56.784398 kernel: Normal empty Sep 9 04:45:56.784404 kernel: Device empty Sep 9 04:45:56.784410 kernel: Movable zone start for each node Sep 9 04:45:56.784416 kernel: Early memory node ranges Sep 9 04:45:56.784422 kernel: node 0: [mem 0x0000000040000000-0x00000000dbb4ffff] Sep 9 04:45:56.784428 kernel: node 0: [mem 0x00000000dbb50000-0x00000000dbe7ffff] Sep 9 04:45:56.784442 kernel: node 0: [mem 0x00000000dbe80000-0x00000000dbe9ffff] Sep 9 04:45:56.784448 kernel: node 0: [mem 0x00000000dbea0000-0x00000000dbedffff] Sep 9 04:45:56.784454 kernel: node 0: [mem 0x00000000dbee0000-0x00000000dbf1ffff] Sep 9 04:45:56.784460 kernel: node 0: [mem 0x00000000dbf20000-0x00000000dbf6ffff] Sep 9 04:45:56.784469 kernel: node 0: [mem 0x00000000dbf70000-0x00000000dcbfffff] Sep 9 04:45:56.784475 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Sep 9 04:45:56.784481 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 9 04:45:56.784490 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 04:45:56.784496 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 9 04:45:56.784503 kernel: cma: Reserved 16 MiB at 0x00000000d7a00000 on node -1 Sep 9 04:45:56.784509 kernel: psci: probing for conduit method from ACPI. Sep 9 04:45:56.784517 kernel: psci: PSCIv1.1 detected in firmware. Sep 9 04:45:56.784523 kernel: psci: Using standard PSCI v0.2 function IDs Sep 9 04:45:56.784529 kernel: psci: Trusted OS migration not required Sep 9 04:45:56.784539 kernel: psci: SMC Calling Convention v1.1 Sep 9 04:45:56.784548 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 9 04:45:56.784557 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 9 04:45:56.784565 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 9 04:45:56.784572 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 9 04:45:56.784578 kernel: Detected PIPT I-cache on CPU0 Sep 9 04:45:56.784587 kernel: CPU features: detected: GIC system register CPU interface Sep 9 04:45:56.784594 kernel: CPU features: detected: Spectre-v4 Sep 9 04:45:56.784600 kernel: CPU features: detected: Spectre-BHB Sep 9 04:45:56.784607 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 9 04:45:56.784614 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 9 04:45:56.784621 kernel: CPU features: detected: ARM erratum 1418040 Sep 9 04:45:56.784627 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 9 04:45:56.784634 kernel: alternatives: applying boot alternatives Sep 9 04:45:56.784641 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=1e9320fd787e27d01e3b8a1acb67e0c640346112c469b7a652e9dcfc9271bf90 Sep 9 04:45:56.784648 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 9 04:45:56.784655 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 04:45:56.784663 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 9 04:45:56.784669 kernel: Fallback order for Node 0: 0 Sep 9 04:45:56.784676 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Sep 9 04:45:56.784682 kernel: Policy zone: DMA Sep 9 04:45:56.784688 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 04:45:56.784695 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Sep 9 04:45:56.784701 kernel: software IO TLB: area num 4. Sep 9 04:45:56.784708 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Sep 9 04:45:56.784715 kernel: software IO TLB: mapped [mem 0x00000000db504000-0x00000000db904000] (4MB) Sep 9 04:45:56.784721 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 9 04:45:56.784728 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 04:45:56.784734 kernel: rcu: RCU event tracing is enabled. Sep 9 04:45:56.784743 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 9 04:45:56.784749 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 04:45:56.784756 kernel: Tracing variant of Tasks RCU enabled. Sep 9 04:45:56.784762 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 04:45:56.784769 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 9 04:45:56.784775 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 04:45:56.784782 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 04:45:56.784788 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 9 04:45:56.784795 kernel: GICv3: 256 SPIs implemented Sep 9 04:45:56.784801 kernel: GICv3: 0 Extended SPIs implemented Sep 9 04:45:56.784807 kernel: Root IRQ handler: gic_handle_irq Sep 9 04:45:56.784815 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 9 04:45:56.784821 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 9 04:45:56.784828 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 9 04:45:56.784834 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 9 04:45:56.784840 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Sep 9 04:45:56.784847 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Sep 9 04:45:56.784853 kernel: GICv3: using LPI property table @0x0000000040130000 Sep 9 04:45:56.784860 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Sep 9 04:45:56.784866 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 9 04:45:56.784873 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 04:45:56.784879 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 9 04:45:56.784886 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 9 04:45:56.784894 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 9 04:45:56.784900 kernel: arm-pv: using stolen time PV Sep 9 04:45:56.784907 kernel: Console: colour dummy device 80x25 Sep 9 04:45:56.784914 kernel: ACPI: Core revision 20240827 Sep 9 04:45:56.784920 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 9 04:45:56.784927 kernel: pid_max: default: 32768 minimum: 301 Sep 9 04:45:56.784934 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 9 04:45:56.784940 kernel: landlock: Up and running. Sep 9 04:45:56.784947 kernel: SELinux: Initializing. Sep 9 04:45:56.784955 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 04:45:56.784961 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 04:45:56.784968 kernel: rcu: Hierarchical SRCU implementation. Sep 9 04:45:56.784975 kernel: rcu: Max phase no-delay instances is 400. Sep 9 04:45:56.784982 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 9 04:45:56.784988 kernel: Remapping and enabling EFI services. Sep 9 04:45:56.784995 kernel: smp: Bringing up secondary CPUs ... Sep 9 04:45:56.785001 kernel: Detected PIPT I-cache on CPU1 Sep 9 04:45:56.785008 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 9 04:45:56.785024 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Sep 9 04:45:56.785036 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 04:45:56.785043 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 9 04:45:56.785051 kernel: Detected PIPT I-cache on CPU2 Sep 9 04:45:56.785059 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 9 04:45:56.785066 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Sep 9 04:45:56.785073 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 04:45:56.785079 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 9 04:45:56.785086 kernel: Detected PIPT I-cache on CPU3 Sep 9 04:45:56.785095 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 9 04:45:56.785102 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Sep 9 04:45:56.785109 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 04:45:56.785115 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 9 04:45:56.785122 kernel: smp: Brought up 1 node, 4 CPUs Sep 9 04:45:56.785129 kernel: SMP: Total of 4 processors activated. Sep 9 04:45:56.785136 kernel: CPU: All CPU(s) started at EL1 Sep 9 04:45:56.785143 kernel: CPU features: detected: 32-bit EL0 Support Sep 9 04:45:56.785150 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 9 04:45:56.785158 kernel: CPU features: detected: Common not Private translations Sep 9 04:45:56.785165 kernel: CPU features: detected: CRC32 instructions Sep 9 04:45:56.785172 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 9 04:45:56.785197 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 9 04:45:56.785208 kernel: CPU features: detected: LSE atomic instructions Sep 9 04:45:56.785219 kernel: CPU features: detected: Privileged Access Never Sep 9 04:45:56.785226 kernel: CPU features: detected: RAS Extension Support Sep 9 04:45:56.785233 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 9 04:45:56.785240 kernel: alternatives: applying system-wide alternatives Sep 9 04:45:56.785249 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Sep 9 04:45:56.785256 kernel: Memory: 2422372K/2572288K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38976K init, 1038K bss, 127580K reserved, 16384K cma-reserved) Sep 9 04:45:56.785263 kernel: devtmpfs: initialized Sep 9 04:45:56.785270 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 04:45:56.785277 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 9 04:45:56.785285 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 9 04:45:56.785291 kernel: 0 pages in range for non-PLT usage Sep 9 04:45:56.785298 kernel: 508560 pages in range for PLT usage Sep 9 04:45:56.785305 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 04:45:56.785313 kernel: SMBIOS 3.0.0 present. Sep 9 04:45:56.785321 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Sep 9 04:45:56.785327 kernel: DMI: Memory slots populated: 1/1 Sep 9 04:45:56.785339 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 04:45:56.785354 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 9 04:45:56.785361 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 9 04:45:56.785372 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 9 04:45:56.785379 kernel: audit: initializing netlink subsys (disabled) Sep 9 04:45:56.785385 kernel: audit: type=2000 audit(0.039:1): state=initialized audit_enabled=0 res=1 Sep 9 04:45:56.785394 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 04:45:56.785401 kernel: cpuidle: using governor menu Sep 9 04:45:56.785408 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 9 04:45:56.785418 kernel: ASID allocator initialised with 32768 entries Sep 9 04:45:56.785425 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 04:45:56.785435 kernel: Serial: AMBA PL011 UART driver Sep 9 04:45:56.785443 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 04:45:56.785450 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 9 04:45:56.785457 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 9 04:45:56.785466 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 9 04:45:56.785473 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 04:45:56.785480 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 9 04:45:56.785487 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 9 04:45:56.785494 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 9 04:45:56.785501 kernel: ACPI: Added _OSI(Module Device) Sep 9 04:45:56.785511 kernel: ACPI: Added _OSI(Processor Device) Sep 9 04:45:56.785519 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 04:45:56.785526 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 04:45:56.785534 kernel: ACPI: Interpreter enabled Sep 9 04:45:56.785541 kernel: ACPI: Using GIC for interrupt routing Sep 9 04:45:56.785548 kernel: ACPI: MCFG table detected, 1 entries Sep 9 04:45:56.785555 kernel: ACPI: CPU0 has been hot-added Sep 9 04:45:56.785562 kernel: ACPI: CPU1 has been hot-added Sep 9 04:45:56.785568 kernel: ACPI: CPU2 has been hot-added Sep 9 04:45:56.785575 kernel: ACPI: CPU3 has been hot-added Sep 9 04:45:56.785582 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 9 04:45:56.785589 kernel: printk: legacy console [ttyAMA0] enabled Sep 9 04:45:56.785597 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 9 04:45:56.785733 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 9 04:45:56.785796 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 9 04:45:56.785865 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 9 04:45:56.785932 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 9 04:45:56.785988 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 9 04:45:56.785997 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 9 04:45:56.786007 kernel: PCI host bridge to bus 0000:00 Sep 9 04:45:56.786071 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 9 04:45:56.786124 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 9 04:45:56.786176 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 9 04:45:56.786241 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 9 04:45:56.786322 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Sep 9 04:45:56.786392 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 9 04:45:56.786470 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Sep 9 04:45:56.786532 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Sep 9 04:45:56.786590 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 04:45:56.786650 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Sep 9 04:45:56.786742 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Sep 9 04:45:56.786806 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Sep 9 04:45:56.786863 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 9 04:45:56.787002 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 9 04:45:56.787063 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 9 04:45:56.787073 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 9 04:45:56.787080 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 9 04:45:56.787087 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 9 04:45:56.787095 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 9 04:45:56.787102 kernel: iommu: Default domain type: Translated Sep 9 04:45:56.787110 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 9 04:45:56.787121 kernel: efivars: Registered efivars operations Sep 9 04:45:56.787128 kernel: vgaarb: loaded Sep 9 04:45:56.787135 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 9 04:45:56.787142 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 04:45:56.787149 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 04:45:56.787156 kernel: pnp: PnP ACPI init Sep 9 04:45:56.787257 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 9 04:45:56.787269 kernel: pnp: PnP ACPI: found 1 devices Sep 9 04:45:56.787293 kernel: NET: Registered PF_INET protocol family Sep 9 04:45:56.787301 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 04:45:56.787308 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 9 04:45:56.787316 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 04:45:56.787323 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 9 04:45:56.787330 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 9 04:45:56.787337 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 9 04:45:56.787344 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 04:45:56.787351 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 04:45:56.787360 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 04:45:56.787367 kernel: PCI: CLS 0 bytes, default 64 Sep 9 04:45:56.787374 kernel: kvm [1]: HYP mode not available Sep 9 04:45:56.787381 kernel: Initialise system trusted keyrings Sep 9 04:45:56.787388 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 9 04:45:56.787395 kernel: Key type asymmetric registered Sep 9 04:45:56.787402 kernel: Asymmetric key parser 'x509' registered Sep 9 04:45:56.787410 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 9 04:45:56.787417 kernel: io scheduler mq-deadline registered Sep 9 04:45:56.787425 kernel: io scheduler kyber registered Sep 9 04:45:56.787443 kernel: io scheduler bfq registered Sep 9 04:45:56.787452 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 9 04:45:56.787460 kernel: ACPI: button: Power Button [PWRB] Sep 9 04:45:56.787468 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 9 04:45:56.787542 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 9 04:45:56.787552 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 04:45:56.787559 kernel: thunder_xcv, ver 1.0 Sep 9 04:45:56.787566 kernel: thunder_bgx, ver 1.0 Sep 9 04:45:56.787575 kernel: nicpf, ver 1.0 Sep 9 04:45:56.787582 kernel: nicvf, ver 1.0 Sep 9 04:45:56.787653 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 9 04:45:56.787709 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-09T04:45:56 UTC (1757393156) Sep 9 04:45:56.787719 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 04:45:56.787726 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 9 04:45:56.787733 kernel: watchdog: NMI not fully supported Sep 9 04:45:56.787740 kernel: watchdog: Hard watchdog permanently disabled Sep 9 04:45:56.787749 kernel: NET: Registered PF_INET6 protocol family Sep 9 04:45:56.787756 kernel: Segment Routing with IPv6 Sep 9 04:45:56.787763 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 04:45:56.787770 kernel: NET: Registered PF_PACKET protocol family Sep 9 04:45:56.787776 kernel: Key type dns_resolver registered Sep 9 04:45:56.787783 kernel: registered taskstats version 1 Sep 9 04:45:56.787790 kernel: Loading compiled-in X.509 certificates Sep 9 04:45:56.787798 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.45-flatcar: 44d1e8b5c5ffbaa3cedd99c03d41580671fabec5' Sep 9 04:45:56.787805 kernel: Demotion targets for Node 0: null Sep 9 04:45:56.787813 kernel: Key type .fscrypt registered Sep 9 04:45:56.787820 kernel: Key type fscrypt-provisioning registered Sep 9 04:45:56.787827 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 04:45:56.787834 kernel: ima: Allocated hash algorithm: sha1 Sep 9 04:45:56.787842 kernel: ima: No architecture policies found Sep 9 04:45:56.787849 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 9 04:45:56.787856 kernel: clk: Disabling unused clocks Sep 9 04:45:56.787863 kernel: PM: genpd: Disabling unused power domains Sep 9 04:45:56.787870 kernel: Warning: unable to open an initial console. Sep 9 04:45:56.787879 kernel: Freeing unused kernel memory: 38976K Sep 9 04:45:56.787886 kernel: Run /init as init process Sep 9 04:45:56.787893 kernel: with arguments: Sep 9 04:45:56.787900 kernel: /init Sep 9 04:45:56.787907 kernel: with environment: Sep 9 04:45:56.787914 kernel: HOME=/ Sep 9 04:45:56.787921 kernel: TERM=linux Sep 9 04:45:56.787927 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 9 04:45:56.787935 systemd[1]: Successfully made /usr/ read-only. Sep 9 04:45:56.787947 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 9 04:45:56.787956 systemd[1]: Detected virtualization kvm. Sep 9 04:45:56.787963 systemd[1]: Detected architecture arm64. Sep 9 04:45:56.787970 systemd[1]: Running in initrd. Sep 9 04:45:56.787978 systemd[1]: No hostname configured, using default hostname. Sep 9 04:45:56.787986 systemd[1]: Hostname set to . Sep 9 04:45:56.787993 systemd[1]: Initializing machine ID from VM UUID. Sep 9 04:45:56.788002 systemd[1]: Queued start job for default target initrd.target. Sep 9 04:45:56.788010 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 04:45:56.788018 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 04:45:56.788026 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 9 04:45:56.788034 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 04:45:56.788041 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 9 04:45:56.788050 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 9 04:45:56.788060 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 9 04:45:56.788068 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 9 04:45:56.788076 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 04:45:56.788084 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 04:45:56.788091 systemd[1]: Reached target paths.target - Path Units. Sep 9 04:45:56.788099 systemd[1]: Reached target slices.target - Slice Units. Sep 9 04:45:56.788106 systemd[1]: Reached target swap.target - Swaps. Sep 9 04:45:56.788114 systemd[1]: Reached target timers.target - Timer Units. Sep 9 04:45:56.788123 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 04:45:56.788130 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 04:45:56.788138 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 9 04:45:56.788145 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 9 04:45:56.788153 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 04:45:56.788161 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 04:45:56.788169 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 04:45:56.788176 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 04:45:56.788195 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 9 04:45:56.788204 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 04:45:56.788212 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 9 04:45:56.788220 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 9 04:45:56.788228 systemd[1]: Starting systemd-fsck-usr.service... Sep 9 04:45:56.788235 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 04:45:56.788243 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 04:45:56.788251 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 04:45:56.788258 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 9 04:45:56.788267 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 04:45:56.788275 systemd[1]: Finished systemd-fsck-usr.service. Sep 9 04:45:56.788300 systemd-journald[244]: Collecting audit messages is disabled. Sep 9 04:45:56.788321 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 04:45:56.788330 systemd-journald[244]: Journal started Sep 9 04:45:56.788349 systemd-journald[244]: Runtime Journal (/run/log/journal/94ecf78883324e7591b61d04b63bb2c5) is 6M, max 48.5M, 42.4M free. Sep 9 04:45:56.780518 systemd-modules-load[248]: Inserted module 'overlay' Sep 9 04:45:56.792172 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 04:45:56.800080 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 04:45:56.804250 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 9 04:45:56.804282 kernel: Bridge firewalling registered Sep 9 04:45:56.801579 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 04:45:56.804058 systemd-modules-load[248]: Inserted module 'br_netfilter' Sep 9 04:45:56.805925 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 04:45:56.809269 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 04:45:56.815288 systemd-tmpfiles[264]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 9 04:45:56.816478 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 04:45:56.818393 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 04:45:56.829402 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 04:45:56.832701 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 04:45:56.839671 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 04:45:56.843408 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 04:45:56.845213 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 04:45:56.848205 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 04:45:56.864926 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 9 04:45:56.889817 systemd-resolved[286]: Positive Trust Anchors: Sep 9 04:45:56.889837 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 04:45:56.889867 systemd-resolved[286]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 9 04:45:56.894838 systemd-resolved[286]: Defaulting to hostname 'linux'. Sep 9 04:45:56.901751 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=1e9320fd787e27d01e3b8a1acb67e0c640346112c469b7a652e9dcfc9271bf90 Sep 9 04:45:56.895868 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 04:45:56.901010 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 04:45:56.970218 kernel: SCSI subsystem initialized Sep 9 04:45:56.975203 kernel: Loading iSCSI transport class v2.0-870. Sep 9 04:45:56.982206 kernel: iscsi: registered transport (tcp) Sep 9 04:45:56.995292 kernel: iscsi: registered transport (qla4xxx) Sep 9 04:45:56.995366 kernel: QLogic iSCSI HBA Driver Sep 9 04:45:57.012642 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 04:45:57.030214 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 04:45:57.032485 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 04:45:57.078168 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 9 04:45:57.080514 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 9 04:45:57.146221 kernel: raid6: neonx8 gen() 15773 MB/s Sep 9 04:45:57.163198 kernel: raid6: neonx4 gen() 15783 MB/s Sep 9 04:45:57.180199 kernel: raid6: neonx2 gen() 13262 MB/s Sep 9 04:45:57.197196 kernel: raid6: neonx1 gen() 10450 MB/s Sep 9 04:45:57.214196 kernel: raid6: int64x8 gen() 6900 MB/s Sep 9 04:45:57.231206 kernel: raid6: int64x4 gen() 7349 MB/s Sep 9 04:45:57.248196 kernel: raid6: int64x2 gen() 6064 MB/s Sep 9 04:45:57.265199 kernel: raid6: int64x1 gen() 5052 MB/s Sep 9 04:45:57.265213 kernel: raid6: using algorithm neonx4 gen() 15783 MB/s Sep 9 04:45:57.282198 kernel: raid6: .... xor() 12335 MB/s, rmw enabled Sep 9 04:45:57.282225 kernel: raid6: using neon recovery algorithm Sep 9 04:45:57.287579 kernel: xor: measuring software checksum speed Sep 9 04:45:57.287605 kernel: 8regs : 21624 MB/sec Sep 9 04:45:57.288215 kernel: 32regs : 21676 MB/sec Sep 9 04:45:57.289215 kernel: arm64_neon : 28128 MB/sec Sep 9 04:45:57.289227 kernel: xor: using function: arm64_neon (28128 MB/sec) Sep 9 04:45:57.342210 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 9 04:45:57.348611 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 9 04:45:57.352362 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 04:45:57.379681 systemd-udevd[498]: Using default interface naming scheme 'v255'. Sep 9 04:45:57.383795 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 04:45:57.386349 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 9 04:45:57.418126 dracut-pre-trigger[507]: rd.md=0: removing MD RAID activation Sep 9 04:45:57.442555 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 04:45:57.445212 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 04:45:57.504629 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 04:45:57.508025 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 9 04:45:57.559696 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 9 04:45:57.559857 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 9 04:45:57.567205 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 04:45:57.570489 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 04:45:57.570619 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 04:45:57.575816 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 04:45:57.580255 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 04:45:57.607261 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 9 04:45:57.618024 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 9 04:45:57.620585 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 9 04:45:57.621996 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 04:45:57.640791 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 9 04:45:57.642102 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 9 04:45:57.651722 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 04:45:57.653044 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 04:45:57.655457 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 04:45:57.657899 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 04:45:57.661079 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 9 04:45:57.663198 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 9 04:45:57.686211 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 04:45:57.686514 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 9 04:45:58.698037 disk-uuid[594]: The operation has completed successfully. Sep 9 04:45:58.699598 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 04:45:58.724550 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 04:45:58.724655 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 9 04:45:58.751551 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 9 04:45:58.769357 sh[611]: Success Sep 9 04:45:58.782203 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 04:45:58.783892 kernel: device-mapper: uevent: version 1.0.3 Sep 9 04:45:58.783935 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 9 04:45:58.794270 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 9 04:45:58.820248 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 9 04:45:58.823455 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 9 04:45:58.846917 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 9 04:45:58.853214 kernel: BTRFS: device fsid 72a0ff35-b4e8-4772-9a8d-d0e90c3fb364 devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (623) Sep 9 04:45:58.853266 kernel: BTRFS info (device dm-0): first mount of filesystem 72a0ff35-b4e8-4772-9a8d-d0e90c3fb364 Sep 9 04:45:58.855007 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 9 04:45:58.859202 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 9 04:45:58.859271 kernel: BTRFS info (device dm-0): enabling free space tree Sep 9 04:45:58.860122 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 9 04:45:58.861670 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 9 04:45:58.863363 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 9 04:45:58.864254 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 9 04:45:58.866004 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 9 04:45:58.892976 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (654) Sep 9 04:45:58.893025 kernel: BTRFS info (device vda6): first mount of filesystem ea68277c-dabb-41e9-9258-b2fe475f0ae6 Sep 9 04:45:58.894005 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 04:45:58.896660 kernel: BTRFS info (device vda6): turning on async discard Sep 9 04:45:58.896711 kernel: BTRFS info (device vda6): enabling free space tree Sep 9 04:45:58.901207 kernel: BTRFS info (device vda6): last unmount of filesystem ea68277c-dabb-41e9-9258-b2fe475f0ae6 Sep 9 04:45:58.901952 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 9 04:45:58.906319 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 9 04:45:58.970723 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 04:45:58.973824 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 04:45:59.014741 ignition[704]: Ignition 2.22.0 Sep 9 04:45:59.014759 ignition[704]: Stage: fetch-offline Sep 9 04:45:59.014796 ignition[704]: no configs at "/usr/lib/ignition/base.d" Sep 9 04:45:59.014804 ignition[704]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 04:45:59.014890 ignition[704]: parsed url from cmdline: "" Sep 9 04:45:59.014894 ignition[704]: no config URL provided Sep 9 04:45:59.014898 ignition[704]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 04:45:59.014905 ignition[704]: no config at "/usr/lib/ignition/user.ign" Sep 9 04:45:59.014925 ignition[704]: op(1): [started] loading QEMU firmware config module Sep 9 04:45:59.014929 ignition[704]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 9 04:45:59.020607 ignition[704]: op(1): [finished] loading QEMU firmware config module Sep 9 04:45:59.029336 ignition[704]: parsing config with SHA512: 8dcf2e30c79010b9073f9a90e872998b77b4f8d4745a622a45e919016709473167d92e07262ce1d6367b5e5d3bc0beda3ff5111dc38da2dd074305a61948f4d4 Sep 9 04:45:59.035856 systemd-networkd[802]: lo: Link UP Sep 9 04:45:59.035867 systemd-networkd[802]: lo: Gained carrier Sep 9 04:45:59.036793 systemd-networkd[802]: Enumeration completed Sep 9 04:45:59.039648 ignition[704]: fetch-offline: fetch-offline passed Sep 9 04:45:59.036927 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 04:45:59.039739 ignition[704]: Ignition finished successfully Sep 9 04:45:59.037229 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 04:45:59.037233 systemd-networkd[802]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 04:45:59.038264 systemd-networkd[802]: eth0: Link UP Sep 9 04:45:59.038354 systemd-networkd[802]: eth0: Gained carrier Sep 9 04:45:59.038363 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 04:45:59.038941 systemd[1]: Reached target network.target - Network. Sep 9 04:45:59.039417 unknown[704]: fetched base config from "system" Sep 9 04:45:59.039434 unknown[704]: fetched user config from "qemu" Sep 9 04:45:59.042635 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 04:45:59.045051 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 9 04:45:59.045907 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 9 04:45:59.055243 systemd-networkd[802]: eth0: DHCPv4 address 10.0.0.10/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 04:45:59.085488 ignition[812]: Ignition 2.22.0 Sep 9 04:45:59.085501 ignition[812]: Stage: kargs Sep 9 04:45:59.085705 ignition[812]: no configs at "/usr/lib/ignition/base.d" Sep 9 04:45:59.085715 ignition[812]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 04:45:59.088601 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 9 04:45:59.086301 ignition[812]: kargs: kargs passed Sep 9 04:45:59.086348 ignition[812]: Ignition finished successfully Sep 9 04:45:59.091259 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 9 04:45:59.118833 ignition[821]: Ignition 2.22.0 Sep 9 04:45:59.118874 ignition[821]: Stage: disks Sep 9 04:45:59.119048 ignition[821]: no configs at "/usr/lib/ignition/base.d" Sep 9 04:45:59.119057 ignition[821]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 04:45:59.121729 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 9 04:45:59.119654 ignition[821]: disks: disks passed Sep 9 04:45:59.123688 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 9 04:45:59.119700 ignition[821]: Ignition finished successfully Sep 9 04:45:59.125541 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 04:45:59.127662 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 04:45:59.129209 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 04:45:59.131278 systemd[1]: Reached target basic.target - Basic System. Sep 9 04:45:59.133784 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 9 04:45:59.165944 systemd-resolved[286]: Detected conflict on linux IN A 10.0.0.10 Sep 9 04:45:59.165955 systemd-resolved[286]: Hostname conflict, changing published hostname from 'linux' to 'linux6'. Sep 9 04:45:59.169104 systemd-fsck[831]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 9 04:45:59.171593 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 9 04:45:59.174528 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 9 04:45:59.252207 kernel: EXT4-fs (vda9): mounted filesystem 88574756-967d-44b3-be66-46689c8baf27 r/w with ordered data mode. Quota mode: none. Sep 9 04:45:59.252907 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 9 04:45:59.254306 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 9 04:45:59.259342 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 04:45:59.261037 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 9 04:45:59.262136 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 9 04:45:59.262203 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 9 04:45:59.262231 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 04:45:59.282045 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 9 04:45:59.284919 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 9 04:45:59.288208 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (839) Sep 9 04:45:59.290932 kernel: BTRFS info (device vda6): first mount of filesystem ea68277c-dabb-41e9-9258-b2fe475f0ae6 Sep 9 04:45:59.290958 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 04:45:59.294503 kernel: BTRFS info (device vda6): turning on async discard Sep 9 04:45:59.294547 kernel: BTRFS info (device vda6): enabling free space tree Sep 9 04:45:59.296122 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 04:45:59.325384 initrd-setup-root[864]: cut: /sysroot/etc/passwd: No such file or directory Sep 9 04:45:59.329537 initrd-setup-root[871]: cut: /sysroot/etc/group: No such file or directory Sep 9 04:45:59.332485 initrd-setup-root[878]: cut: /sysroot/etc/shadow: No such file or directory Sep 9 04:45:59.336331 initrd-setup-root[885]: cut: /sysroot/etc/gshadow: No such file or directory Sep 9 04:45:59.412026 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 9 04:45:59.414372 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 9 04:45:59.416147 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 9 04:45:59.431202 kernel: BTRFS info (device vda6): last unmount of filesystem ea68277c-dabb-41e9-9258-b2fe475f0ae6 Sep 9 04:45:59.450337 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 9 04:45:59.465332 ignition[952]: INFO : Ignition 2.22.0 Sep 9 04:45:59.465332 ignition[952]: INFO : Stage: mount Sep 9 04:45:59.467875 ignition[952]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 04:45:59.467875 ignition[952]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 04:45:59.467875 ignition[952]: INFO : mount: mount passed Sep 9 04:45:59.467875 ignition[952]: INFO : Ignition finished successfully Sep 9 04:45:59.467961 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 9 04:45:59.470747 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 9 04:45:59.852791 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 9 04:45:59.854353 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 04:45:59.879216 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (966) Sep 9 04:45:59.881253 kernel: BTRFS info (device vda6): first mount of filesystem ea68277c-dabb-41e9-9258-b2fe475f0ae6 Sep 9 04:45:59.881272 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 04:45:59.883680 kernel: BTRFS info (device vda6): turning on async discard Sep 9 04:45:59.883719 kernel: BTRFS info (device vda6): enabling free space tree Sep 9 04:45:59.885438 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 04:45:59.919462 ignition[983]: INFO : Ignition 2.22.0 Sep 9 04:45:59.919462 ignition[983]: INFO : Stage: files Sep 9 04:45:59.921408 ignition[983]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 04:45:59.921408 ignition[983]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 04:45:59.921408 ignition[983]: DEBUG : files: compiled without relabeling support, skipping Sep 9 04:45:59.925227 ignition[983]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 9 04:45:59.925227 ignition[983]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 9 04:45:59.928386 ignition[983]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 9 04:45:59.928386 ignition[983]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 9 04:45:59.928386 ignition[983]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 9 04:45:59.927700 unknown[983]: wrote ssh authorized keys file for user: core Sep 9 04:45:59.934674 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 04:45:59.936790 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 04:45:59.936790 ignition[983]: INFO : files: op(4): [started] processing unit "etcd-member.service" Sep 9 04:45:59.940952 ignition[983]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 9 04:45:59.947930 ignition[983]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 9 04:45:59.947930 ignition[983]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Sep 9 04:45:59.947930 ignition[983]: INFO : files: op(6): [started] processing unit "flannel-docker-opts.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(6): op(7): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(6): op(7): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(6): [finished] processing unit "flannel-docker-opts.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(8): [started] processing unit "docker.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(8): [finished] processing unit "docker.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(9): [started] processing unit "flanneld.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(9): op(a): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(9): op(a): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(9): [finished] processing unit "flanneld.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(b): [started] processing unit "coreos-metadata.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(b): op(c): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(b): op(c): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(b): [finished] processing unit "coreos-metadata.service" Sep 9 04:45:59.961060 ignition[983]: INFO : files: op(d): [started] setting preset to disabled for "coreos-metadata.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(d): op(e): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(d): op(e): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(d): [finished] setting preset to disabled for "coreos-metadata.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(f): [started] setting preset to enabled for "docker.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(f): [finished] setting preset to enabled for "docker.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(10): [started] setting preset to enabled for "etcd-member.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(10): [finished] setting preset to enabled for "etcd-member.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(11): [started] setting preset to enabled for "flanneld.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: op(11): [finished] setting preset to enabled for "flanneld.service" Sep 9 04:45:59.993147 ignition[983]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 04:45:59.993147 ignition[983]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 04:45:59.993147 ignition[983]: INFO : files: files passed Sep 9 04:45:59.993147 ignition[983]: INFO : Ignition finished successfully Sep 9 04:45:59.975409 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 9 04:45:59.977686 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 9 04:46:00.022572 initrd-setup-root-after-ignition[1011]: grep: /sysroot/oem/oem-release: No such file or directory Sep 9 04:45:59.980729 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 9 04:46:00.025636 initrd-setup-root-after-ignition[1013]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 04:46:00.025636 initrd-setup-root-after-ignition[1013]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 9 04:45:59.997546 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 04:46:00.030215 initrd-setup-root-after-ignition[1017]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 04:45:59.997667 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 9 04:46:00.003769 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 04:46:00.007276 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 9 04:46:00.010397 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 9 04:46:00.072441 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 04:46:00.072578 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 9 04:46:00.075105 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 9 04:46:00.077250 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 9 04:46:00.079539 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 9 04:46:00.080511 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 9 04:46:00.111148 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 04:46:00.113684 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 9 04:46:00.140156 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 9 04:46:00.142761 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 04:46:00.144155 systemd[1]: Stopped target timers.target - Timer Units. Sep 9 04:46:00.146382 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 04:46:00.146524 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 04:46:00.149350 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 9 04:46:00.151611 systemd[1]: Stopped target basic.target - Basic System. Sep 9 04:46:00.153585 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 9 04:46:00.155621 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 04:46:00.157805 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 9 04:46:00.160002 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 9 04:46:00.162233 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 9 04:46:00.164350 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 04:46:00.166700 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 9 04:46:00.168975 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 9 04:46:00.171089 systemd[1]: Stopped target swap.target - Swaps. Sep 9 04:46:00.172879 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 04:46:00.173018 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 9 04:46:00.175562 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 9 04:46:00.177669 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 04:46:00.179832 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 9 04:46:00.183219 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 04:46:00.184625 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 04:46:00.184750 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 9 04:46:00.187953 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 04:46:00.188071 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 04:46:00.190326 systemd[1]: Stopped target paths.target - Path Units. Sep 9 04:46:00.192159 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 04:46:00.198255 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 04:46:00.199403 systemd[1]: Stopped target slices.target - Slice Units. Sep 9 04:46:00.201653 systemd[1]: Stopped target sockets.target - Socket Units. Sep 9 04:46:00.203293 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 04:46:00.203414 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 04:46:00.205079 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 04:46:00.205218 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 04:46:00.206732 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 04:46:00.206890 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 04:46:00.208596 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 04:46:00.208742 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 9 04:46:00.211134 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 9 04:46:00.213096 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 04:46:00.213282 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 04:46:00.223851 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 9 04:46:00.224754 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 04:46:00.224949 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 04:46:00.226983 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 04:46:00.227138 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 04:46:00.235451 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 04:46:00.236836 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 9 04:46:00.242524 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 9 04:46:00.244068 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 9 04:46:00.244152 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 9 04:46:00.247672 ignition[1039]: INFO : Ignition 2.22.0 Sep 9 04:46:00.247672 ignition[1039]: INFO : Stage: umount Sep 9 04:46:00.247672 ignition[1039]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 04:46:00.247672 ignition[1039]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 04:46:00.247672 ignition[1039]: INFO : umount: umount passed Sep 9 04:46:00.256932 ignition[1039]: INFO : Ignition finished successfully Sep 9 04:46:00.249274 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 04:46:00.249374 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 9 04:46:00.251140 systemd[1]: Stopped target network.target - Network. Sep 9 04:46:00.254074 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 04:46:00.254145 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 9 04:46:00.256092 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 04:46:00.256135 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 9 04:46:00.257812 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 9 04:46:00.257865 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 9 04:46:00.259543 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 9 04:46:00.259586 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 9 04:46:00.261239 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 04:46:00.261294 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 9 04:46:00.263260 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 9 04:46:00.265106 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 9 04:46:00.269858 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 04:46:00.270003 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 9 04:46:00.273073 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 9 04:46:00.273377 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 9 04:46:00.273438 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 04:46:00.277135 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 9 04:46:00.280169 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 04:46:00.281837 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 9 04:46:00.283891 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 9 04:46:00.286227 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 04:46:00.286269 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 9 04:46:00.289465 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 9 04:46:00.290788 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 04:46:00.290859 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 04:46:00.293528 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 04:46:00.293582 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 9 04:46:00.296976 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 04:46:00.297025 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 9 04:46:00.299437 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 04:46:00.315150 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 04:46:00.315292 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 9 04:46:00.322866 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 04:46:00.323048 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 04:46:00.325652 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 04:46:00.325695 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 9 04:46:00.327909 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 9 04:46:00.327947 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 04:46:00.329996 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 04:46:00.330053 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 9 04:46:00.333188 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 04:46:00.333241 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 9 04:46:00.336262 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 04:46:00.336318 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 04:46:00.340288 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 9 04:46:00.341685 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 9 04:46:00.341749 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 04:46:00.345232 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 9 04:46:00.345277 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 04:46:00.348479 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 04:46:00.348524 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 04:46:00.356673 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 04:46:00.356790 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 9 04:46:00.359227 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 9 04:46:00.361983 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 9 04:46:00.391756 systemd[1]: Switching root. Sep 9 04:46:00.429980 systemd-journald[244]: Journal stopped Sep 9 04:46:01.186228 systemd-journald[244]: Received SIGTERM from PID 1 (systemd). Sep 9 04:46:01.186285 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 04:46:01.186296 kernel: SELinux: policy capability open_perms=1 Sep 9 04:46:01.186310 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 04:46:01.186323 kernel: SELinux: policy capability always_check_network=0 Sep 9 04:46:01.186333 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 04:46:01.186346 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 04:46:01.186355 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 04:46:01.186368 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 04:46:01.186378 kernel: SELinux: policy capability userspace_initial_context=0 Sep 9 04:46:01.186389 kernel: audit: type=1403 audit(1757393160.526:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 9 04:46:01.186402 systemd[1]: Successfully loaded SELinux policy in 56.525ms. Sep 9 04:46:01.186427 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.023ms. Sep 9 04:46:01.186440 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 9 04:46:01.186452 systemd[1]: Detected virtualization kvm. Sep 9 04:46:01.186463 systemd[1]: Detected architecture arm64. Sep 9 04:46:01.186473 systemd[1]: Detected first boot. Sep 9 04:46:01.186487 systemd[1]: Initializing machine ID from VM UUID. Sep 9 04:46:01.186498 zram_generator::config[1084]: No configuration found. Sep 9 04:46:01.186509 kernel: NET: Registered PF_VSOCK protocol family Sep 9 04:46:01.186521 systemd[1]: Populated /etc with preset unit settings. Sep 9 04:46:01.186533 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 9 04:46:01.186544 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 04:46:01.186555 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 9 04:46:01.186566 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 04:46:01.186577 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 9 04:46:01.186587 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 9 04:46:01.186597 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 9 04:46:01.186610 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 9 04:46:01.186621 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 9 04:46:01.186632 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 9 04:46:01.186643 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 9 04:46:01.186653 systemd[1]: Created slice user.slice - User and Session Slice. Sep 9 04:46:01.186663 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 04:46:01.186674 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 04:46:01.186685 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 9 04:46:01.186696 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 9 04:46:01.186708 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 9 04:46:01.186719 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 04:46:01.186730 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 9 04:46:01.186741 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 04:46:01.186751 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 04:46:01.186777 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 9 04:46:01.186788 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 9 04:46:01.186798 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 9 04:46:01.186812 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 9 04:46:01.186823 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 04:46:01.186833 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 04:46:01.186844 systemd[1]: Reached target slices.target - Slice Units. Sep 9 04:46:01.186856 systemd[1]: Reached target swap.target - Swaps. Sep 9 04:46:01.186867 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 9 04:46:01.186878 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 04:46:01.186889 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 9 04:46:01.186899 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 04:46:01.186913 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 04:46:01.186924 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 04:46:01.186934 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 9 04:46:01.186946 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 9 04:46:01.187005 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 9 04:46:01.187043 systemd[1]: Mounting media.mount - External Media Directory... Sep 9 04:46:01.187054 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 9 04:46:01.187065 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 9 04:46:01.187076 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 9 04:46:01.187088 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 9 04:46:01.187099 systemd[1]: Reached target machines.target - Containers. Sep 9 04:46:01.187110 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 9 04:46:01.187134 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 04:46:01.187145 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 04:46:01.187159 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 9 04:46:01.187170 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 04:46:01.187237 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 04:46:01.187252 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 04:46:01.187263 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 9 04:46:01.187275 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 04:46:01.187286 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 9 04:46:01.187297 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 04:46:01.187308 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 9 04:46:01.187319 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 9 04:46:01.187329 systemd[1]: Stopped systemd-fsck-usr.service. Sep 9 04:46:01.187353 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 04:46:01.187366 kernel: fuse: init (API version 7.41) Sep 9 04:46:01.187377 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 04:46:01.187388 kernel: loop: module loaded Sep 9 04:46:01.187399 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 04:46:01.187409 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 04:46:01.187429 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 9 04:46:01.187441 kernel: ACPI: bus type drm_connector registered Sep 9 04:46:01.187451 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 9 04:46:01.187465 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 04:46:01.187475 systemd[1]: verity-setup.service: Deactivated successfully. Sep 9 04:46:01.187485 systemd[1]: Stopped verity-setup.service. Sep 9 04:46:01.187535 systemd-journald[1152]: Collecting audit messages is disabled. Sep 9 04:46:01.187560 systemd-journald[1152]: Journal started Sep 9 04:46:01.187581 systemd-journald[1152]: Runtime Journal (/run/log/journal/94ecf78883324e7591b61d04b63bb2c5) is 6M, max 48.5M, 42.4M free. Sep 9 04:46:00.942546 systemd[1]: Queued start job for default target multi-user.target. Sep 9 04:46:00.968480 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 9 04:46:00.968862 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 04:46:01.189715 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 04:46:01.190382 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 9 04:46:01.192068 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 9 04:46:01.193692 systemd[1]: Mounted media.mount - External Media Directory. Sep 9 04:46:01.195116 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 9 04:46:01.196635 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 9 04:46:01.198125 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 9 04:46:01.200451 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 9 04:46:01.203227 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 04:46:01.205107 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 04:46:01.205349 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 9 04:46:01.206997 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 04:46:01.207265 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 04:46:01.208750 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 04:46:01.208905 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 04:46:01.210556 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 04:46:01.210722 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 04:46:01.212502 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 04:46:01.212680 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 9 04:46:01.214099 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 04:46:01.214517 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 04:46:01.216218 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 04:46:01.217862 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 04:46:01.219724 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 9 04:46:01.221491 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 9 04:46:01.234899 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 04:46:01.237133 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 9 04:46:01.239154 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 9 04:46:01.240270 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 9 04:46:01.240312 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 04:46:01.242121 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 9 04:46:01.250386 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 9 04:46:01.251731 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 04:46:01.253371 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 9 04:46:01.255679 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 9 04:46:01.257530 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 04:46:01.261371 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 9 04:46:01.263029 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 04:46:01.264663 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 04:46:01.265661 systemd-journald[1152]: Time spent on flushing to /var/log/journal/94ecf78883324e7591b61d04b63bb2c5 is 24.686ms for 867 entries. Sep 9 04:46:01.265661 systemd-journald[1152]: System Journal (/var/log/journal/94ecf78883324e7591b61d04b63bb2c5) is 8M, max 195.6M, 187.6M free. Sep 9 04:46:01.297884 systemd-journald[1152]: Received client request to flush runtime journal. Sep 9 04:46:01.297937 kernel: loop0: detected capacity change from 0 to 100632 Sep 9 04:46:01.268384 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 9 04:46:01.271437 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 9 04:46:01.276035 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 04:46:01.277791 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 9 04:46:01.279385 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 9 04:46:01.283242 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 9 04:46:01.287569 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 9 04:46:01.293346 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 9 04:46:01.300522 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 9 04:46:01.304291 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 04:46:01.318216 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 9 04:46:01.332834 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 9 04:46:01.336016 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 04:46:01.338048 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 9 04:46:01.343252 kernel: loop1: detected capacity change from 0 to 119368 Sep 9 04:46:01.367497 systemd-tmpfiles[1216]: ACLs are not supported, ignoring. Sep 9 04:46:01.367518 systemd-tmpfiles[1216]: ACLs are not supported, ignoring. Sep 9 04:46:01.372952 kernel: loop2: detected capacity change from 0 to 100632 Sep 9 04:46:01.372278 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 04:46:01.388114 kernel: loop3: detected capacity change from 0 to 119368 Sep 9 04:46:01.391541 (sd-merge)[1220]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 9 04:46:01.391899 (sd-merge)[1220]: Merged extensions into '/usr'. Sep 9 04:46:01.396226 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 9 04:46:01.399447 systemd[1]: Starting ensure-sysext.service... Sep 9 04:46:01.403352 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 04:46:01.423479 systemd[1]: Reload requested from client PID 1223 ('systemctl') (unit ensure-sysext.service)... Sep 9 04:46:01.423499 systemd[1]: Reloading... Sep 9 04:46:01.432771 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 9 04:46:01.433145 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 9 04:46:01.433503 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 04:46:01.433836 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 9 04:46:01.435165 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 04:46:01.435522 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Sep 9 04:46:01.435748 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Sep 9 04:46:01.438909 systemd-tmpfiles[1224]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 04:46:01.439017 systemd-tmpfiles[1224]: Skipping /boot Sep 9 04:46:01.445207 systemd-tmpfiles[1224]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 04:46:01.445309 systemd-tmpfiles[1224]: Skipping /boot Sep 9 04:46:01.464219 zram_generator::config[1248]: No configuration found. Sep 9 04:46:01.564861 ldconfig[1195]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 04:46:01.641694 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 04:46:01.641890 systemd[1]: Reloading finished in 218 ms. Sep 9 04:46:01.675139 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 9 04:46:01.690398 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 04:46:01.700787 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 04:46:01.703445 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 9 04:46:01.716490 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 9 04:46:01.722457 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 04:46:01.726436 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 9 04:46:01.730269 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 04:46:01.732421 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 04:46:01.734778 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 04:46:01.740110 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 04:46:01.743617 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 04:46:01.743761 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 04:46:01.749239 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 04:46:01.749421 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 04:46:01.749508 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 04:46:01.751234 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 9 04:46:01.752989 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 9 04:46:01.754883 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 04:46:01.755052 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 04:46:01.756871 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 04:46:01.767369 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 04:46:01.769289 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 04:46:01.771227 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 04:46:01.778788 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 04:46:01.780255 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 04:46:01.782567 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 04:46:01.785431 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 04:46:01.789488 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 04:46:01.790830 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 04:46:01.790959 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 04:46:01.792031 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 04:46:01.793270 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 04:46:01.794803 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 04:46:01.794967 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 04:46:01.796568 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 04:46:01.796727 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 04:46:01.798297 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 04:46:01.798473 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 04:46:01.801706 systemd[1]: Finished ensure-sysext.service. Sep 9 04:46:01.806001 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 04:46:01.806072 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 04:46:01.808007 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 9 04:46:01.824141 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 9 04:46:01.826969 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 9 04:46:01.838381 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 9 04:46:01.840080 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 9 04:46:01.892875 augenrules[1338]: No rules Sep 9 04:46:01.894642 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 04:46:01.894847 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 04:46:01.899269 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 9 04:46:01.902749 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 04:46:01.905689 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 9 04:46:01.921432 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 9 04:46:01.928734 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 9 04:46:01.930363 systemd[1]: Reached target time-set.target - System Time Set. Sep 9 04:46:01.930905 systemd-resolved[1292]: Positive Trust Anchors: Sep 9 04:46:01.930935 systemd-resolved[1292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 04:46:01.930967 systemd-resolved[1292]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 9 04:46:01.936816 systemd-udevd[1345]: Using default interface naming scheme 'v255'. Sep 9 04:46:01.939682 systemd-resolved[1292]: Defaulting to hostname 'linux'. Sep 9 04:46:01.940993 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 04:46:01.942398 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 04:46:01.956495 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 04:46:01.958568 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 04:46:01.960789 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 9 04:46:01.962224 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 9 04:46:01.963768 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 9 04:46:01.966073 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 9 04:46:01.967598 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 9 04:46:01.969084 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 9 04:46:01.969128 systemd[1]: Reached target paths.target - Path Units. Sep 9 04:46:01.970308 systemd[1]: Reached target timers.target - Timer Units. Sep 9 04:46:01.972163 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 9 04:46:01.974432 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 04:46:01.977423 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 9 04:46:01.978667 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 9 04:46:01.979794 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 9 04:46:01.990174 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 9 04:46:01.992007 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 9 04:46:01.995068 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 04:46:01.997842 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 04:46:02.001487 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 04:46:02.002560 systemd[1]: Reached target basic.target - Basic System. Sep 9 04:46:02.003641 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 9 04:46:02.003669 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 9 04:46:02.004886 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 9 04:46:02.006973 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 9 04:46:02.011767 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 9 04:46:02.013847 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 9 04:46:02.015008 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 9 04:46:02.021634 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 04:46:02.024055 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 9 04:46:02.026705 jq[1381]: false Sep 9 04:46:02.027498 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 9 04:46:02.041450 extend-filesystems[1382]: Found /dev/vda6 Sep 9 04:46:02.039662 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 9 04:46:02.042050 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 9 04:46:02.042722 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 9 04:46:02.044228 systemd[1]: Starting update-engine.service - Update Engine... Sep 9 04:46:02.046946 extend-filesystems[1382]: Found /dev/vda9 Sep 9 04:46:02.047958 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 9 04:46:02.050345 extend-filesystems[1382]: Checking size of /dev/vda9 Sep 9 04:46:02.051118 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 9 04:46:02.053706 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 9 04:46:02.054152 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 9 04:46:02.054560 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 04:46:02.054773 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 9 04:46:02.070300 jq[1396]: true Sep 9 04:46:02.070560 extend-filesystems[1382]: Old size kept for /dev/vda9 Sep 9 04:46:02.072567 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 04:46:02.072807 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 9 04:46:02.086331 jq[1413]: true Sep 9 04:46:02.094673 dbus-daemon[1379]: [system] SELinux support is enabled Sep 9 04:46:02.112151 update_engine[1393]: I20250909 04:46:02.111583 1393 main.cc:92] Flatcar Update Engine starting Sep 9 04:46:02.115127 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 9 04:46:02.119425 update_engine[1393]: I20250909 04:46:02.119359 1393 update_check_scheduler.cc:74] Next update check in 9m23s Sep 9 04:46:02.119672 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 04:46:02.119893 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 04:46:02.137050 systemd[1]: Started update-engine.service - Update Engine. Sep 9 04:46:02.144022 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 04:46:02.147483 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 9 04:46:02.147518 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 9 04:46:02.149147 systemd-logind[1389]: New seat seat0. Sep 9 04:46:02.151046 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 9 04:46:02.177761 systemd-networkd[1377]: lo: Link UP Sep 9 04:46:02.177966 systemd-networkd[1377]: lo: Gained carrier Sep 9 04:46:02.183592 systemd-networkd[1377]: Enumeration completed Sep 9 04:46:02.185583 systemd-networkd[1377]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 04:46:02.185592 systemd-networkd[1377]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 04:46:02.186542 systemd-networkd[1377]: eth0: Link UP Sep 9 04:46:02.186714 systemd-networkd[1377]: eth0: Gained carrier Sep 9 04:46:02.186729 systemd-networkd[1377]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 04:46:02.199262 systemd-networkd[1377]: eth0: DHCPv4 address 10.0.0.10/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 04:46:02.200595 systemd-timesyncd[1323]: Network configuration changed, trying to establish connection. Sep 9 04:46:02.202739 systemd-timesyncd[1323]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 9 04:46:02.202790 systemd-timesyncd[1323]: Initial clock synchronization to Tue 2025-09-09 04:46:02.438621 UTC. Sep 9 04:46:02.234681 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 9 04:46:02.236891 bash[1438]: Updated "/home/core/.ssh/authorized_keys" Sep 9 04:46:02.235248 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 9 04:46:02.264384 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 9 04:46:02.266576 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 04:46:02.268083 systemd[1]: Started systemd-logind.service - User Login Management. Sep 9 04:46:02.270943 systemd-logind[1389]: Watching system buttons on /dev/input/event0 (Power Button) Sep 9 04:46:02.272453 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 9 04:46:02.274781 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 9 04:46:02.279951 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 9 04:46:02.287784 systemd[1]: Reached target network.target - Network. Sep 9 04:46:02.290842 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 04:46:02.292505 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 9 04:46:02.294344 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 9 04:46:02.303293 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 9 04:46:02.306670 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 04:46:02.339469 locksmithd[1453]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 04:46:02.342567 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 9 04:46:02.344515 (ntainerd)[1468]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 04:46:02.364253 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 04:46:02.494790 containerd[1468]: time="2025-09-09T04:46:02Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 9 04:46:02.495557 containerd[1468]: time="2025-09-09T04:46:02.495523360Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 9 04:46:02.505888 containerd[1468]: time="2025-09-09T04:46:02.505836280Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.64µs" Sep 9 04:46:02.505888 containerd[1468]: time="2025-09-09T04:46:02.505876880Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 9 04:46:02.505888 containerd[1468]: time="2025-09-09T04:46:02.505895720Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 9 04:46:02.506075 containerd[1468]: time="2025-09-09T04:46:02.506055360Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 9 04:46:02.506100 containerd[1468]: time="2025-09-09T04:46:02.506077080Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 9 04:46:02.506122 containerd[1468]: time="2025-09-09T04:46:02.506102160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506167 containerd[1468]: time="2025-09-09T04:46:02.506151800Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506196 containerd[1468]: time="2025-09-09T04:46:02.506167200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506485 containerd[1468]: time="2025-09-09T04:46:02.506446960Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506485 containerd[1468]: time="2025-09-09T04:46:02.506473080Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506485 containerd[1468]: time="2025-09-09T04:46:02.506484280Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506550 containerd[1468]: time="2025-09-09T04:46:02.506493160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506586 containerd[1468]: time="2025-09-09T04:46:02.506570360Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506799 containerd[1468]: time="2025-09-09T04:46:02.506767240Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506823 containerd[1468]: time="2025-09-09T04:46:02.506802160Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 04:46:02.506823 containerd[1468]: time="2025-09-09T04:46:02.506812480Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 9 04:46:02.506861 containerd[1468]: time="2025-09-09T04:46:02.506847320Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 9 04:46:02.507092 containerd[1468]: time="2025-09-09T04:46:02.507070560Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 9 04:46:02.507163 containerd[1468]: time="2025-09-09T04:46:02.507140920Z" level=info msg="metadata content store policy set" policy=shared Sep 9 04:46:02.510503 containerd[1468]: time="2025-09-09T04:46:02.510462320Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 9 04:46:02.510560 containerd[1468]: time="2025-09-09T04:46:02.510517120Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 9 04:46:02.510560 containerd[1468]: time="2025-09-09T04:46:02.510538640Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 9 04:46:02.510595 containerd[1468]: time="2025-09-09T04:46:02.510550360Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 9 04:46:02.510613 containerd[1468]: time="2025-09-09T04:46:02.510579080Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 9 04:46:02.510613 containerd[1468]: time="2025-09-09T04:46:02.510606520Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 9 04:46:02.510653 containerd[1468]: time="2025-09-09T04:46:02.510617960Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 9 04:46:02.510653 containerd[1468]: time="2025-09-09T04:46:02.510629640Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 9 04:46:02.510653 containerd[1468]: time="2025-09-09T04:46:02.510640360Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 9 04:46:02.510653 containerd[1468]: time="2025-09-09T04:46:02.510651560Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 9 04:46:02.510734 containerd[1468]: time="2025-09-09T04:46:02.510661200Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 9 04:46:02.510734 containerd[1468]: time="2025-09-09T04:46:02.510673920Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 9 04:46:02.510813 containerd[1468]: time="2025-09-09T04:46:02.510792920Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 9 04:46:02.510843 containerd[1468]: time="2025-09-09T04:46:02.510820160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 9 04:46:02.510843 containerd[1468]: time="2025-09-09T04:46:02.510837160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 9 04:46:02.510875 containerd[1468]: time="2025-09-09T04:46:02.510848600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 9 04:46:02.510875 containerd[1468]: time="2025-09-09T04:46:02.510859040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 9 04:46:02.510875 containerd[1468]: time="2025-09-09T04:46:02.510868600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 9 04:46:02.510926 containerd[1468]: time="2025-09-09T04:46:02.510879840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 9 04:46:02.510926 containerd[1468]: time="2025-09-09T04:46:02.510890600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 9 04:46:02.510926 containerd[1468]: time="2025-09-09T04:46:02.510901920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 9 04:46:02.510926 containerd[1468]: time="2025-09-09T04:46:02.510912600Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 9 04:46:02.510926 containerd[1468]: time="2025-09-09T04:46:02.510922640Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 9 04:46:02.511236 containerd[1468]: time="2025-09-09T04:46:02.511217920Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 9 04:46:02.511261 containerd[1468]: time="2025-09-09T04:46:02.511241720Z" level=info msg="Start snapshots syncer" Sep 9 04:46:02.511279 containerd[1468]: time="2025-09-09T04:46:02.511268040Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 9 04:46:02.511521 containerd[1468]: time="2025-09-09T04:46:02.511482840Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 9 04:46:02.511607 containerd[1468]: time="2025-09-09T04:46:02.511539120Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 9 04:46:02.511640 containerd[1468]: time="2025-09-09T04:46:02.511620440Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.511989600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512044640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512063240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512075800Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512093560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512109440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512124360Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 9 04:46:02.512210 containerd[1468]: time="2025-09-09T04:46:02.512158280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 9 04:46:02.512404 containerd[1468]: time="2025-09-09T04:46:02.512175720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 9 04:46:02.512485 containerd[1468]: time="2025-09-09T04:46:02.512468200Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 9 04:46:02.512576 containerd[1468]: time="2025-09-09T04:46:02.512558480Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 04:46:02.512639 containerd[1468]: time="2025-09-09T04:46:02.512619840Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 04:46:02.512880 containerd[1468]: time="2025-09-09T04:46:02.512859560Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 04:46:02.512954 containerd[1468]: time="2025-09-09T04:46:02.512938360Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 04:46:02.513017 containerd[1468]: time="2025-09-09T04:46:02.513000400Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 9 04:46:02.513074 containerd[1468]: time="2025-09-09T04:46:02.513060400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 9 04:46:02.513127 containerd[1468]: time="2025-09-09T04:46:02.513115760Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 9 04:46:02.513335 containerd[1468]: time="2025-09-09T04:46:02.513321920Z" level=info msg="runtime interface created" Sep 9 04:46:02.513382 containerd[1468]: time="2025-09-09T04:46:02.513372560Z" level=info msg="created NRI interface" Sep 9 04:46:02.513442 containerd[1468]: time="2025-09-09T04:46:02.513427200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 9 04:46:02.513497 containerd[1468]: time="2025-09-09T04:46:02.513486760Z" level=info msg="Connect containerd service" Sep 9 04:46:02.513574 containerd[1468]: time="2025-09-09T04:46:02.513562280Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 04:46:02.514380 containerd[1468]: time="2025-09-09T04:46:02.514350960Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 9 04:46:02.581887 containerd[1468]: time="2025-09-09T04:46:02.581773960Z" level=info msg="Start subscribing containerd event" Sep 9 04:46:02.581887 containerd[1468]: time="2025-09-09T04:46:02.581860360Z" level=info msg="Start recovering state" Sep 9 04:46:02.581996 containerd[1468]: time="2025-09-09T04:46:02.581983240Z" level=info msg="Start event monitor" Sep 9 04:46:02.582015 containerd[1468]: time="2025-09-09T04:46:02.582002760Z" level=info msg="Start cni network conf syncer for default" Sep 9 04:46:02.582034 containerd[1468]: time="2025-09-09T04:46:02.582013480Z" level=info msg="Start streaming server" Sep 9 04:46:02.582034 containerd[1468]: time="2025-09-09T04:46:02.582023000Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 9 04:46:02.582034 containerd[1468]: time="2025-09-09T04:46:02.582029520Z" level=info msg="runtime interface starting up..." Sep 9 04:46:02.582110 containerd[1468]: time="2025-09-09T04:46:02.582036800Z" level=info msg="starting plugins..." Sep 9 04:46:02.582110 containerd[1468]: time="2025-09-09T04:46:02.582050160Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 9 04:46:02.582404 containerd[1468]: time="2025-09-09T04:46:02.582382760Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 04:46:02.582549 containerd[1468]: time="2025-09-09T04:46:02.582496440Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 04:46:02.582674 containerd[1468]: time="2025-09-09T04:46:02.582661600Z" level=info msg="containerd successfully booted in 0.088242s" Sep 9 04:46:02.582758 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 04:46:02.637815 sshd_keygen[1401]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 9 04:46:02.657144 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 9 04:46:02.659973 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 9 04:46:02.688724 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 04:46:02.688929 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 9 04:46:02.692565 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 9 04:46:02.713129 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 9 04:46:02.716322 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 9 04:46:02.718829 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 9 04:46:02.720570 systemd[1]: Reached target getty.target - Login Prompts. Sep 9 04:46:03.497358 systemd-networkd[1377]: eth0: Gained IPv6LL Sep 9 04:46:03.499830 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 9 04:46:03.501699 systemd[1]: Reached target network-online.target - Network is Online. Sep 9 04:46:03.504305 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 9 04:46:03.506531 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 9 04:46:03.542696 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 9 04:46:03.542926 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 9 04:46:03.546284 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 9 04:46:03.549625 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 9 04:46:03.550864 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 9 04:46:03.569967 (-wrapper)[1528]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 9 04:46:03.676769 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 04:46:03.699605 (dockerd)[1540]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 9 04:46:03.911780 dockerd[1540]: time="2025-09-09T04:46:03.911659149Z" level=info msg="Starting up" Sep 9 04:46:03.912521 dockerd[1540]: time="2025-09-09T04:46:03.912497655Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 9 04:46:03.923371 dockerd[1540]: time="2025-09-09T04:46:03.923315793Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 9 04:46:03.956403 dockerd[1540]: time="2025-09-09T04:46:03.956190325Z" level=info msg="Loading containers: start." Sep 9 04:46:03.965254 kernel: Initializing XFRM netlink socket Sep 9 04:46:04.184014 systemd-networkd[1377]: docker0: Link UP Sep 9 04:46:04.189216 dockerd[1540]: time="2025-09-09T04:46:04.189163243Z" level=info msg="Loading containers: done." Sep 9 04:46:04.202126 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck320401243-merged.mount: Deactivated successfully. Sep 9 04:46:04.202345 dockerd[1540]: time="2025-09-09T04:46:04.202260803Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 9 04:46:04.202955 dockerd[1540]: time="2025-09-09T04:46:04.202421733Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 9 04:46:04.202955 dockerd[1540]: time="2025-09-09T04:46:04.202523247Z" level=info msg="Initializing buildkit" Sep 9 04:46:04.228382 dockerd[1540]: time="2025-09-09T04:46:04.228331350Z" level=info msg="Completed buildkit initialization" Sep 9 04:46:04.236400 dockerd[1540]: time="2025-09-09T04:46:04.236347410Z" level=info msg="Daemon has completed initialization" Sep 9 04:46:04.236524 dockerd[1540]: time="2025-09-09T04:46:04.236427136Z" level=info msg="API listen on /run/docker.sock" Sep 9 04:46:04.236658 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 04:46:04.239088 etcd-wrapper[1532]: Error response from daemon: No such container: etcd-member Sep 9 04:46:04.250916 etcd-wrapper[1741]: Error response from daemon: No such container: etcd-member Sep 9 04:46:04.276553 etcd-wrapper[1762]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally Sep 9 04:46:04.951234 etcd-wrapper[1762]: v3.5.0: Pulling from coreos/etcd Sep 9 04:46:05.098881 etcd-wrapper[1762]: 6022c6b01d76: Pulling fs layer Sep 9 04:46:05.098881 etcd-wrapper[1762]: 1d97b1ec77fc: Pulling fs layer Sep 9 04:46:05.098881 etcd-wrapper[1762]: 99ef4b690837: Pulling fs layer Sep 9 04:46:05.098881 etcd-wrapper[1762]: 435b7bf0967c: Pulling fs layer Sep 9 04:46:05.098881 etcd-wrapper[1762]: 17e4a5f7c1b5: Pulling fs layer Sep 9 04:46:05.098881 etcd-wrapper[1762]: 5b0292999756: Pulling fs layer Sep 9 04:46:05.099116 etcd-wrapper[1762]: 435b7bf0967c: Waiting Sep 9 04:46:05.099116 etcd-wrapper[1762]: 17e4a5f7c1b5: Waiting Sep 9 04:46:05.099116 etcd-wrapper[1762]: 5b0292999756: Waiting Sep 9 04:46:05.506244 etcd-wrapper[1762]: 99ef4b690837: Verifying Checksum Sep 9 04:46:05.506244 etcd-wrapper[1762]: 99ef4b690837: Download complete Sep 9 04:46:05.695008 etcd-wrapper[1762]: 1d97b1ec77fc: Verifying Checksum Sep 9 04:46:05.695008 etcd-wrapper[1762]: 1d97b1ec77fc: Download complete Sep 9 04:46:05.703150 etcd-wrapper[1762]: 6022c6b01d76: Verifying Checksum Sep 9 04:46:05.703150 etcd-wrapper[1762]: 6022c6b01d76: Download complete Sep 9 04:46:05.918355 etcd-wrapper[1762]: 17e4a5f7c1b5: Verifying Checksum Sep 9 04:46:05.918355 etcd-wrapper[1762]: 17e4a5f7c1b5: Download complete Sep 9 04:46:05.930164 etcd-wrapper[1762]: 5b0292999756: Verifying Checksum Sep 9 04:46:05.930164 etcd-wrapper[1762]: 5b0292999756: Download complete Sep 9 04:46:05.953488 etcd-wrapper[1762]: 435b7bf0967c: Verifying Checksum Sep 9 04:46:05.953488 etcd-wrapper[1762]: 435b7bf0967c: Download complete Sep 9 04:46:06.308810 etcd-wrapper[1762]: 6022c6b01d76: Pull complete Sep 9 04:46:06.402844 systemd[1]: var-lib-docker-overlay2-a0d8fc231543ec408156e36359c70dc008edb80927acf2150513e0d9d8c2f690-merged.mount: Deactivated successfully. Sep 9 04:46:06.547671 etcd-wrapper[1762]: 1d97b1ec77fc: Pull complete Sep 9 04:46:06.622114 systemd[1]: var-lib-docker-overlay2-3e56a86e27d813810f41e40efaf8dfceb214feeb93871ed639c8acd947a7b0de-merged.mount: Deactivated successfully. Sep 9 04:46:06.645309 etcd-wrapper[1762]: 99ef4b690837: Pull complete Sep 9 04:46:06.735461 etcd-wrapper[1762]: 435b7bf0967c: Pull complete Sep 9 04:46:06.748620 etcd-wrapper[1762]: 17e4a5f7c1b5: Pull complete Sep 9 04:46:06.761908 etcd-wrapper[1762]: 5b0292999756: Pull complete Sep 9 04:46:06.768238 etcd-wrapper[1762]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b Sep 9 04:46:06.770309 etcd-wrapper[1762]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 Sep 9 04:46:06.808751 containerd[1468]: time="2025-09-09T04:46:06.808694276Z" level=info msg="connecting to shim f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999" address="unix:///run/containerd/s/1c16948dbf75968fc3515c6b93a2cc07f553760e893123f42237ed45f0125911" namespace=moby protocol=ttrpc version=3 Sep 9 04:46:06.839403 systemd[1]: Started docker-f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999.scope - libcontainer container f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999. Sep 9 04:46:06.852324 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"info","ts":1757393166.8980508,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"info","ts":1757393166.898124,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"94ecf78883324e7591b61d04b63bb2c5"} Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"warn","ts":1757393166.898154,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"warn","ts":1757393166.8981636,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"warn","ts":1757393166.8981695,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"warn","ts":1757393166.8981743,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 9 04:46:06.898440 etcd-wrapper[1762]: {"level":"warn","ts":1757393166.89822,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Sep 9 04:46:06.898830 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.898Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.10:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.10:2380","--advertise-client-urls=http://10.0.0.10:2379","--discovery=http://10.0.0.1:44257/v2/keys/discovery/4909323788467775944","--enable-v2=true"]} Sep 9 04:46:06.898830 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.898Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.10:2380"]} Sep 9 04:46:06.899018 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.898Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 9 04:46:06.899018 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.898Z","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":"94ecf78883324e7591b61d04b63bb2c5","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.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"94ecf78883324e7591b61d04b63bb2c5=http://10.0.0.10:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:44257/v2/keys/discovery/4909323788467775944","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:44257/v2/keys/discovery/4909323788467775944","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 9 04:46:06.900962 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.900Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.620973ms"} Sep 9 04:46:06.918561 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.918Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:44257","self":"884efc11bb1d5ed7"} Sep 9 04:46:06.918783 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:06.918Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:44257","found-peers":1,"needed-peers":2} Sep 9 04:46:07.304793 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.304Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:44257","peer":"d35268838b7d91b"} Sep 9 04:46:07.304793 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.304Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:44257","found-peers":2,"needed-peers":1} Sep 9 04:46:07.317763 systemd[1]: var-lib-docker-overlay2-321f7827831f48b4437a262b9afb4da43a156062611e182b45aa9415f81e5256-merged.mount: Deactivated successfully. Sep 9 04:46:07.428003 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.427Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:44257","peer":"972c040f769b6104"} Sep 9 04:46:07.428003 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.427Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:44257","found-peers":3} Sep 9 04:46:07.556735 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"884efc11bb1d5ed7","cluster-id":"dc6e0433ae64aa84"} Sep 9 04:46:07.556735 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=()"} Sep 9 04:46:07.557152 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became follower at term 0"} Sep 9 04:46:07.557152 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 884efc11bb1d5ed7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 9 04:46:07.557152 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became follower at term 1"} Sep 9 04:46:07.557152 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443)"} Sep 9 04:46:07.557152 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263)"} Sep 9 04:46:07.557152 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263 10893086063163302148)"} Sep 9 04:46:07.574058 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:07.573Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Sep 9 04:46:07.575363 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.575Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Sep 9 04:46:07.577823 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.577Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Sep 9 04:46:07.578468 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.578Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.578468 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.578Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.578725 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.578Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.579343 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.579Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.579598 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.579Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.579775 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.579Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b","remote-peer-urls":["http://10.0.0.11:2380"]} Sep 9 04:46:07.579775 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.579Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.579775 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.579Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.580201 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.580Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.580201 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.580Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104","remote-peer-urls":["http://10.0.0.9:2380"]} Sep 9 04:46:07.580201 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.580Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"884efc11bb1d5ed7","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Sep 9 04:46:07.581716 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.582254 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263 10893086063163302148)"} Sep 9 04:46:07.582433 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.582530 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.582530 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.582530 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.582728 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.581Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","added-peer-id":"d35268838b7d91b","added-peer-peer-urls":["http://10.0.0.11:2380"]} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263 10893086063163302148)"} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","added-peer-id":"884efc11bb1d5ed7","added-peer-peer-urls":["http://10.0.0.10:2380"]} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263 10893086063163302148)"} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","added-peer-id":"972c040f769b6104","added-peer-peer-urls":["http://10.0.0.9:2380"]} Sep 9 04:46:07.582886 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:07.582Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Sep 9 04:46:07.583245 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.10:2380"} Sep 9 04:46:07.583245 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.10:2380"} Sep 9 04:46:07.583245 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.582Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"884efc11bb1d5ed7","initial-advertise-peer-urls":["http://10.0.0.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 9 04:46:07.583535 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.583Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"d35268838b7d91b","stream-type":"stream Message"} Sep 9 04:46:07.583786 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.583Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d35268838b7d91b"} Sep 9 04:46:07.583786 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.583Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.584003 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.583Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"d35268838b7d91b","stream-type":"stream MsgApp v2"} Sep 9 04:46:07.584003 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.583Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.585790 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.585Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"972c040f769b6104","stream-type":"stream MsgApp v2"} Sep 9 04:46:07.585790 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.585Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"972c040f769b6104"} Sep 9 04:46:07.585790 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.585Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.585790 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.585Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"972c040f769b6104","stream-type":"stream Message"} Sep 9 04:46:07.585790 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.585Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.588923 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.588Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.589124 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.588Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:07.589353 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.589Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.589589 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.589Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:07.633557 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.633Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"884efc11bb1d5ed7","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Sep 9 04:46:07.851989 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 972c040f769b6104 [logterm: 1, index: 3] at term 1"} Sep 9 04:46:07.852820 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [term: 1] received a MsgVote message with higher term from 972c040f769b6104 [term: 2]"} Sep 9 04:46:07.852820 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became follower at term 2"} Sep 9 04:46:07.852820 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 1, index: 3, vote: 0] cast MsgVote for 972c040f769b6104 [logterm: 1, index: 3] at term 2"} Sep 9 04:46:07.853793 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 884efc11bb1d5ed7 elected leader 972c040f769b6104 at term 2"} Sep 9 04:46:07.856191 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.855Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Sep 9 04:46:07.856308 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.855Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"884efc11bb1d5ed7","local-member-attributes":"{Name:94ecf78883324e7591b61d04b63bb2c5 ClientURLs:[http://10.0.0.10:2379]}","request-path":"/0/members/884efc11bb1d5ed7/attributes","cluster-id":"dc6e0433ae64aa84","publish-timeout":"7s"} Sep 9 04:46:07.856930 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 9 04:46:07.857691 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.856Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Sep 9 04:46:07.857691 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.857Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Sep 9 04:46:07.857877 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.857Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Sep 9 04:46:07.858691 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.858Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","cluster-version":"3.5"} Sep 9 04:46:07.858804 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:07.858Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 9 04:46:07.859386 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Sep 9 04:46:07.942788 etcdctl[1866]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Sep 9 04:46:07.973804 flannel-wrapper[1875]: Error response from daemon: No such container: flannel Sep 9 04:46:07.987543 flannel-wrapper[1884]: Error response from daemon: No such container: flannel Sep 9 04:46:08.003310 flannel-wrapper[1904]: Unable to find image 'quay.io/coreos/flannel:v0.14.0-arm64' locally Sep 9 04:46:08.624397 flannel-wrapper[1904]: v0.14.0-arm64: Pulling from coreos/flannel Sep 9 04:46:08.624397 flannel-wrapper[1904]: b538f80385f9: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: 782376d11ccb: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: ab023a03e512: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: 1ce603871d35: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: 2ff40439b6d5: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: f6c30695e556: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: 071b96dd834b: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: e9e292d9edba: Pulling fs layer Sep 9 04:46:08.624397 flannel-wrapper[1904]: 2ff40439b6d5: Waiting Sep 9 04:46:08.624397 flannel-wrapper[1904]: f6c30695e556: Waiting Sep 9 04:46:08.624397 flannel-wrapper[1904]: 071b96dd834b: Waiting Sep 9 04:46:08.624397 flannel-wrapper[1904]: e9e292d9edba: Waiting Sep 9 04:46:08.624825 flannel-wrapper[1904]: 1ce603871d35: Waiting Sep 9 04:46:08.925267 flannel-wrapper[1904]: 782376d11ccb: Verifying Checksum Sep 9 04:46:08.925267 flannel-wrapper[1904]: 782376d11ccb: Download complete Sep 9 04:46:08.978268 flannel-wrapper[1904]: b538f80385f9: Verifying Checksum Sep 9 04:46:08.978268 flannel-wrapper[1904]: b538f80385f9: Download complete Sep 9 04:46:08.994398 flannel-wrapper[1904]: ab023a03e512: Verifying Checksum Sep 9 04:46:08.994398 flannel-wrapper[1904]: ab023a03e512: Download complete Sep 9 04:46:09.056760 flannel-wrapper[1904]: b538f80385f9: Pull complete Sep 9 04:46:09.091841 systemd[1]: var-lib-docker-overlay2-58142ee8748f9cdc1681ec091f160f58a4cefdf27e23d666d68c7f4231e61c10-merged.mount: Deactivated successfully. Sep 9 04:46:09.122618 flannel-wrapper[1904]: 782376d11ccb: Pull complete Sep 9 04:46:09.210752 flannel-wrapper[1904]: 1ce603871d35: Verifying Checksum Sep 9 04:46:09.210752 flannel-wrapper[1904]: 1ce603871d35: Download complete Sep 9 04:46:09.223620 flannel-wrapper[1904]: f6c30695e556: Verifying Checksum Sep 9 04:46:09.223620 flannel-wrapper[1904]: f6c30695e556: Download complete Sep 9 04:46:09.329839 systemd[1]: var-lib-docker-overlay2-82a68f24e469774f1e1257b1f7f6411dd470d12042413f8222632b55ebfc76a0-merged.mount: Deactivated successfully. Sep 9 04:46:09.377363 flannel-wrapper[1904]: ab023a03e512: Pull complete Sep 9 04:46:09.425648 flannel-wrapper[1904]: 071b96dd834b: Verifying Checksum Sep 9 04:46:09.425648 flannel-wrapper[1904]: 071b96dd834b: Download complete Sep 9 04:46:09.437494 flannel-wrapper[1904]: 1ce603871d35: Pull complete Sep 9 04:46:09.464024 flannel-wrapper[1904]: e9e292d9edba: Verifying Checksum Sep 9 04:46:09.464024 flannel-wrapper[1904]: e9e292d9edba: Download complete Sep 9 04:46:09.477032 flannel-wrapper[1904]: 2ff40439b6d5: Verifying Checksum Sep 9 04:46:09.477032 flannel-wrapper[1904]: 2ff40439b6d5: Download complete Sep 9 04:46:09.723581 flannel-wrapper[1904]: 2ff40439b6d5: Pull complete Sep 9 04:46:09.741215 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 9 04:46:09.742306 systemd[1]: Started sshd@0-10.0.0.10:22-10.0.0.1:33476.service - OpenSSH per-connection server daemon (10.0.0.1:33476). Sep 9 04:46:09.772101 flannel-wrapper[1904]: f6c30695e556: Pull complete Sep 9 04:46:09.791064 flannel-wrapper[1904]: 071b96dd834b: Pull complete Sep 9 04:46:09.808194 flannel-wrapper[1904]: e9e292d9edba: Pull complete Sep 9 04:46:09.814691 flannel-wrapper[1904]: Digest: sha256:dad4e92d4eb00d129a664ac7b44a71a5cbadea8a7f11b5b239e1e2b2701baac6 Sep 9 04:46:09.816898 flannel-wrapper[1904]: Status: Downloaded newer image for quay.io/coreos/flannel:v0.14.0-arm64 Sep 9 04:46:09.823487 sshd[1945]: Accepted publickey for core from 10.0.0.1 port 33476 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:09.826111 sshd-session[1945]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:09.832513 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 9 04:46:09.833552 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 9 04:46:09.839761 systemd-logind[1389]: New session 1 of user core. Sep 9 04:46:09.858962 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 9 04:46:09.861757 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 9 04:46:09.864948 containerd[1468]: time="2025-09-09T04:46:09.864745781Z" level=info msg="connecting to shim c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8" address="unix:///run/containerd/s/a22e4fae87bb7b3fa849fd38acadaeb70685ce9bffe822e68abb198badd7f675" namespace=moby protocol=ttrpc version=3 Sep 9 04:46:09.877278 (systemd)[1965]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 9 04:46:09.880005 systemd-logind[1389]: New session c1 of user core. Sep 9 04:46:09.881774 systemd[1]: Started docker-c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8.scope - libcontainer container c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8. Sep 9 04:46:09.901884 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 04:46:09.974418 flannel-wrapper[1904]: I0909 04:46:09.974071 1 main.go:520] Determining IP address of default interface Sep 9 04:46:09.974680 flannel-wrapper[1904]: I0909 04:46:09.974477 1 main.go:533] Using interface with name eth0 and address 10.0.0.10 Sep 9 04:46:09.974680 flannel-wrapper[1904]: I0909 04:46:09.974501 1 main.go:550] Defaulting external address to interface address (10.0.0.10) Sep 9 04:46:09.974825 flannel-wrapper[1904]: I0909 04:46:09.974708 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: None Sep 9 04:46:09.974825 flannel-wrapper[1904]: I0909 04:46:09.974740 1 main.go:257] Installing signal handlers Sep 9 04:46:09.978886 flannel-wrapper[1904]: I0909 04:46:09.978652 1 main.go:392] Found network config - Backend type: vxlan Sep 9 04:46:09.980492 flannel-wrapper[1904]: I0909 04:46:09.978877 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Sep 9 04:46:09.993810 flannel-wrapper[1904]: I0909 04:46:09.993593 1 local_manager.go:234] Picking subnet in range 10.254.1.0 ... 10.254.255.0 Sep 9 04:46:09.995980 flannel-wrapper[1904]: I0909 04:46:09.995773 1 local_manager.go:220] Allocated lease (10.254.55.0/24) to current node (10.0.0.10) Sep 9 04:46:09.996687 flannel-wrapper[1904]: I0909 04:46:09.996324 1 main.go:357] Current network or subnet (10.254.0.0/16, 10.254.55.0/24) is not equal to previous one (0.0.0.0/0, 0.0.0.0/0), trying to recycle old iptables rules Sep 9 04:46:09.996955 systemd-networkd[1377]: flannel.1: Link UP Sep 9 04:46:09.996964 systemd-networkd[1377]: flannel.1: Gained carrier Sep 9 04:46:09.999612 systemd[1965]: Queued start job for default target default.target. Sep 9 04:46:10.008246 systemd[1965]: Created slice app.slice - User Application Slice. Sep 9 04:46:10.008277 systemd[1965]: Reached target paths.target - Paths. Sep 9 04:46:10.008317 systemd[1965]: Reached target timers.target - Timers. Sep 9 04:46:10.009539 systemd[1965]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 9 04:46:10.014741 flannel-wrapper[1904]: I0909 04:46:10.014539 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Sep 9 04:46:10.016514 flannel-wrapper[1904]: I0909 04:46:10.016339 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Sep 9 04:46:10.017743 flannel-wrapper[1904]: I0909 04:46:10.017570 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Sep 9 04:46:10.018755 flannel-wrapper[1904]: I0909 04:46:10.018543 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j MASQUERADE --random-fully Sep 9 04:46:10.019832 flannel-wrapper[1904]: I0909 04:46:10.019693 1 main.go:307] Setting up masking rules Sep 9 04:46:10.020809 flannel-wrapper[1904]: I0909 04:46:10.020605 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Sep 9 04:46:10.021011 flannel-wrapper[1904]: I0909 04:46:10.020874 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Sep 9 04:46:10.021011 flannel-wrapper[1904]: I0909 04:46:10.020884 1 main.go:327] Running backend. Sep 9 04:46:10.021686 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Sep 9 04:46:10.022342 flannel-wrapper[1904]: I0909 04:46:10.021345 1 vxlan_network.go:59] watching for new subnet leases Sep 9 04:46:10.022759 systemd[1965]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 9 04:46:10.022875 systemd[1965]: Reached target sockets.target - Sockets. Sep 9 04:46:10.022913 systemd[1965]: Reached target basic.target - Basic System. Sep 9 04:46:10.022957 systemd[1965]: Reached target default.target - Main User Target. Sep 9 04:46:10.022994 systemd[1965]: Startup finished in 136ms. Sep 9 04:46:10.023047 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 9 04:46:10.025367 flannel-wrapper[1904]: I0909 04:46:10.025148 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Sep 9 04:46:10.025367 flannel-wrapper[1904]: I0909 04:46:10.025186 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Sep 9 04:46:10.027387 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Sep 9 04:46:10.027609 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 9 04:46:10.030319 flannel-wrapper[1904]: I0909 04:46:10.026473 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Sep 9 04:46:10.030319 flannel-wrapper[1904]: I0909 04:46:10.029202 1 main.go:439] Waiting for 22h59m59.964930874s to renew lease Sep 9 04:46:10.030616 flannel-wrapper[1904]: I0909 04:46:10.030425 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Sep 9 04:46:10.030616 flannel-wrapper[1904]: I0909 04:46:10.030439 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -j ACCEPT Sep 9 04:46:10.031507 flannel-wrapper[1904]: I0909 04:46:10.031355 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.55.0/24 -j RETURN Sep 9 04:46:10.032533 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 9 04:46:10.033461 flannel-wrapper[1904]: I0909 04:46:10.031671 1 iptables.go:172] Deleting iptables rule: -d 10.254.0.0/16 -j ACCEPT Sep 9 04:46:10.033461 flannel-wrapper[1904]: I0909 04:46:10.032742 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Sep 9 04:46:10.035000 flannel-wrapper[1904]: I0909 04:46:10.034140 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Sep 9 04:46:10.036282 flannel-wrapper[1904]: I0909 04:46:10.036066 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -j ACCEPT Sep 9 04:46:10.036369 flannel-wrapper[1904]: I0909 04:46:10.036226 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Sep 9 04:46:10.036761 sh[2060]: + for try in 1 2 3 4 5 6 Sep 9 04:46:10.037036 sh[2060]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Sep 9 04:46:10.038584 flannel-wrapper[1904]: I0909 04:46:10.038321 1 iptables.go:160] Adding iptables rule: -d 10.254.0.0/16 -j ACCEPT Sep 9 04:46:10.039842 flannel-wrapper[1904]: I0909 04:46:10.039700 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.55.0/24 -j RETURN Sep 9 04:46:10.041936 flannel-wrapper[1904]: I0909 04:46:10.041780 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Sep 9 04:46:10.055154 sh[2081]: Error response from daemon: No such container: flannel-docker-opts Sep 9 04:46:10.066170 systemd[1]: var-lib-docker-overlay2-b5ba127164ab0f9a9331a677c1ff6079fbb5ae530ecf7c46713bb89202cc575f-merged.mount: Deactivated successfully. Sep 9 04:46:10.073567 sh[2090]: Error response from daemon: No such container: flannel-docker-opts Sep 9 04:46:10.098682 systemd[1]: Started sshd@1-10.0.0.10:22-10.0.0.1:34632.service - OpenSSH per-connection server daemon (10.0.0.1:34632). Sep 9 04:46:10.105652 systemd[1]: var-lib-docker-overlay2-37d927b10a82149214a7cca9e8c22acb6273826026d2b6377603d3a686d3f795\x2dinit-merged.mount: Deactivated successfully. Sep 9 04:46:10.149817 containerd[1468]: time="2025-09-09T04:46:10.149766919Z" level=info msg="connecting to shim 9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b" address="unix:///run/containerd/s/1114bd45642857c298447662e5faffddfcaf4cafcc92938bed7ca855134ecee5" namespace=moby protocol=ttrpc version=3 Sep 9 04:46:10.166088 sshd[2113]: Accepted publickey for core from 10.0.0.1 port 34632 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:10.167547 sshd-session[2113]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:10.179472 systemd[1]: Started docker-9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b.scope - libcontainer container 9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b. Sep 9 04:46:10.184752 systemd-logind[1389]: New session 2 of user core. Sep 9 04:46:10.185442 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 9 04:46:10.197631 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 04:46:10.224303 systemd[1]: docker-9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b.scope: Deactivated successfully. Sep 9 04:46:10.239416 sshd[2155]: Connection closed by 10.0.0.1 port 34632 Sep 9 04:46:10.241162 sshd-session[2113]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:10.243926 containerd[1468]: time="2025-09-09T04:46:10.243865398Z" level=info msg="shim disconnected" id=9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b namespace=moby Sep 9 04:46:10.244010 containerd[1468]: time="2025-09-09T04:46:10.243895139Z" level=warning msg="cleaning up after shim disconnected" id=9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b namespace=moby Sep 9 04:46:10.244010 containerd[1468]: time="2025-09-09T04:46:10.243988326Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 04:46:10.244256 dockerd[1540]: time="2025-09-09T04:46:10.244043154Z" level=info msg="ignoring event" container=9f9285691ebb567e96bb3808332db6f1cc6d4fa645df3e096b081f6f5f0fd12b module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 9 04:46:10.247693 systemd[1]: sshd@1-10.0.0.10:22-10.0.0.1:34632.service: Deactivated successfully. Sep 9 04:46:10.249262 systemd[1]: session-2.scope: Deactivated successfully. Sep 9 04:46:10.250785 systemd-logind[1389]: Session 2 logged out. Waiting for processes to exit. Sep 9 04:46:10.252522 systemd[1]: Started sshd@2-10.0.0.10:22-10.0.0.1:34636.service - OpenSSH per-connection server daemon (10.0.0.1:34636). Sep 9 04:46:10.256240 systemd-logind[1389]: Removed session 2. Sep 9 04:46:10.259400 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [term 2] received MsgTimeoutNow from 972c040f769b6104 and starts an election to get leadership."} Sep 9 04:46:10.259400 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 is starting a new election at term 2"} Sep 9 04:46:10.259772 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became candidate at term 3"} Sep 9 04:46:10.259772 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 received MsgVoteResp from 884efc11bb1d5ed7 at term 3"} Sep 9 04:46:10.259772 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 2, index: 28] sent MsgVote request to d35268838b7d91b at term 3"} Sep 9 04:46:10.259772 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 2, index: 28] sent MsgVote request to 972c040f769b6104 at term 3"} Sep 9 04:46:10.259772 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 884efc11bb1d5ed7 lost leader 972c040f769b6104 at term 3"} Sep 9 04:46:10.262231 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 received MsgVoteResp from 972c040f769b6104 at term 3"} Sep 9 04:46:10.262231 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 has received 2 MsgVoteResp votes and 0 vote rejections"} Sep 9 04:46:10.262231 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became leader at term 3"} Sep 9 04:46:10.262555 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 884efc11bb1d5ed7 elected leader 884efc11bb1d5ed7 at term 3"} Sep 9 04:46:10.283024 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 04:46:10.284288 dockerd[1540]: time="2025-09-09T04:46:10.282986064Z" level=info msg="Processing signal 'terminated'" Sep 9 04:46:10.290651 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.290Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} Sep 9 04:46:10.290651 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.290Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"94ecf78883324e7591b61d04b63bb2c5","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"]} Sep 9 04:46:10.291732 flannel-wrapper[1904]: I0909 04:46:10.291466 1 main.go:376] shutdownHandler sent cancel signal... Sep 9 04:46:10.292454 flannel-wrapper[1904]: I0909 04:46:10.291710 1 watch.go:174] context canceled, close receiver chan Sep 9 04:46:10.292454 flannel-wrapper[1904]: I0909 04:46:10.291843 1 main.go:432] Stopped monitoring lease Sep 9 04:46:10.292454 flannel-wrapper[1904]: I0909 04:46:10.291851 1 main.go:345] Waiting for all goroutines to exit Sep 9 04:46:10.292454 flannel-wrapper[1904]: I0909 04:46:10.292126 1 watch.go:40] context canceled, close receiver chan Sep 9 04:46:10.292454 flannel-wrapper[1904]: I0909 04:46:10.292141 1 vxlan_network.go:74] evts chan closed Sep 9 04:46:10.292454 flannel-wrapper[1904]: I0909 04:46:10.292151 1 main.go:348] Exiting cleanly... Sep 9 04:46:10.294425 systemd[1]: docker-c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8.scope: Deactivated successfully. Sep 9 04:46:10.295341 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.294Z","caller":"etcdserver/server.go:1398","msg":"leadership transfer starting","local-member-id":"884efc11bb1d5ed7","current-leader-member-id":"884efc11bb1d5ed7","transferee-member-id":"d35268838b7d91b"} Sep 9 04:46:10.295620 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [term 3] starts to transfer leadership to d35268838b7d91b"} Sep 9 04:46:10.295620 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 sends MsgTimeoutNow to d35268838b7d91b immediately as d35268838b7d91b already has up-to-date log"} Sep 9 04:46:10.295955 etcd-wrapper[1762]: WARNING: 2025/09/09 04:46:10 [core] grpc: addrConn.createTransport failed to connect to {0.0.0.0:2379 0.0.0.0:2379 0 }. Err: connection error: desc = "transport: Error while dialing dial tcp 0.0.0.0:2379: connect: connection refused". Reconnecting... Sep 9 04:46:10.300500 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.300Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [term: 3] received a MsgVote message with higher term from d35268838b7d91b [term: 4]"} Sep 9 04:46:10.300878 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.300Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became follower at term 4"} Sep 9 04:46:10.301202 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.300Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 3, index: 32, vote: 0] cast MsgVote for d35268838b7d91b [logterm: 3, index: 32] at term 4"} Sep 9 04:46:10.302250 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 884efc11bb1d5ed7 lost leader 884efc11bb1d5ed7 at term 4"} Sep 9 04:46:10.304641 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 884efc11bb1d5ed7 elected leader d35268838b7d91b at term 4"} Sep 9 04:46:10.311558 dockerd[1540]: time="2025-09-09T04:46:10.311514232Z" level=info msg="ignoring event" container=c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 9 04:46:10.311814 containerd[1468]: time="2025-09-09T04:46:10.311716184Z" level=info msg="shim disconnected" id=c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8 namespace=moby Sep 9 04:46:10.311814 containerd[1468]: time="2025-09-09T04:46:10.311754422Z" level=warning msg="cleaning up after shim disconnected" id=c1aad8f85b0f2df1386e0e54a0ea340c8ee7ba88518c06a995f92aa2a57fb4e8 namespace=moby Sep 9 04:46:10.311814 containerd[1468]: time="2025-09-09T04:46:10.311787643Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 04:46:10.318643 sshd[2199]: Accepted publickey for core from 10.0.0.1 port 34636 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:10.320032 sshd-session[2199]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:10.330946 systemd-logind[1389]: New session 3 of user core. Sep 9 04:46:10.336415 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 9 04:46:10.389176 sshd[2242]: Connection closed by 10.0.0.1 port 34636 Sep 9 04:46:10.389573 sshd-session[2199]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:10.392360 systemd[1]: sshd@2-10.0.0.10:22-10.0.0.1:34636.service: Deactivated successfully. Sep 9 04:46:10.394102 systemd[1]: session-3.scope: Deactivated successfully. Sep 9 04:46:10.396900 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.396Z","caller":"etcdserver/server.go:1415","msg":"leadership transfer finished","local-member-id":"884efc11bb1d5ed7","old-leader-member-id":"884efc11bb1d5ed7","new-leader-member-id":"d35268838b7d91b","took":"102.265564ms"} Sep 9 04:46:10.396900 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.396Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.398033 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.397Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.398305 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.397Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.398665 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.398Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.398648 systemd-logind[1389]: Session 3 logged out. Waiting for processes to exit. Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.398Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.398Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b","error":"context canceled"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"d35268838b7d91b","error":"failed to read d35268838b7d91b on stream MsgApp v2 (context canceled)"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b","error":"context canceled"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:10.399705 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.400335 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.400335 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.399Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.401317 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.400Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.401317 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.400Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.401317 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.400Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.401317 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.400Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104","error":"context canceled"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"972c040f769b6104","error":"failed to read 972c040f769b6104 on stream MsgApp v2 (context canceled)"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104","error":"context canceled"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"884efc11bb1d5ed7","remote-peer-id-stream-handler":"884efc11bb1d5ed7","remote-peer-id-from":"972c040f769b6104","cluster-id":"dc6e0433ae64aa84"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"884efc11bb1d5ed7","remote-peer-id-stream-handler":"884efc11bb1d5ed7","remote-peer-id-from":"d35268838b7d91b","cluster-id":"dc6e0433ae64aa84"} Sep 9 04:46:10.402407 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"884efc11bb1d5ed7","remote-peer-id-stream-handler":"884efc11bb1d5ed7","remote-peer-id-from":"d35268838b7d91b","cluster-id":"dc6e0433ae64aa84"} Sep 9 04:46:10.401850 systemd-logind[1389]: Removed session 3. Sep 9 04:46:10.402755 etcd-wrapper[1762]: {"level":"warn","ts":"2025-09-09T04:46:10.401Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"884efc11bb1d5ed7","remote-peer-id-stream-handler":"884efc11bb1d5ed7","remote-peer-id-from":"972c040f769b6104","cluster-id":"dc6e0433ae64aa84"} Sep 9 04:46:10.403179 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.402Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"10.0.0.10:2380"} Sep 9 04:46:10.670729 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.670Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"10.0.0.10:2380"} Sep 9 04:46:10.670729 etcd-wrapper[1762]: {"level":"info","ts":"2025-09-09T04:46:10.670Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"94ecf78883324e7591b61d04b63bb2c5","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"]} Sep 9 04:46:10.672347 systemd[1]: docker-f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999.scope: Deactivated successfully. Sep 9 04:46:10.685592 dockerd[1540]: time="2025-09-09T04:46:10.685530521Z" level=info msg="ignoring event" container=f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 9 04:46:10.685726 containerd[1468]: time="2025-09-09T04:46:10.685685415Z" level=info msg="shim disconnected" id=f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999 namespace=moby Sep 9 04:46:10.685774 containerd[1468]: time="2025-09-09T04:46:10.685723208Z" level=warning msg="cleaning up after shim disconnected" id=f8edae142036f1c362e5e99d02b49f5d03585b7bd63622edb8a30e679f683999 namespace=moby Sep 9 04:46:10.685774 containerd[1468]: time="2025-09-09T04:46:10.685753394Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 04:46:10.709328 dockerd[1540]: time="2025-09-09T04:46:10.709281908Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Sep 9 04:46:10.710213 dockerd[1540]: time="2025-09-09T04:46:10.710114806Z" level=info msg="Daemon shutdown complete" Sep 9 04:46:10.710337 dockerd[1540]: time="2025-09-09T04:46:10.710227577Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Sep 9 04:46:10.821263 systemd[1]: docker.service: Deactivated successfully. Sep 9 04:46:10.821602 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 04:46:10.821667 systemd[1]: docker.service: Consumed 3.160s CPU time, 329.7M memory peak. Sep 9 04:46:10.822432 systemd[1]: docker.socket: Deactivated successfully. Sep 9 04:46:10.823515 docker[2244]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? Sep 9 04:46:10.823822 docker[2281]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? Sep 9 04:46:10.823557 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 04:46:10.823609 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 04:46:10.825098 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 04:46:10.826548 systemd[1]: flanneld.service: Control process exited, code=exited, status=1/FAILURE Sep 9 04:46:10.834996 systemd[1]: etcd-member.service: Control process exited, code=exited, status=1/FAILURE Sep 9 04:46:10.836278 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 04:46:10.838545 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 04:46:10.843031 (dockerd)[2297]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS Sep 9 04:46:10.870011 dockerd[2297]: time="2025-09-09T04:46:10.869829846Z" level=info msg="Starting up" Sep 9 04:46:10.871414 dockerd[2297]: time="2025-09-09T04:46:10.871234411Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 9 04:46:10.881606 dockerd[2297]: time="2025-09-09T04:46:10.881552163Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 9 04:46:10.895259 dockerd[2297]: time="2025-09-09T04:46:10.895215265Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 04:46:10.904242 dockerd[2297]: time="2025-09-09T04:46:10.904179801Z" level=info msg="Loading containers: start." Sep 9 04:46:11.064493 systemd[1]: var-lib-docker-overlay2-9e93cf5ca13248939a30bc8e346c7f5f6b545c53d7d687531e0a1d4819345464-merged.mount: Deactivated successfully. Sep 9 04:46:11.064605 systemd[1]: var-lib-docker-overlay2-f70f86ad745f6404a38118b647190ff6ab14b894011aaa3ccb0ec9d3d9997b90-merged.mount: Deactivated successfully. Sep 9 04:46:11.303362 systemd-networkd[1377]: flannel.1: Gained IPv6LL Sep 9 04:46:11.552522 dockerd[2297]: time="2025-09-09T04:46:11.552231654Z" level=info msg="Loading containers: done." Sep 9 04:46:11.562203 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck599717714-merged.mount: Deactivated successfully. Sep 9 04:46:11.569689 dockerd[2297]: time="2025-09-09T04:46:11.569628702Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 9 04:46:11.569809 dockerd[2297]: time="2025-09-09T04:46:11.569734685Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 9 04:46:11.569809 dockerd[2297]: time="2025-09-09T04:46:11.569777111Z" level=info msg="Initializing buildkit" Sep 9 04:46:11.584444 dockerd[2297]: time="2025-09-09T04:46:11.584407558Z" level=info msg="Completed buildkit initialization" Sep 9 04:46:11.590763 dockerd[2297]: time="2025-09-09T04:46:11.590719211Z" level=info msg="Daemon has completed initialization" Sep 9 04:46:11.590964 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 04:46:11.591834 dockerd[2297]: time="2025-09-09T04:46:11.591642314Z" level=info msg="API listen on /run/docker.sock" Sep 9 04:46:11.591898 sh[2072]: Restarted Docker to apply Flannel options Sep 9 04:46:11.592688 sh[2060]: + break Sep 9 04:46:11.592688 sh[2060]: + '[' 1 '!=' fail ']' Sep 9 04:46:11.595243 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Sep 9 04:46:11.598459 systemd[1]: Startup finished in 2.047s (kernel) + 3.917s (initrd) + 11.129s (userspace) = 17.094s. Sep 9 04:46:11.606814 docker[2293]: flannel Sep 9 04:46:11.608043 docker[2295]: etcd-member Sep 9 04:46:11.609535 systemd[1]: flanneld.service: Failed with result 'exit-code'. Sep 9 04:46:11.610598 systemd[1]: etcd-member.service: Failed with result 'exit-code'. Sep 9 04:46:20.477540 systemd[1]: Started sshd@3-10.0.0.10:22-10.0.0.1:53082.service - OpenSSH per-connection server daemon (10.0.0.1:53082). Sep 9 04:46:20.545551 sshd[2546]: Accepted publickey for core from 10.0.0.1 port 53082 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:20.546768 sshd-session[2546]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:20.550382 systemd-logind[1389]: New session 4 of user core. Sep 9 04:46:20.559335 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 9 04:46:20.611495 sshd[2549]: Connection closed by 10.0.0.1 port 53082 Sep 9 04:46:20.611919 sshd-session[2546]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:20.624097 systemd[1]: sshd@3-10.0.0.10:22-10.0.0.1:53082.service: Deactivated successfully. Sep 9 04:46:20.626481 systemd[1]: session-4.scope: Deactivated successfully. Sep 9 04:46:20.627681 systemd-logind[1389]: Session 4 logged out. Waiting for processes to exit. Sep 9 04:46:20.629725 systemd[1]: Started sshd@4-10.0.0.10:22-10.0.0.1:53084.service - OpenSSH per-connection server daemon (10.0.0.1:53084). Sep 9 04:46:20.630129 systemd-logind[1389]: Removed session 4. Sep 9 04:46:20.684622 sshd[2555]: Accepted publickey for core from 10.0.0.1 port 53084 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:20.685869 sshd-session[2555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:20.690247 systemd-logind[1389]: New session 5 of user core. Sep 9 04:46:20.701339 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 9 04:46:20.748432 sshd[2558]: Connection closed by 10.0.0.1 port 53084 Sep 9 04:46:20.748608 sshd-session[2555]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:20.771142 systemd[1]: sshd@4-10.0.0.10:22-10.0.0.1:53084.service: Deactivated successfully. Sep 9 04:46:20.774503 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 04:46:20.775799 systemd-logind[1389]: Session 5 logged out. Waiting for processes to exit. Sep 9 04:46:20.777022 systemd[1]: Started sshd@5-10.0.0.10:22-10.0.0.1:53094.service - OpenSSH per-connection server daemon (10.0.0.1:53094). Sep 9 04:46:20.777714 systemd-logind[1389]: Removed session 5. Sep 9 04:46:20.834161 sshd[2564]: Accepted publickey for core from 10.0.0.1 port 53094 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:20.835479 sshd-session[2564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:20.839083 systemd-logind[1389]: New session 6 of user core. Sep 9 04:46:20.851344 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 9 04:46:20.902887 sshd[2568]: Connection closed by 10.0.0.1 port 53094 Sep 9 04:46:20.902758 sshd-session[2564]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:20.915179 systemd[1]: sshd@5-10.0.0.10:22-10.0.0.1:53094.service: Deactivated successfully. Sep 9 04:46:20.917527 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 04:46:20.918219 systemd-logind[1389]: Session 6 logged out. Waiting for processes to exit. Sep 9 04:46:20.920350 systemd[1]: Started sshd@6-10.0.0.10:22-10.0.0.1:53102.service - OpenSSH per-connection server daemon (10.0.0.1:53102). Sep 9 04:46:20.920791 systemd-logind[1389]: Removed session 6. Sep 9 04:46:20.973013 sshd[2574]: Accepted publickey for core from 10.0.0.1 port 53102 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:20.974377 sshd-session[2574]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:20.979931 systemd-logind[1389]: New session 7 of user core. Sep 9 04:46:20.987364 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 9 04:46:21.043821 sudo[2578]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 04:46:21.044119 sudo[2578]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 04:46:21.062077 sudo[2578]: pam_unix(sudo:session): session closed for user root Sep 9 04:46:21.063618 sshd[2577]: Connection closed by 10.0.0.1 port 53102 Sep 9 04:46:21.063984 sshd-session[2574]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:21.076254 systemd[1]: sshd@6-10.0.0.10:22-10.0.0.1:53102.service: Deactivated successfully. Sep 9 04:46:21.078587 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 04:46:21.079316 systemd-logind[1389]: Session 7 logged out. Waiting for processes to exit. Sep 9 04:46:21.081666 systemd[1]: Started sshd@7-10.0.0.10:22-10.0.0.1:53112.service - OpenSSH per-connection server daemon (10.0.0.1:53112). Sep 9 04:46:21.082201 systemd-logind[1389]: Removed session 7. Sep 9 04:46:21.138211 sshd[2584]: Accepted publickey for core from 10.0.0.1 port 53112 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:21.142803 sshd-session[2584]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:21.147267 systemd-logind[1389]: New session 8 of user core. Sep 9 04:46:21.157383 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 9 04:46:21.208051 sudo[2589]: 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 Sep 9 04:46:21.208669 sudo[2589]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 04:46:21.213546 sudo[2589]: pam_unix(sudo:session): session closed for user root Sep 9 04:46:21.218116 sudo[2588]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 9 04:46:21.218394 sudo[2588]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 04:46:21.226539 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 04:46:21.266993 augenrules[2611]: No rules Sep 9 04:46:21.268434 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 04:46:21.268721 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 04:46:21.270011 sudo[2588]: pam_unix(sudo:session): session closed for user root Sep 9 04:46:21.271185 sshd[2587]: Connection closed by 10.0.0.1 port 53112 Sep 9 04:46:21.271575 sshd-session[2584]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:21.275022 systemd[1]: sshd@7-10.0.0.10:22-10.0.0.1:53112.service: Deactivated successfully. Sep 9 04:46:21.276798 systemd[1]: session-8.scope: Deactivated successfully. Sep 9 04:46:21.277566 systemd-logind[1389]: Session 8 logged out. Waiting for processes to exit. Sep 9 04:46:21.278830 systemd-logind[1389]: Removed session 8. Sep 9 04:46:21.361131 systemd[1]: Started sshd@8-10.0.0.10:22-10.0.0.1:53114.service - OpenSSH per-connection server daemon (10.0.0.1:53114). Sep 9 04:46:21.407282 sshd[2620]: Accepted publickey for core from 10.0.0.1 port 53114 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:21.408504 sshd-session[2620]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:21.412287 systemd-logind[1389]: New session 9 of user core. Sep 9 04:46:21.419386 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 9 04:46:21.860250 systemd[1]: flanneld.service: Scheduled restart job, restart counter is at 1. Sep 9 04:46:21.860864 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. Sep 9 04:46:21.862325 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 9 04:46:21.863264 systemd[1]: Stopping flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Sep 9 04:46:21.906527 docker[2633]: flannel-docker-opts Sep 9 04:46:21.912310 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 9 04:46:21.912657 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 9 04:46:21.931879 docker[2647]: flannel-docker-opts Sep 9 04:46:21.933856 systemd[1]: flannel-docker-opts.service: Deactivated successfully. Sep 9 04:46:21.934162 systemd[1]: Stopped flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Sep 9 04:46:21.934805 systemd[1]: Stopped flanneld.service - flannel - Network fabric for containers (System Application Container). Sep 9 04:46:21.937552 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 9 04:46:21.956554 (-wrapper)[2658]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 9 04:46:21.975450 etcd-wrapper[2662]: Error response from daemon: No such container: etcd-member Sep 9 04:46:21.987961 etcd-wrapper[2672]: Error response from daemon: No such container: etcd-member Sep 9 04:46:22.018132 systemd[1]: var-lib-docker-overlay2-4eeb2ad5e33652ec88a70e8ec7ec504bd7bc0c8103b122d1044ccedfa96fdd86\x2dinit-merged.mount: Deactivated successfully. Sep 9 04:46:22.064213 containerd[1468]: time="2025-09-09T04:46:22.063329509Z" level=info msg="connecting to shim 82ee532c9846775b2c206d9f7042f7c36d5d7bdd1dde7dcdf111f4d3616fbeb7" address="unix:///run/containerd/s/f4bc59918c263d3f0ce221126ebf873843116bb4de6a613b3bf0fe22a1c2675d" namespace=moby protocol=ttrpc version=3 Sep 9 04:46:22.084402 systemd[1]: Started docker-82ee532c9846775b2c206d9f7042f7c36d5d7bdd1dde7dcdf111f4d3616fbeb7.scope - libcontainer container 82ee532c9846775b2c206d9f7042f7c36d5d7bdd1dde7dcdf111f4d3616fbeb7. Sep 9 04:46:22.094755 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"info","ts":1757393182.4194806,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"info","ts":1757393182.4195545,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"94ecf78883324e7591b61d04b63bb2c5"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"warn","ts":1757393182.4195812,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"warn","ts":1757393182.4195912,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"warn","ts":1757393182.4195971,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"warn","ts":1757393182.419604,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"warn","ts":1757393182.4196098,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.419Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.10:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.10:2380","--advertise-client-urls=http://10.0.0.10:2379","--discovery=http://10.0.0.1:44257/v2/keys/discovery/4909323788467775944","--enable-v2=true"]} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.419Z","caller":"etcdmain/etcd.go:115","msg":"server has been already initialized","data-dir":"/var/lib/etcd","dir-type":"member"} Sep 9 04:46:22.420204 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.419Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.10:2380"]} Sep 9 04:46:22.420867 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.419Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 9 04:46:22.420867 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.420Z","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":true,"name":"94ecf78883324e7591b61d04b63bb2c5","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.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"","initial-cluster-state":"new","initial-cluster-token":"","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:44257/v2/keys/discovery/4909323788467775944","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 9 04:46:22.420867 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.420Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"154.961µs"} Sep 9 04:46:22.421076 etcd-wrapper[2694]: {"level":"warn","ts":"2025-09-09T04:46:22.420Z","caller":"etcdserver/server.go:480","msg":"discovery token is ignored since cluster already initialized; valid logs are found","wal-dir":"/var/lib/etcd/member/wal"} Sep 9 04:46:22.421076 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.420Z","caller":"etcdserver/server.go:526","msg":"No snapshot found. Recovering WAL from scratch!"} Sep 9 04:46:22.422154 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.421Z","caller":"etcdserver/raft.go:483","msg":"restarting local member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","commit-index":34} Sep 9 04:46:22.422154 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=()"} Sep 9 04:46:22.422154 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became follower at term 4"} Sep 9 04:46:22.422154 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 884efc11bb1d5ed7 [peers: [], term: 4, commit: 34, applied: 0, lastindex: 34, lastterm: 4]"} Sep 9 04:46:22.422445 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 9 04:46:22.422445 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","recovered-remote-peer-id":"972c040f769b6104","recovered-remote-peer-urls":["http://10.0.0.9:2380"]} Sep 9 04:46:22.422445 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","recovered-remote-peer-id":"d35268838b7d91b","recovered-remote-peer-urls":["http://10.0.0.11:2380"]} Sep 9 04:46:22.422445 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","recovered-remote-peer-id":"884efc11bb1d5ed7","recovered-remote-peer-urls":["http://10.0.0.10:2380"]} Sep 9 04:46:22.422445 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.422Z","caller":"membership/cluster.go:285","msg":"set cluster version from store","cluster-version":"3.5"} Sep 9 04:46:22.473809 etcd-wrapper[2694]: {"level":"warn","ts":"2025-09-09T04:46:22.473Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Sep 9 04:46:22.507305 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.507Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Sep 9 04:46:22.508138 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.507Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Sep 9 04:46:22.508361 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.508Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.508496 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.508Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.509300 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.508Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.509935 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.509935 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.510167 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b","remote-peer-urls":["http://10.0.0.11:2380"]} Sep 9 04:46:22.510167 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.510167 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.510515 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.510515 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.509Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.511249 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.510Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.511249 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.510Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.511366 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.511366 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.511366 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104","remote-peer-urls":["http://10.0.0.9:2380"]} Sep 9 04:46:22.511366 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"etcdserver/server.go:834","msg":"starting etcd server","local-member-id":"884efc11bb1d5ed7","local-server-version":"3.5.0","cluster-id":"dc6e0433ae64aa84","cluster-version":"3.5"} Sep 9 04:46:22.511366 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:22.511488 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Sep 9 04:46:22.511772 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443)"} Sep 9 04:46:22.512343 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","added-peer-id":"d35268838b7d91b","added-peer-peer-urls":["http://10.0.0.11:2380"]} Sep 9 04:46:22.512343 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263)"} Sep 9 04:46:22.512343 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","added-peer-id":"884efc11bb1d5ed7","added-peer-peer-urls":["http://10.0.0.10:2380"]} Sep 9 04:46:22.512343 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 switched to configuration voters=(951709262767708443 9822064990425538263 10893086063163302148)"} Sep 9 04:46:22.512343 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.511Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","added-peer-id":"972c040f769b6104","added-peer-peer-urls":["http://10.0.0.9:2380"]} Sep 9 04:46:22.512343 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.512Z","caller":"membership/cluster.go:523","msg":"updated cluster version","cluster-id":"dc6e0433ae64aa84","local-member-id":"884efc11bb1d5ed7","from":"3.5","to":"3.5"} Sep 9 04:46:22.512741 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.512Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d35268838b7d91b"} Sep 9 04:46:22.512741 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.512Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.513085 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.512Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.515226 etcd-wrapper[2694]: {"level":"warn","ts":"2025-09-09T04:46:22.514Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Sep 9 04:46:22.515226 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.514Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"884efc11bb1d5ed7","initial-advertise-peer-urls":["http://10.0.0.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 9 04:46:22.515226 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.514Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.10:2380"} Sep 9 04:46:22.515226 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.514Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.10:2380"} Sep 9 04:46:22.515502 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.515Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"d35268838b7d91b","stream-type":"stream MsgApp v2"} Sep 9 04:46:22.515502 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.515Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:22.515502 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.515Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"d35268838b7d91b","stream-type":"stream Message"} Sep 9 04:46:22.515502 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:22.515Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"d35268838b7d91b"} Sep 9 04:46:23.844411 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 4, index: 34, vote: d35268838b7d91b] cast MsgPreVote for d35268838b7d91b [logterm: 5, index: 36] at term 4"} Sep 9 04:46:23.848513 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [term: 4] received a MsgVote message with higher term from d35268838b7d91b [term: 6]"} Sep 9 04:46:23.848513 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 became follower at term 6"} Sep 9 04:46:23.848513 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"884efc11bb1d5ed7 [logterm: 4, index: 34, vote: 0] cast MsgVote for d35268838b7d91b [logterm: 5, index: 36] at term 6"} Sep 9 04:46:23.849727 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 884efc11bb1d5ed7 elected leader d35268838b7d91b at term 6"} Sep 9 04:46:23.852196 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.851Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"884efc11bb1d5ed7","local-member-attributes":"{Name:94ecf78883324e7591b61d04b63bb2c5 ClientURLs:[http://10.0.0.10:2379]}","request-path":"/0/members/884efc11bb1d5ed7/attributes","cluster-id":"dc6e0433ae64aa84","publish-timeout":"7s"} Sep 9 04:46:23.852196 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.851Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Sep 9 04:46:23.852462 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.852Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Sep 9 04:46:23.852582 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 9 04:46:23.854283 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.852Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Sep 9 04:46:23.854283 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:23.852Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Sep 9 04:46:23.854463 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Sep 9 04:46:23.887233 etcdctl[2757]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Sep 9 04:46:23.922819 flannel-wrapper[2766]: Error response from daemon: No such container: flannel Sep 9 04:46:23.934338 flannel-wrapper[2774]: Error response from daemon: No such container: flannel Sep 9 04:46:23.960976 systemd[1]: var-lib-docker-overlay2-c76c46300de0b4ff7094a031b3337d10e380eb1104910e22ec8eb0679e5ae47e\x2dinit-merged.mount: Deactivated successfully. Sep 9 04:46:23.974389 systemd[1]: var-lib-docker-overlay2-c76c46300de0b4ff7094a031b3337d10e380eb1104910e22ec8eb0679e5ae47e-merged.mount: Deactivated successfully. Sep 9 04:46:24.005334 containerd[1468]: time="2025-09-09T04:46:24.005288411Z" level=info msg="connecting to shim 5d4a655bb9adafa95ab41f56a579e0dea5dd7aaf18977725a34711db63db7f83" address="unix:///run/containerd/s/899acf4cabca6ea6c7fca0534b37a3dfb1cdec0dfd4f47e01c5b79841f1a44b8" namespace=moby protocol=ttrpc version=3 Sep 9 04:46:24.037353 systemd[1]: Started docker-5d4a655bb9adafa95ab41f56a579e0dea5dd7aaf18977725a34711db63db7f83.scope - libcontainer container 5d4a655bb9adafa95ab41f56a579e0dea5dd7aaf18977725a34711db63db7f83. Sep 9 04:46:24.052005 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 04:46:24.085036 flannel-wrapper[2794]: I0909 04:46:24.084676 1 main.go:520] Determining IP address of default interface Sep 9 04:46:24.085502 flannel-wrapper[2794]: I0909 04:46:24.085053 1 main.go:533] Using interface with name eth0 and address 10.0.0.10 Sep 9 04:46:24.085502 flannel-wrapper[2794]: I0909 04:46:24.085069 1 main.go:550] Defaulting external address to interface address (10.0.0.10) Sep 9 04:46:24.085502 flannel-wrapper[2794]: I0909 04:46:24.085194 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: 10.254.55.0/24 Sep 9 04:46:24.085502 flannel-wrapper[2794]: I0909 04:46:24.085203 1 main.go:257] Installing signal handlers Sep 9 04:46:24.088042 flannel-wrapper[2794]: I0909 04:46:24.087896 1 main.go:392] Found network config - Backend type: vxlan Sep 9 04:46:24.088042 flannel-wrapper[2794]: I0909 04:46:24.087981 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Sep 9 04:46:24.097282 flannel-wrapper[2794]: I0909 04:46:24.096567 1 local_manager.go:147] Found lease (10.254.55.0/24) for current IP (10.0.0.10), reusing Sep 9 04:46:24.102513 flannel-wrapper[2794]: I0909 04:46:24.102333 1 main.go:307] Setting up masking rules Sep 9 04:46:24.114811 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Sep 9 04:46:24.115622 flannel-wrapper[2794]: I0909 04:46:24.114416 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Sep 9 04:46:24.115622 flannel-wrapper[2794]: I0909 04:46:24.114558 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Sep 9 04:46:24.115622 flannel-wrapper[2794]: I0909 04:46:24.114565 1 main.go:327] Running backend. Sep 9 04:46:24.116568 flannel-wrapper[2794]: I0909 04:46:24.115994 1 vxlan_network.go:59] watching for new subnet leases Sep 9 04:46:24.116856 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Sep 9 04:46:24.119659 flannel-wrapper[2794]: I0909 04:46:24.119486 1 main.go:439] Waiting for 22h59m59.977856114s to renew lease Sep 9 04:46:24.135031 sh[2882]: + for try in 1 2 3 4 5 6 Sep 9 04:46:24.135031 sh[2882]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Sep 9 04:46:24.149356 sh[2892]: Error response from daemon: No such container: flannel-docker-opts Sep 9 04:46:24.160999 sh[2901]: Error response from daemon: No such container: flannel-docker-opts Sep 9 04:46:24.184852 systemd[1]: var-lib-docker-overlay2-86926225734db5130f1841d859a1b74cee1df527ef8f9de45c45821d116629fe\x2dinit-merged.mount: Deactivated successfully. Sep 9 04:46:24.222497 containerd[1468]: time="2025-09-09T04:46:24.222446806Z" level=info msg="connecting to shim 3daef2f75dc9bf1540af520ad5a21370c7aa0be3b51a2f89414994e54e869434" address="unix:///run/containerd/s/d220bc5184bd036eeb078d5504693abee1e1f95e60faafa09d2d7907cf024bf3" namespace=moby protocol=ttrpc version=3 Sep 9 04:46:24.259475 systemd[1]: Started docker-3daef2f75dc9bf1540af520ad5a21370c7aa0be3b51a2f89414994e54e869434.scope - libcontainer container 3daef2f75dc9bf1540af520ad5a21370c7aa0be3b51a2f89414994e54e869434. Sep 9 04:46:24.273785 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 04:46:24.298666 systemd[1]: docker-3daef2f75dc9bf1540af520ad5a21370c7aa0be3b51a2f89414994e54e869434.scope: Deactivated successfully. Sep 9 04:46:24.311366 containerd[1468]: time="2025-09-09T04:46:24.311176589Z" level=info msg="shim disconnected" id=3daef2f75dc9bf1540af520ad5a21370c7aa0be3b51a2f89414994e54e869434 namespace=moby Sep 9 04:46:24.311366 containerd[1468]: time="2025-09-09T04:46:24.311360396Z" level=warning msg="cleaning up after shim disconnected" id=3daef2f75dc9bf1540af520ad5a21370c7aa0be3b51a2f89414994e54e869434 namespace=moby Sep 9 04:46:24.311366 containerd[1468]: time="2025-09-09T04:46:24.311369412Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 04:46:24.336429 sh[2882]: + break Sep 9 04:46:24.336429 sh[2882]: + '[' 1 '!=' fail ']' Sep 9 04:46:24.337731 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Sep 9 04:46:27.512823 etcd-wrapper[2694]: {"level":"warn","ts":"2025-09-09T04:46:27.512Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"972c040f769b6104","rtt":"0s","error":"dial tcp 10.0.0.9:2380: connect: connection refused"} Sep 9 04:46:27.512823 etcd-wrapper[2694]: {"level":"warn","ts":"2025-09-09T04:46:27.512Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"972c040f769b6104","rtt":"0s","error":"dial tcp 10.0.0.9:2380: connect: connection refused"} Sep 9 04:46:28.860879 sshd[2623]: Connection closed by 10.0.0.1 port 53114 Sep 9 04:46:28.861547 sshd-session[2620]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:28.866854 systemd[1]: sshd@8-10.0.0.10:22-10.0.0.1:53114.service: Deactivated successfully. Sep 9 04:46:28.868648 systemd[1]: session-9.scope: Deactivated successfully. Sep 9 04:46:28.870192 systemd-logind[1389]: Session 9 logged out. Waiting for processes to exit. Sep 9 04:46:28.871972 systemd-logind[1389]: Removed session 9. Sep 9 04:46:29.049657 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.049Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"972c040f769b6104","stream-type":"stream Message"} Sep 9 04:46:29.049657 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.049Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"972c040f769b6104"} Sep 9 04:46:29.049657 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.049Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"884efc11bb1d5ed7","to":"972c040f769b6104","stream-type":"stream MsgApp v2"} Sep 9 04:46:29.049657 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.049Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:29.049657 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.049Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:29.114283 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.113Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:29.114283 etcd-wrapper[2694]: {"level":"info","ts":"2025-09-09T04:46:29.113Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"884efc11bb1d5ed7","remote-peer-id":"972c040f769b6104"} Sep 9 04:46:38.880224 systemd[1]: Started sshd@9-10.0.0.10:22-10.0.0.1:36014.service - OpenSSH per-connection server daemon (10.0.0.1:36014). Sep 9 04:46:38.962205 sshd[3019]: Accepted publickey for core from 10.0.0.1 port 36014 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:38.963646 sshd-session[3019]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:38.969643 systemd-logind[1389]: New session 10 of user core. Sep 9 04:46:38.982088 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 9 04:46:39.064704 sshd[3022]: Connection closed by 10.0.0.1 port 36014 Sep 9 04:46:39.066038 sshd-session[3019]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:39.080614 systemd[1]: sshd@9-10.0.0.10:22-10.0.0.1:36014.service: Deactivated successfully. Sep 9 04:46:39.082820 systemd[1]: session-10.scope: Deactivated successfully. Sep 9 04:46:39.083872 systemd-logind[1389]: Session 10 logged out. Waiting for processes to exit. Sep 9 04:46:39.088939 systemd[1]: Started sshd@10-10.0.0.10:22-10.0.0.1:36028.service - OpenSSH per-connection server daemon (10.0.0.1:36028). Sep 9 04:46:39.089673 systemd-logind[1389]: Removed session 10. Sep 9 04:46:39.152707 sshd[3034]: Accepted publickey for core from 10.0.0.1 port 36028 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:39.155045 sshd-session[3034]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:39.161547 systemd-logind[1389]: New session 11 of user core. Sep 9 04:46:39.175417 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 9 04:46:39.235484 sshd[3043]: Connection closed by 10.0.0.1 port 36028 Sep 9 04:46:39.235801 sshd-session[3034]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:39.239339 systemd[1]: sshd@10-10.0.0.10:22-10.0.0.1:36028.service: Deactivated successfully. Sep 9 04:46:39.241670 systemd[1]: session-11.scope: Deactivated successfully. Sep 9 04:46:39.243081 systemd-logind[1389]: Session 11 logged out. Waiting for processes to exit. Sep 9 04:46:39.244747 systemd-logind[1389]: Removed session 11. Sep 9 04:46:39.416403 systemd[1]: Started sshd@11-10.0.0.10:22-10.0.0.1:36038.service - OpenSSH per-connection server daemon (10.0.0.1:36038). Sep 9 04:46:39.487813 sshd[3052]: Accepted publickey for core from 10.0.0.1 port 36038 ssh2: RSA SHA256:BZm90Ok3j8HCXtlwShuWuMQDPsEE0kFrFWmP82ap/wE Sep 9 04:46:39.489122 sshd-session[3052]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 04:46:39.494349 systemd-logind[1389]: New session 12 of user core. Sep 9 04:46:39.505472 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 9 04:46:47.511806 update_engine[1393]: I20250909 04:46:47.511704 1393 update_attempter.cc:509] Updating boot flags... Sep 9 04:46:48.808095 sshd[3055]: Connection closed by 10.0.0.1 port 36038 Sep 9 04:46:48.808607 sshd-session[3052]: pam_unix(sshd:session): session closed for user core Sep 9 04:46:48.812464 systemd[1]: sshd@11-10.0.0.10:22-10.0.0.1:36038.service: Deactivated successfully. Sep 9 04:46:48.814346 systemd[1]: session-12.scope: Deactivated successfully. Sep 9 04:46:48.815112 systemd-logind[1389]: Session 12 logged out. Waiting for processes to exit. Sep 9 04:46:48.816196 systemd-logind[1389]: Removed session 12.