Sep 5 05:35:11.740312 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 5 05:35:11.740332 kernel: Linux version 6.12.44-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Fri Sep 5 04:25:57 -00 2025 Sep 5 05:35:11.740342 kernel: KASLR enabled Sep 5 05:35:11.740347 kernel: efi: EFI v2.7 by EDK II Sep 5 05:35:11.740353 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Sep 5 05:35:11.740359 kernel: random: crng init done Sep 5 05:35:11.740365 kernel: secureboot: Secure boot disabled Sep 5 05:35:11.740371 kernel: ACPI: Early table checksum verification disabled Sep 5 05:35:11.740377 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Sep 5 05:35:11.740384 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 5 05:35:11.740390 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740396 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740402 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740407 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740414 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740422 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740428 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740434 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740440 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:35:11.740446 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 5 05:35:11.740451 kernel: ACPI: Use ACPI SPCR as default console: No Sep 5 05:35:11.740457 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 05:35:11.740463 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Sep 5 05:35:11.740469 kernel: Zone ranges: Sep 5 05:35:11.740475 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 05:35:11.740482 kernel: DMA32 empty Sep 5 05:35:11.740488 kernel: Normal empty Sep 5 05:35:11.740494 kernel: Device empty Sep 5 05:35:11.740499 kernel: Movable zone start for each node Sep 5 05:35:11.740505 kernel: Early memory node ranges Sep 5 05:35:11.740511 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Sep 5 05:35:11.742554 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Sep 5 05:35:11.742580 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Sep 5 05:35:11.742587 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Sep 5 05:35:11.742593 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Sep 5 05:35:11.742600 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Sep 5 05:35:11.742606 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Sep 5 05:35:11.742618 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Sep 5 05:35:11.742624 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Sep 5 05:35:11.742630 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 5 05:35:11.742639 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 5 05:35:11.742645 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 5 05:35:11.742652 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 5 05:35:11.742660 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 05:35:11.742666 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 5 05:35:11.742673 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Sep 5 05:35:11.742679 kernel: psci: probing for conduit method from ACPI. Sep 5 05:35:11.742685 kernel: psci: PSCIv1.1 detected in firmware. Sep 5 05:35:11.742692 kernel: psci: Using standard PSCI v0.2 function IDs Sep 5 05:35:11.742698 kernel: psci: Trusted OS migration not required Sep 5 05:35:11.742704 kernel: psci: SMC Calling Convention v1.1 Sep 5 05:35:11.742711 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 5 05:35:11.742718 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 5 05:35:11.742725 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 5 05:35:11.742732 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 5 05:35:11.742738 kernel: Detected PIPT I-cache on CPU0 Sep 5 05:35:11.742745 kernel: CPU features: detected: GIC system register CPU interface Sep 5 05:35:11.742751 kernel: CPU features: detected: Spectre-v4 Sep 5 05:35:11.742757 kernel: CPU features: detected: Spectre-BHB Sep 5 05:35:11.742764 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 5 05:35:11.742770 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 5 05:35:11.742777 kernel: CPU features: detected: ARM erratum 1418040 Sep 5 05:35:11.742783 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 5 05:35:11.742789 kernel: alternatives: applying boot alternatives Sep 5 05:35:11.742798 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=ad0560d5d82b42c8405832aa39f4f52a20b919c503afe4e7ecc72adb2e451fae Sep 5 05:35:11.742806 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 5 05:35:11.742812 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 5 05:35:11.742819 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 5 05:35:11.742825 kernel: Fallback order for Node 0: 0 Sep 5 05:35:11.742831 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Sep 5 05:35:11.742838 kernel: Policy zone: DMA Sep 5 05:35:11.742844 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 5 05:35:11.742851 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Sep 5 05:35:11.742857 kernel: software IO TLB: area num 4. Sep 5 05:35:11.742872 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Sep 5 05:35:11.742878 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Sep 5 05:35:11.742887 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 5 05:35:11.742894 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 5 05:35:11.742902 kernel: rcu: RCU event tracing is enabled. Sep 5 05:35:11.742908 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 5 05:35:11.742915 kernel: Trampoline variant of Tasks RCU enabled. Sep 5 05:35:11.742921 kernel: Tracing variant of Tasks RCU enabled. Sep 5 05:35:11.742928 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 5 05:35:11.742934 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 5 05:35:11.742941 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 05:35:11.742947 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 05:35:11.742954 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 5 05:35:11.742961 kernel: GICv3: 256 SPIs implemented Sep 5 05:35:11.742968 kernel: GICv3: 0 Extended SPIs implemented Sep 5 05:35:11.742974 kernel: Root IRQ handler: gic_handle_irq Sep 5 05:35:11.742981 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 5 05:35:11.742987 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 5 05:35:11.742994 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 5 05:35:11.743000 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 5 05:35:11.743007 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Sep 5 05:35:11.743016 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Sep 5 05:35:11.743025 kernel: GICv3: using LPI property table @0x0000000040130000 Sep 5 05:35:11.743032 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Sep 5 05:35:11.743038 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 5 05:35:11.743047 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:35:11.743054 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 5 05:35:11.743061 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 5 05:35:11.743068 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 5 05:35:11.743074 kernel: arm-pv: using stolen time PV Sep 5 05:35:11.743081 kernel: Console: colour dummy device 80x25 Sep 5 05:35:11.743088 kernel: ACPI: Core revision 20240827 Sep 5 05:35:11.743095 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 5 05:35:11.743102 kernel: pid_max: default: 32768 minimum: 301 Sep 5 05:35:11.743109 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 5 05:35:11.743117 kernel: landlock: Up and running. Sep 5 05:35:11.743124 kernel: SELinux: Initializing. Sep 5 05:35:11.743131 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 05:35:11.743138 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 05:35:11.743145 kernel: rcu: Hierarchical SRCU implementation. Sep 5 05:35:11.743152 kernel: rcu: Max phase no-delay instances is 400. Sep 5 05:35:11.743159 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 5 05:35:11.743166 kernel: Remapping and enabling EFI services. Sep 5 05:35:11.743173 kernel: smp: Bringing up secondary CPUs ... Sep 5 05:35:11.743187 kernel: Detected PIPT I-cache on CPU1 Sep 5 05:35:11.743194 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 5 05:35:11.743201 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Sep 5 05:35:11.743211 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:35:11.743218 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 5 05:35:11.743225 kernel: Detected PIPT I-cache on CPU2 Sep 5 05:35:11.743233 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 5 05:35:11.743240 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Sep 5 05:35:11.743249 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:35:11.743256 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 5 05:35:11.743263 kernel: Detected PIPT I-cache on CPU3 Sep 5 05:35:11.743270 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 5 05:35:11.743278 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Sep 5 05:35:11.743285 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:35:11.743292 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 5 05:35:11.743300 kernel: smp: Brought up 1 node, 4 CPUs Sep 5 05:35:11.743307 kernel: SMP: Total of 4 processors activated. Sep 5 05:35:11.743315 kernel: CPU: All CPU(s) started at EL1 Sep 5 05:35:11.743329 kernel: CPU features: detected: 32-bit EL0 Support Sep 5 05:35:11.743339 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 5 05:35:11.743346 kernel: CPU features: detected: Common not Private translations Sep 5 05:35:11.743354 kernel: CPU features: detected: CRC32 instructions Sep 5 05:35:11.743361 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 5 05:35:11.743369 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 5 05:35:11.743376 kernel: CPU features: detected: LSE atomic instructions Sep 5 05:35:11.743383 kernel: CPU features: detected: Privileged Access Never Sep 5 05:35:11.743392 kernel: CPU features: detected: RAS Extension Support Sep 5 05:35:11.743399 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 5 05:35:11.743406 kernel: alternatives: applying system-wide alternatives Sep 5 05:35:11.743414 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Sep 5 05:35:11.743421 kernel: Memory: 2424544K/2572288K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38912K init, 1038K bss, 125408K reserved, 16384K cma-reserved) Sep 5 05:35:11.743429 kernel: devtmpfs: initialized Sep 5 05:35:11.743436 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 5 05:35:11.743443 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 5 05:35:11.743450 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 5 05:35:11.743459 kernel: 0 pages in range for non-PLT usage Sep 5 05:35:11.743466 kernel: 508576 pages in range for PLT usage Sep 5 05:35:11.743473 kernel: pinctrl core: initialized pinctrl subsystem Sep 5 05:35:11.743480 kernel: SMBIOS 3.0.0 present. Sep 5 05:35:11.743488 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Sep 5 05:35:11.743495 kernel: DMI: Memory slots populated: 1/1 Sep 5 05:35:11.743502 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 5 05:35:11.743510 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 5 05:35:11.743524 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 5 05:35:11.743534 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 5 05:35:11.743541 kernel: audit: initializing netlink subsys (disabled) Sep 5 05:35:11.743549 kernel: audit: type=2000 audit(0.021:1): state=initialized audit_enabled=0 res=1 Sep 5 05:35:11.743556 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 5 05:35:11.743563 kernel: cpuidle: using governor menu Sep 5 05:35:11.743569 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 5 05:35:11.743576 kernel: ASID allocator initialised with 32768 entries Sep 5 05:35:11.743583 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 5 05:35:11.743591 kernel: Serial: AMBA PL011 UART driver Sep 5 05:35:11.743599 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 5 05:35:11.743606 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 5 05:35:11.743613 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 5 05:35:11.743620 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 5 05:35:11.743627 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 5 05:35:11.743634 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 5 05:35:11.743642 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 5 05:35:11.743649 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 5 05:35:11.743656 kernel: ACPI: Added _OSI(Module Device) Sep 5 05:35:11.743664 kernel: ACPI: Added _OSI(Processor Device) Sep 5 05:35:11.743671 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 5 05:35:11.743678 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 5 05:35:11.743685 kernel: ACPI: Interpreter enabled Sep 5 05:35:11.743692 kernel: ACPI: Using GIC for interrupt routing Sep 5 05:35:11.743699 kernel: ACPI: MCFG table detected, 1 entries Sep 5 05:35:11.743706 kernel: ACPI: CPU0 has been hot-added Sep 5 05:35:11.743714 kernel: ACPI: CPU1 has been hot-added Sep 5 05:35:11.743721 kernel: ACPI: CPU2 has been hot-added Sep 5 05:35:11.743728 kernel: ACPI: CPU3 has been hot-added Sep 5 05:35:11.743737 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 5 05:35:11.743744 kernel: printk: legacy console [ttyAMA0] enabled Sep 5 05:35:11.743751 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 5 05:35:11.743913 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 5 05:35:11.743990 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 5 05:35:11.744051 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 5 05:35:11.744110 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 5 05:35:11.744169 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 5 05:35:11.744179 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 5 05:35:11.744186 kernel: PCI host bridge to bus 0000:00 Sep 5 05:35:11.744250 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 5 05:35:11.744308 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 5 05:35:11.744362 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 5 05:35:11.744414 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 5 05:35:11.744501 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Sep 5 05:35:11.744587 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 5 05:35:11.744666 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Sep 5 05:35:11.744729 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Sep 5 05:35:11.744789 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Sep 5 05:35:11.744852 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Sep 5 05:35:11.744922 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Sep 5 05:35:11.744987 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Sep 5 05:35:11.745042 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 5 05:35:11.745104 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 5 05:35:11.745157 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 5 05:35:11.745166 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 5 05:35:11.745173 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 5 05:35:11.745180 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 5 05:35:11.745195 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 5 05:35:11.745207 kernel: iommu: Default domain type: Translated Sep 5 05:35:11.745214 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 5 05:35:11.745221 kernel: efivars: Registered efivars operations Sep 5 05:35:11.745228 kernel: vgaarb: loaded Sep 5 05:35:11.745236 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 5 05:35:11.745243 kernel: VFS: Disk quotas dquot_6.6.0 Sep 5 05:35:11.745250 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 5 05:35:11.745257 kernel: pnp: PnP ACPI init Sep 5 05:35:11.745324 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 5 05:35:11.745334 kernel: pnp: PnP ACPI: found 1 devices Sep 5 05:35:11.745341 kernel: NET: Registered PF_INET protocol family Sep 5 05:35:11.745348 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 5 05:35:11.745355 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 5 05:35:11.745362 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 5 05:35:11.745369 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 5 05:35:11.745376 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 5 05:35:11.745385 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 5 05:35:11.745392 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 05:35:11.745399 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 05:35:11.745406 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 5 05:35:11.745413 kernel: PCI: CLS 0 bytes, default 64 Sep 5 05:35:11.745420 kernel: kvm [1]: HYP mode not available Sep 5 05:35:11.745427 kernel: Initialise system trusted keyrings Sep 5 05:35:11.745435 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 5 05:35:11.745442 kernel: Key type asymmetric registered Sep 5 05:35:11.745450 kernel: Asymmetric key parser 'x509' registered Sep 5 05:35:11.745457 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 5 05:35:11.745465 kernel: io scheduler mq-deadline registered Sep 5 05:35:11.745472 kernel: io scheduler kyber registered Sep 5 05:35:11.745479 kernel: io scheduler bfq registered Sep 5 05:35:11.745486 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 5 05:35:11.745493 kernel: ACPI: button: Power Button [PWRB] Sep 5 05:35:11.745500 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 5 05:35:11.745592 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 5 05:35:11.745605 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 5 05:35:11.745613 kernel: thunder_xcv, ver 1.0 Sep 5 05:35:11.745620 kernel: thunder_bgx, ver 1.0 Sep 5 05:35:11.745627 kernel: nicpf, ver 1.0 Sep 5 05:35:11.745634 kernel: nicvf, ver 1.0 Sep 5 05:35:11.745702 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 5 05:35:11.745759 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-05T05:35:11 UTC (1757050511) Sep 5 05:35:11.745769 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 5 05:35:11.745777 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 5 05:35:11.745786 kernel: watchdog: NMI not fully supported Sep 5 05:35:11.745793 kernel: watchdog: Hard watchdog permanently disabled Sep 5 05:35:11.745800 kernel: NET: Registered PF_INET6 protocol family Sep 5 05:35:11.745807 kernel: Segment Routing with IPv6 Sep 5 05:35:11.745814 kernel: In-situ OAM (IOAM) with IPv6 Sep 5 05:35:11.745821 kernel: NET: Registered PF_PACKET protocol family Sep 5 05:35:11.745828 kernel: Key type dns_resolver registered Sep 5 05:35:11.745835 kernel: registered taskstats version 1 Sep 5 05:35:11.745842 kernel: Loading compiled-in X.509 certificates Sep 5 05:35:11.745850 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.44-flatcar: aa317a1d4cc75a128b85a6fc319190bc5853ac85' Sep 5 05:35:11.745857 kernel: Demotion targets for Node 0: null Sep 5 05:35:11.745872 kernel: Key type .fscrypt registered Sep 5 05:35:11.745879 kernel: Key type fscrypt-provisioning registered Sep 5 05:35:11.745886 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 5 05:35:11.745893 kernel: ima: Allocated hash algorithm: sha1 Sep 5 05:35:11.745900 kernel: ima: No architecture policies found Sep 5 05:35:11.745907 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 5 05:35:11.745916 kernel: clk: Disabling unused clocks Sep 5 05:35:11.745923 kernel: PM: genpd: Disabling unused power domains Sep 5 05:35:11.745929 kernel: Warning: unable to open an initial console. Sep 5 05:35:11.745937 kernel: Freeing unused kernel memory: 38912K Sep 5 05:35:11.745944 kernel: Run /init as init process Sep 5 05:35:11.745951 kernel: with arguments: Sep 5 05:35:11.745958 kernel: /init Sep 5 05:35:11.745965 kernel: with environment: Sep 5 05:35:11.745971 kernel: HOME=/ Sep 5 05:35:11.745978 kernel: TERM=linux Sep 5 05:35:11.745987 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 5 05:35:11.745995 systemd[1]: Successfully made /usr/ read-only. Sep 5 05:35:11.746005 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 5 05:35:11.746014 systemd[1]: Detected virtualization kvm. Sep 5 05:35:11.746021 systemd[1]: Detected architecture arm64. Sep 5 05:35:11.746028 systemd[1]: Running in initrd. Sep 5 05:35:11.746036 systemd[1]: No hostname configured, using default hostname. Sep 5 05:35:11.746045 systemd[1]: Hostname set to . Sep 5 05:35:11.746052 systemd[1]: Initializing machine ID from VM UUID. Sep 5 05:35:11.746060 systemd[1]: Queued start job for default target initrd.target. Sep 5 05:35:11.746067 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 05:35:11.746075 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 05:35:11.746083 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 5 05:35:11.746091 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 05:35:11.746098 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 5 05:35:11.746109 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 5 05:35:11.746117 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 5 05:35:11.746125 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 5 05:35:11.746133 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 05:35:11.746140 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 05:35:11.746148 systemd[1]: Reached target paths.target - Path Units. Sep 5 05:35:11.746155 systemd[1]: Reached target slices.target - Slice Units. Sep 5 05:35:11.746164 systemd[1]: Reached target swap.target - Swaps. Sep 5 05:35:11.746172 systemd[1]: Reached target timers.target - Timer Units. Sep 5 05:35:11.746180 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 05:35:11.746187 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 05:35:11.746195 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 5 05:35:11.746202 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 5 05:35:11.746210 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 05:35:11.746217 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 05:35:11.746226 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 05:35:11.746234 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 05:35:11.746241 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 5 05:35:11.746249 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 05:35:11.746256 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 5 05:35:11.746264 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 5 05:35:11.746272 systemd[1]: Starting systemd-fsck-usr.service... Sep 5 05:35:11.746279 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 05:35:11.746287 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 05:35:11.746296 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:35:11.746304 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 5 05:35:11.746312 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 05:35:11.746320 systemd[1]: Finished systemd-fsck-usr.service. Sep 5 05:35:11.746346 systemd-journald[244]: Collecting audit messages is disabled. Sep 5 05:35:11.746366 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 5 05:35:11.746374 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:35:11.746383 systemd-journald[244]: Journal started Sep 5 05:35:11.746403 systemd-journald[244]: Runtime Journal (/run/log/journal/3268b321dfc847ec9fa14e92197cd97a) is 6M, max 48.5M, 42.4M free. Sep 5 05:35:11.751565 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 5 05:35:11.738046 systemd-modules-load[245]: Inserted module 'overlay' Sep 5 05:35:11.754232 kernel: Bridge firewalling registered Sep 5 05:35:11.754251 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 5 05:35:11.752111 systemd-modules-load[245]: Inserted module 'br_netfilter' Sep 5 05:35:11.756565 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 05:35:11.757640 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 05:35:11.758675 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 05:35:11.762884 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 05:35:11.764389 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 05:35:11.766618 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 05:35:11.774909 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 05:35:11.777273 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 5 05:35:11.783287 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 05:35:11.785146 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 05:35:11.785797 systemd-tmpfiles[275]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 5 05:35:11.788714 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 05:35:11.792213 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 05:35:11.801051 dracut-cmdline[282]: 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=ad0560d5d82b42c8405832aa39f4f52a20b919c503afe4e7ecc72adb2e451fae Sep 5 05:35:11.834258 systemd-resolved[291]: Positive Trust Anchors: Sep 5 05:35:11.834276 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 05:35:11.834311 systemd-resolved[291]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 5 05:35:11.839250 systemd-resolved[291]: Defaulting to hostname 'linux'. Sep 5 05:35:11.840379 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 05:35:11.842965 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 05:35:11.876562 kernel: SCSI subsystem initialized Sep 5 05:35:11.881535 kernel: Loading iSCSI transport class v2.0-870. Sep 5 05:35:11.888536 kernel: iscsi: registered transport (tcp) Sep 5 05:35:11.901542 kernel: iscsi: registered transport (qla4xxx) Sep 5 05:35:11.901579 kernel: QLogic iSCSI HBA Driver Sep 5 05:35:11.918198 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 05:35:11.941003 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 05:35:11.943127 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 05:35:11.986956 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 5 05:35:11.988944 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 5 05:35:12.056551 kernel: raid6: neonx8 gen() 15761 MB/s Sep 5 05:35:12.073536 kernel: raid6: neonx4 gen() 15821 MB/s Sep 5 05:35:12.090535 kernel: raid6: neonx2 gen() 13233 MB/s Sep 5 05:35:12.107537 kernel: raid6: neonx1 gen() 10467 MB/s Sep 5 05:35:12.124535 kernel: raid6: int64x8 gen() 6902 MB/s Sep 5 05:35:12.141537 kernel: raid6: int64x4 gen() 7352 MB/s Sep 5 05:35:12.158535 kernel: raid6: int64x2 gen() 6104 MB/s Sep 5 05:35:12.175536 kernel: raid6: int64x1 gen() 5053 MB/s Sep 5 05:35:12.175557 kernel: raid6: using algorithm neonx4 gen() 15821 MB/s Sep 5 05:35:12.192542 kernel: raid6: .... xor() 12339 MB/s, rmw enabled Sep 5 05:35:12.192555 kernel: raid6: using neon recovery algorithm Sep 5 05:35:12.197583 kernel: xor: measuring software checksum speed Sep 5 05:35:12.197609 kernel: 8regs : 21596 MB/sec Sep 5 05:35:12.198626 kernel: 32regs : 21687 MB/sec Sep 5 05:35:12.198639 kernel: arm64_neon : 28099 MB/sec Sep 5 05:35:12.198648 kernel: xor: using function: arm64_neon (28099 MB/sec) Sep 5 05:35:12.250551 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 5 05:35:12.258561 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 5 05:35:12.260749 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 05:35:12.288369 systemd-udevd[498]: Using default interface naming scheme 'v255'. Sep 5 05:35:12.292350 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 05:35:12.294125 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 5 05:35:12.324480 dracut-pre-trigger[506]: rd.md=0: removing MD RAID activation Sep 5 05:35:12.346012 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 05:35:12.348055 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 05:35:12.408784 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 05:35:12.411541 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 5 05:35:12.454542 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 5 05:35:12.455854 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 5 05:35:12.459545 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:35:12.463377 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 05:35:12.463501 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:35:12.469417 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:35:12.474004 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:35:12.494578 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 5 05:35:12.499974 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 5 05:35:12.501553 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:35:12.514790 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 5 05:35:12.521897 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 5 05:35:12.523609 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 5 05:35:12.531454 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 05:35:12.532573 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 05:35:12.534292 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 05:35:12.535948 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 05:35:12.538221 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 5 05:35:12.540008 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 5 05:35:12.557226 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 5 05:35:12.561280 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:35:13.565578 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:35:13.566116 disk-uuid[592]: The operation has completed successfully. Sep 5 05:35:13.589490 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 5 05:35:13.589599 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 5 05:35:13.617252 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 5 05:35:13.635257 sh[609]: Success Sep 5 05:35:13.648261 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 5 05:35:13.648304 kernel: device-mapper: uevent: version 1.0.3 Sep 5 05:35:13.648315 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 5 05:35:13.655544 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 5 05:35:13.678083 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 5 05:35:13.680290 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 5 05:35:13.695882 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 5 05:35:13.703675 kernel: BTRFS: device fsid 9394a7fb-1948-4797-93d7-fc7ecccd6bdf devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (621) Sep 5 05:35:13.703720 kernel: BTRFS info (device dm-0): first mount of filesystem 9394a7fb-1948-4797-93d7-fc7ecccd6bdf Sep 5 05:35:13.703731 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:35:13.708674 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 5 05:35:13.708696 kernel: BTRFS info (device dm-0): enabling free space tree Sep 5 05:35:13.709766 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 5 05:35:13.710850 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 5 05:35:13.711897 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 5 05:35:13.712689 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 5 05:35:13.715219 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 5 05:35:13.738536 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (654) Sep 5 05:35:13.740544 kernel: BTRFS info (device vda6): first mount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:35:13.740585 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:35:13.742830 kernel: BTRFS info (device vda6): turning on async discard Sep 5 05:35:13.742872 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 05:35:13.746540 kernel: BTRFS info (device vda6): last unmount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:35:13.747873 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 5 05:35:13.751655 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 5 05:35:13.811250 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 05:35:13.814705 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 05:35:13.854701 systemd-networkd[801]: lo: Link UP Sep 5 05:35:13.854714 systemd-networkd[801]: lo: Gained carrier Sep 5 05:35:13.857698 ignition[697]: Ignition 2.22.0 Sep 5 05:35:13.855469 systemd-networkd[801]: Enumeration completed Sep 5 05:35:13.857705 ignition[697]: Stage: fetch-offline Sep 5 05:35:13.855780 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 05:35:13.857732 ignition[697]: no configs at "/usr/lib/ignition/base.d" Sep 5 05:35:13.855940 systemd-networkd[801]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:35:13.857739 ignition[697]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:35:13.855944 systemd-networkd[801]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 05:35:13.857814 ignition[697]: parsed url from cmdline: "" Sep 5 05:35:13.856349 systemd-networkd[801]: eth0: Link UP Sep 5 05:35:13.857817 ignition[697]: no config URL provided Sep 5 05:35:13.856686 systemd-networkd[801]: eth0: Gained carrier Sep 5 05:35:13.857822 ignition[697]: reading system config file "/usr/lib/ignition/user.ign" Sep 5 05:35:13.856697 systemd-networkd[801]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:35:13.857827 ignition[697]: no config at "/usr/lib/ignition/user.ign" Sep 5 05:35:13.857260 systemd[1]: Reached target network.target - Network. Sep 5 05:35:13.857846 ignition[697]: op(1): [started] loading QEMU firmware config module Sep 5 05:35:13.857850 ignition[697]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 5 05:35:13.862539 ignition[697]: op(1): [finished] loading QEMU firmware config module Sep 5 05:35:13.878058 ignition[697]: parsing config with SHA512: aafaab4a717bbd803a3522c2f07d3138530c1b97be9b61a702860330f3348d89697b62e1fe7f4f9b50ca2824124a14de579962c69cb299877a50888322a52b84 Sep 5 05:35:13.884605 systemd-networkd[801]: eth0: DHCPv4 address 10.0.0.10/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 05:35:13.885714 unknown[697]: fetched base config from "system" Sep 5 05:35:13.885927 ignition[697]: fetch-offline: fetch-offline passed Sep 5 05:35:13.885722 unknown[697]: fetched user config from "qemu" Sep 5 05:35:13.886000 ignition[697]: Ignition finished successfully Sep 5 05:35:13.889565 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 05:35:13.890881 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 5 05:35:13.891793 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 5 05:35:13.928628 ignition[810]: Ignition 2.22.0 Sep 5 05:35:13.928646 ignition[810]: Stage: kargs Sep 5 05:35:13.928775 ignition[810]: no configs at "/usr/lib/ignition/base.d" Sep 5 05:35:13.928783 ignition[810]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:35:13.929361 ignition[810]: kargs: kargs passed Sep 5 05:35:13.929403 ignition[810]: Ignition finished successfully Sep 5 05:35:13.931943 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 5 05:35:13.934327 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 5 05:35:13.973783 ignition[818]: Ignition 2.22.0 Sep 5 05:35:13.973801 ignition[818]: Stage: disks Sep 5 05:35:13.973945 ignition[818]: no configs at "/usr/lib/ignition/base.d" Sep 5 05:35:13.977105 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 5 05:35:13.973955 ignition[818]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:35:13.978169 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 5 05:35:13.974580 ignition[818]: disks: disks passed Sep 5 05:35:13.979594 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 5 05:35:13.974626 ignition[818]: Ignition finished successfully Sep 5 05:35:13.981278 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 05:35:13.982769 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 05:35:13.983901 systemd[1]: Reached target basic.target - Basic System. Sep 5 05:35:13.986364 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 5 05:35:14.013882 systemd-fsck[828]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 5 05:35:14.018999 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 5 05:35:14.021105 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 5 05:35:14.077549 kernel: EXT4-fs (vda9): mounted filesystem f4f5d9cb-0abd-4bb7-89fa-b5d1beb281ac r/w with ordered data mode. Quota mode: none. Sep 5 05:35:14.078372 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 5 05:35:14.079552 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 5 05:35:14.082185 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 05:35:14.084180 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 5 05:35:14.085046 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 5 05:35:14.085090 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 5 05:35:14.085114 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 05:35:14.095102 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 5 05:35:14.097713 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 5 05:35:14.101799 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (836) Sep 5 05:35:14.101822 kernel: BTRFS info (device vda6): first mount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:35:14.101831 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:35:14.103971 kernel: BTRFS info (device vda6): turning on async discard Sep 5 05:35:14.104091 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 05:35:14.105028 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 05:35:14.131843 initrd-setup-root[861]: cut: /sysroot/etc/passwd: No such file or directory Sep 5 05:35:14.135557 initrd-setup-root[868]: cut: /sysroot/etc/group: No such file or directory Sep 5 05:35:14.139212 initrd-setup-root[875]: cut: /sysroot/etc/shadow: No such file or directory Sep 5 05:35:14.143201 initrd-setup-root[882]: cut: /sysroot/etc/gshadow: No such file or directory Sep 5 05:35:14.211773 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 5 05:35:14.213843 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 5 05:35:14.215322 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 5 05:35:14.240533 kernel: BTRFS info (device vda6): last unmount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:35:14.254682 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 5 05:35:14.269928 ignition[950]: INFO : Ignition 2.22.0 Sep 5 05:35:14.269928 ignition[950]: INFO : Stage: mount Sep 5 05:35:14.272396 ignition[950]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 05:35:14.272396 ignition[950]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:35:14.272396 ignition[950]: INFO : mount: mount passed Sep 5 05:35:14.272396 ignition[950]: INFO : Ignition finished successfully Sep 5 05:35:14.273139 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 5 05:35:14.274848 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 5 05:35:14.833793 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 5 05:35:14.835273 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 05:35:14.864625 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (963) Sep 5 05:35:14.864660 kernel: BTRFS info (device vda6): first mount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:35:14.864670 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:35:14.867539 kernel: BTRFS info (device vda6): turning on async discard Sep 5 05:35:14.867566 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 05:35:14.868924 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 05:35:14.898350 ignition[980]: INFO : Ignition 2.22.0 Sep 5 05:35:14.898350 ignition[980]: INFO : Stage: files Sep 5 05:35:14.899746 ignition[980]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 05:35:14.899746 ignition[980]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:35:14.899746 ignition[980]: DEBUG : files: compiled without relabeling support, skipping Sep 5 05:35:14.902644 ignition[980]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 5 05:35:14.902644 ignition[980]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 5 05:35:14.902644 ignition[980]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 5 05:35:14.902644 ignition[980]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 5 05:35:14.902644 ignition[980]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 5 05:35:14.902045 unknown[980]: wrote ssh authorized keys file for user: core Sep 5 05:35:14.909472 ignition[980]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 05:35:14.909472 ignition[980]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(4): [started] processing unit "flannel-docker-opts.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(4): op(5): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(4): [finished] processing unit "flannel-docker-opts.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(6): [started] processing unit "docker.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(6): [finished] processing unit "docker.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(7): [started] processing unit "flanneld.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(7): op(8): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(7): op(8): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(7): [finished] processing unit "flanneld.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(9): [started] processing unit "coreos-metadata.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(9): op(a): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(9): op(a): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(9): [finished] processing unit "coreos-metadata.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(b): [started] processing unit "etcd-member.service" Sep 5 05:35:14.909472 ignition[980]: INFO : files: op(b): op(c): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(b): op(c): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(b): [finished] processing unit "etcd-member.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(d): [started] setting preset to disabled for "coreos-metadata.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(d): op(e): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(d): op(e): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(d): [finished] setting preset to disabled for "coreos-metadata.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(f): [started] setting preset to enabled for "docker.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(f): [finished] setting preset to enabled for "docker.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(10): [started] setting preset to enabled for "etcd-member.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(10): [finished] setting preset to enabled for "etcd-member.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(11): [started] setting preset to enabled for "flanneld.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: op(11): [finished] setting preset to enabled for "flanneld.service" Sep 5 05:35:14.939230 ignition[980]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 5 05:35:14.939230 ignition[980]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 5 05:35:14.939230 ignition[980]: INFO : files: files passed Sep 5 05:35:14.939230 ignition[980]: INFO : Ignition finished successfully Sep 5 05:35:14.928771 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 5 05:35:14.931296 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 5 05:35:14.933595 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 5 05:35:14.949782 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 5 05:35:14.965529 initrd-setup-root-after-ignition[1008]: grep: /sysroot/oem/oem-release: No such file or directory Sep 5 05:35:14.949887 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 5 05:35:14.967567 initrd-setup-root-after-ignition[1010]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 05:35:14.967567 initrd-setup-root-after-ignition[1010]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 5 05:35:14.954897 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 05:35:14.971205 initrd-setup-root-after-ignition[1014]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 05:35:14.957457 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 5 05:35:14.960406 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 5 05:35:15.011431 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 5 05:35:15.011572 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 5 05:35:15.013606 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 5 05:35:15.015340 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 5 05:35:15.016977 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 5 05:35:15.017780 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 5 05:35:15.045330 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 05:35:15.047602 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 5 05:35:15.064370 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 5 05:35:15.065513 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 05:35:15.067425 systemd[1]: Stopped target timers.target - Timer Units. Sep 5 05:35:15.069095 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 5 05:35:15.069207 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 05:35:15.071387 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 5 05:35:15.073199 systemd[1]: Stopped target basic.target - Basic System. Sep 5 05:35:15.074587 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 5 05:35:15.076146 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 05:35:15.077881 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 5 05:35:15.079576 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 5 05:35:15.081395 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 5 05:35:15.083139 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 05:35:15.084855 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 5 05:35:15.086496 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 5 05:35:15.088185 systemd[1]: Stopped target swap.target - Swaps. Sep 5 05:35:15.089487 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 5 05:35:15.089605 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 5 05:35:15.091735 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 5 05:35:15.093434 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 05:35:15.095248 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 5 05:35:15.095325 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 05:35:15.097175 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 5 05:35:15.097281 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 5 05:35:15.099802 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 5 05:35:15.099925 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 05:35:15.101638 systemd[1]: Stopped target paths.target - Path Units. Sep 5 05:35:15.103147 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 5 05:35:15.106554 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 05:35:15.107718 systemd[1]: Stopped target slices.target - Slice Units. Sep 5 05:35:15.109533 systemd[1]: Stopped target sockets.target - Socket Units. Sep 5 05:35:15.110975 systemd[1]: iscsid.socket: Deactivated successfully. Sep 5 05:35:15.111074 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 05:35:15.112367 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 5 05:35:15.112454 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 05:35:15.113820 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 5 05:35:15.113937 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 05:35:15.115531 systemd[1]: ignition-files.service: Deactivated successfully. Sep 5 05:35:15.115628 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 5 05:35:15.117796 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 5 05:35:15.120044 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 5 05:35:15.121150 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 5 05:35:15.121263 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 05:35:15.122917 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 5 05:35:15.123021 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 05:35:15.127947 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 5 05:35:15.133722 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 5 05:35:15.142026 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 5 05:35:15.145411 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 5 05:35:15.145501 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 5 05:35:15.150491 ignition[1036]: INFO : Ignition 2.22.0 Sep 5 05:35:15.150491 ignition[1036]: INFO : Stage: umount Sep 5 05:35:15.151928 ignition[1036]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 05:35:15.151928 ignition[1036]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:35:15.151928 ignition[1036]: INFO : umount: umount passed Sep 5 05:35:15.151928 ignition[1036]: INFO : Ignition finished successfully Sep 5 05:35:15.152720 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 5 05:35:15.152817 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 5 05:35:15.154782 systemd[1]: Stopped target network.target - Network. Sep 5 05:35:15.155960 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 5 05:35:15.156014 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 5 05:35:15.157358 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 5 05:35:15.157392 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 5 05:35:15.158941 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 5 05:35:15.158990 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 5 05:35:15.160334 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 5 05:35:15.160369 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 5 05:35:15.161865 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 5 05:35:15.161910 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 5 05:35:15.163546 systemd-networkd[801]: eth0: Gained IPv6LL Sep 5 05:35:15.163738 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 5 05:35:15.165251 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 5 05:35:15.175232 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 5 05:35:15.175335 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 5 05:35:15.178187 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 5 05:35:15.178464 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 5 05:35:15.178497 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 05:35:15.182004 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 5 05:35:15.182200 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 5 05:35:15.182299 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 5 05:35:15.184905 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 5 05:35:15.186234 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 5 05:35:15.186270 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 5 05:35:15.188623 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 5 05:35:15.189329 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 5 05:35:15.189377 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 05:35:15.191053 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 5 05:35:15.191091 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 5 05:35:15.193369 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 5 05:35:15.193409 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 5 05:35:15.195190 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 05:35:15.215112 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 5 05:35:15.215264 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 05:35:15.217263 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 5 05:35:15.217346 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 5 05:35:15.219434 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 5 05:35:15.219493 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 5 05:35:15.220571 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 5 05:35:15.220601 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 05:35:15.222199 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 5 05:35:15.222239 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 5 05:35:15.224604 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 5 05:35:15.224646 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 5 05:35:15.226990 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 5 05:35:15.227038 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 05:35:15.230150 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 5 05:35:15.231159 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 5 05:35:15.231211 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 05:35:15.233583 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 5 05:35:15.233631 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 05:35:15.236346 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 5 05:35:15.236388 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 05:35:15.238947 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 5 05:35:15.238986 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 05:35:15.240889 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 05:35:15.240935 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:35:15.248286 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 5 05:35:15.248364 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 5 05:35:15.250335 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 5 05:35:15.252450 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 5 05:35:15.276895 systemd[1]: Switching root. Sep 5 05:35:15.319514 systemd-journald[244]: Journal stopped Sep 5 05:35:15.973872 systemd-journald[244]: Received SIGTERM from PID 1 (systemd). Sep 5 05:35:15.973922 kernel: SELinux: policy capability network_peer_controls=1 Sep 5 05:35:15.973933 kernel: SELinux: policy capability open_perms=1 Sep 5 05:35:15.973946 kernel: SELinux: policy capability extended_socket_class=1 Sep 5 05:35:15.973959 kernel: SELinux: policy capability always_check_network=0 Sep 5 05:35:15.973972 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 5 05:35:15.973982 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 5 05:35:15.973994 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 5 05:35:15.974005 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 5 05:35:15.974015 kernel: SELinux: policy capability userspace_initial_context=0 Sep 5 05:35:15.974024 kernel: audit: type=1403 audit(1757050515.401:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 5 05:35:15.974036 systemd[1]: Successfully loaded SELinux policy in 53.561ms. Sep 5 05:35:15.974051 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.240ms. Sep 5 05:35:15.974062 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 5 05:35:15.974073 systemd[1]: Detected virtualization kvm. Sep 5 05:35:15.974083 systemd[1]: Detected architecture arm64. Sep 5 05:35:15.974093 systemd[1]: Detected first boot. Sep 5 05:35:15.974102 systemd[1]: Initializing machine ID from VM UUID. Sep 5 05:35:15.974114 kernel: NET: Registered PF_VSOCK protocol family Sep 5 05:35:15.974124 zram_generator::config[1082]: No configuration found. Sep 5 05:35:15.974141 systemd[1]: Populated /etc with preset unit settings. Sep 5 05:35:15.974152 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 5 05:35:15.974162 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 5 05:35:15.974172 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 5 05:35:15.974181 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 5 05:35:15.974192 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 5 05:35:15.974202 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 5 05:35:15.974212 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 5 05:35:15.974224 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 5 05:35:15.974234 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 5 05:35:15.974244 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 5 05:35:15.974254 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 5 05:35:15.974264 systemd[1]: Created slice user.slice - User and Session Slice. Sep 5 05:35:15.974275 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 05:35:15.974285 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 05:35:15.974295 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 5 05:35:15.974307 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 5 05:35:15.974317 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 5 05:35:15.974327 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 05:35:15.974337 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 5 05:35:15.974347 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 05:35:15.974357 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 05:35:15.974374 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 5 05:35:15.974384 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 5 05:35:15.974395 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 5 05:35:15.974408 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 5 05:35:15.974419 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 05:35:15.974429 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 05:35:15.974439 systemd[1]: Reached target slices.target - Slice Units. Sep 5 05:35:15.974449 systemd[1]: Reached target swap.target - Swaps. Sep 5 05:35:15.974459 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 5 05:35:15.974469 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 5 05:35:15.974480 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 5 05:35:15.974492 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 05:35:15.974502 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 05:35:15.974512 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 05:35:15.974539 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 5 05:35:15.974550 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 5 05:35:15.974560 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 5 05:35:15.974570 systemd[1]: Mounting media.mount - External Media Directory... Sep 5 05:35:15.974580 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 5 05:35:15.974590 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 5 05:35:15.974602 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 5 05:35:15.974613 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 5 05:35:15.974624 systemd[1]: Reached target machines.target - Containers. Sep 5 05:35:15.974635 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 5 05:35:15.974645 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:35:15.974655 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 05:35:15.974665 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 5 05:35:15.974676 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:35:15.974686 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 05:35:15.974697 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:35:15.974707 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 5 05:35:15.974718 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 05:35:15.974729 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 5 05:35:15.974739 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 5 05:35:15.974750 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 5 05:35:15.974759 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 5 05:35:15.974769 systemd[1]: Stopped systemd-fsck-usr.service. Sep 5 05:35:15.974781 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:35:15.974791 kernel: fuse: init (API version 7.41) Sep 5 05:35:15.974801 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 05:35:15.974810 kernel: loop: module loaded Sep 5 05:35:15.974820 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 05:35:15.974830 kernel: ACPI: bus type drm_connector registered Sep 5 05:35:15.974841 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 05:35:15.974858 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 5 05:35:15.974870 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 5 05:35:15.974882 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 05:35:15.974893 systemd[1]: verity-setup.service: Deactivated successfully. Sep 5 05:35:15.974902 systemd[1]: Stopped verity-setup.service. Sep 5 05:35:15.974912 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 5 05:35:15.974922 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 5 05:35:15.974933 systemd[1]: Mounted media.mount - External Media Directory. Sep 5 05:35:15.974951 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 5 05:35:15.974994 systemd-journald[1159]: Collecting audit messages is disabled. Sep 5 05:35:15.975016 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 5 05:35:15.975026 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 5 05:35:15.975037 systemd-journald[1159]: Journal started Sep 5 05:35:15.975058 systemd-journald[1159]: Runtime Journal (/run/log/journal/3268b321dfc847ec9fa14e92197cd97a) is 6M, max 48.5M, 42.4M free. Sep 5 05:35:15.763757 systemd[1]: Queued start job for default target multi-user.target. Sep 5 05:35:15.783401 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 5 05:35:15.783763 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 5 05:35:15.977117 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 05:35:15.980597 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 5 05:35:15.982090 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 05:35:15.983532 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 5 05:35:15.983744 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 5 05:35:15.985074 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:35:15.985232 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:35:15.986469 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 05:35:15.986687 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 05:35:15.987842 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:35:15.988035 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:35:15.989417 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 5 05:35:15.989861 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 5 05:35:15.991095 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 05:35:15.991300 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 05:35:15.992707 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 05:35:15.994006 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 05:35:15.995414 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 5 05:35:15.996977 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 5 05:35:16.009389 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 05:35:16.011888 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 5 05:35:16.013871 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 5 05:35:16.014964 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 5 05:35:16.014993 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 05:35:16.016814 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 5 05:35:16.020272 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 5 05:35:16.021382 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:35:16.022636 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 5 05:35:16.024345 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 5 05:35:16.025481 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 05:35:16.026624 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 5 05:35:16.027555 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 05:35:16.032633 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 05:35:16.034951 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 5 05:35:16.037026 systemd-journald[1159]: Time spent on flushing to /var/log/journal/3268b321dfc847ec9fa14e92197cd97a is 22.298ms for 872 entries. Sep 5 05:35:16.037026 systemd-journald[1159]: System Journal (/var/log/journal/3268b321dfc847ec9fa14e92197cd97a) is 8M, max 195.6M, 187.6M free. Sep 5 05:35:16.065006 systemd-journald[1159]: Received client request to flush runtime journal. Sep 5 05:35:16.065055 kernel: loop0: detected capacity change from 0 to 119320 Sep 5 05:35:16.038891 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 5 05:35:16.044372 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 05:35:16.045766 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 5 05:35:16.046973 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 5 05:35:16.048962 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 5 05:35:16.064685 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 05:35:16.066364 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 5 05:35:16.068827 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 5 05:35:16.072838 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 5 05:35:16.073565 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 5 05:35:16.077840 systemd-tmpfiles[1199]: ACLs are not supported, ignoring. Sep 5 05:35:16.077868 systemd-tmpfiles[1199]: ACLs are not supported, ignoring. Sep 5 05:35:16.087087 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 05:35:16.090782 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 5 05:35:16.095567 kernel: loop1: detected capacity change from 0 to 100608 Sep 5 05:35:16.106708 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 5 05:35:16.126959 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 5 05:35:16.131253 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 05:35:16.135619 kernel: loop2: detected capacity change from 0 to 119320 Sep 5 05:35:16.144543 kernel: loop3: detected capacity change from 0 to 100608 Sep 5 05:35:16.153964 (sd-merge)[1221]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 5 05:35:16.154319 (sd-merge)[1221]: Merged extensions into '/usr'. Sep 5 05:35:16.159088 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 5 05:35:16.160271 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Sep 5 05:35:16.160551 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Sep 5 05:35:16.163818 systemd[1]: Starting ensure-sysext.service... Sep 5 05:35:16.165648 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 05:35:16.168631 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 05:35:16.184884 systemd[1]: Reload requested from client PID 1225 ('systemctl') (unit ensure-sysext.service)... Sep 5 05:35:16.184902 systemd[1]: Reloading... Sep 5 05:35:16.198191 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 5 05:35:16.198219 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 5 05:35:16.198438 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 5 05:35:16.198642 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 5 05:35:16.199253 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 5 05:35:16.199476 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Sep 5 05:35:16.199543 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Sep 5 05:35:16.203333 systemd-tmpfiles[1226]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 05:35:16.203397 systemd-tmpfiles[1226]: Skipping /boot Sep 5 05:35:16.210685 systemd-tmpfiles[1226]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 05:35:16.210694 systemd-tmpfiles[1226]: Skipping /boot Sep 5 05:35:16.254553 zram_generator::config[1255]: No configuration found. Sep 5 05:35:16.299169 ldconfig[1193]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 5 05:35:16.399153 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 5 05:35:16.399594 systemd[1]: Reloading finished in 214 ms. Sep 5 05:35:16.418514 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 5 05:35:16.442564 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 05:35:16.452108 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 05:35:16.454262 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 5 05:35:16.456751 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 5 05:35:16.466873 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 05:35:16.469103 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 5 05:35:16.473605 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:35:16.478787 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:35:16.482112 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:35:16.487388 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 05:35:16.489674 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:35:16.489805 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:35:16.490873 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:35:16.491042 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:35:16.492762 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:35:16.492922 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:35:16.500295 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:35:16.502594 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:35:16.504906 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:35:16.505987 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:35:16.506150 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:35:16.508201 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 5 05:35:16.512093 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 5 05:35:16.514929 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 5 05:35:16.518726 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 5 05:35:16.520475 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 05:35:16.520692 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 05:35:16.523215 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:35:16.523367 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:35:16.524977 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:35:16.527900 augenrules[1324]: No rules Sep 5 05:35:16.533717 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:35:16.537465 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 05:35:16.537708 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 05:35:16.540367 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 5 05:35:16.550275 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 05:35:16.551222 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:35:16.552484 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:35:16.554570 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 05:35:16.560397 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:35:16.564699 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 05:35:16.565677 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:35:16.565808 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:35:16.568091 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 05:35:16.571354 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 5 05:35:16.572325 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 5 05:35:16.573754 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 5 05:35:16.575344 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:35:16.577570 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:35:16.579285 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 05:35:16.579467 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 05:35:16.582107 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:35:16.582315 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:35:16.583978 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 05:35:16.584152 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 05:35:16.586145 augenrules[1336]: /sbin/augenrules: No change Sep 5 05:35:16.587178 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 5 05:35:16.590573 systemd[1]: Finished ensure-sysext.service. Sep 5 05:35:16.596028 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 05:35:16.596091 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 05:35:16.596320 augenrules[1369]: No rules Sep 5 05:35:16.598039 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 5 05:35:16.599396 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 05:35:16.599664 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 05:35:16.602256 systemd-udevd[1349]: Using default interface naming scheme 'v255'. Sep 5 05:35:16.619564 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 05:35:16.623553 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 05:35:16.629808 systemd-resolved[1294]: Positive Trust Anchors: Sep 5 05:35:16.629823 systemd-resolved[1294]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 05:35:16.629862 systemd-resolved[1294]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 5 05:35:16.637142 systemd-resolved[1294]: Defaulting to hostname 'linux'. Sep 5 05:35:16.639209 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 05:35:16.640493 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 05:35:16.682715 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 5 05:35:16.714277 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 5 05:35:16.715840 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 05:35:16.716802 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 5 05:35:16.717840 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 5 05:35:16.719186 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 5 05:35:16.720254 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 5 05:35:16.720287 systemd[1]: Reached target paths.target - Path Units. Sep 5 05:35:16.721011 systemd[1]: Reached target time-set.target - System Time Set. Sep 5 05:35:16.721950 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 5 05:35:16.722873 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 5 05:35:16.723875 systemd[1]: Reached target timers.target - Timer Units. Sep 5 05:35:16.725320 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 5 05:35:16.727898 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 05:35:16.730828 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 5 05:35:16.732090 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 5 05:35:16.733294 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 5 05:35:16.736070 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 5 05:35:16.737560 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 5 05:35:16.739082 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 05:35:16.742039 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 05:35:16.743698 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 05:35:16.744493 systemd[1]: Reached target basic.target - Basic System. Sep 5 05:35:16.745255 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 5 05:35:16.745281 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 5 05:35:16.746326 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 5 05:35:16.749364 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 5 05:35:16.751839 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 5 05:35:16.754739 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 5 05:35:16.755510 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 5 05:35:16.761939 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 5 05:35:16.764636 jq[1420]: false Sep 5 05:35:16.764703 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 5 05:35:16.767105 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 5 05:35:16.769218 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 5 05:35:16.777299 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 5 05:35:16.779045 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 5 05:35:16.779502 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 5 05:35:16.781964 systemd[1]: Starting update-engine.service - Update Engine... Sep 5 05:35:16.785193 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 5 05:35:16.788338 extend-filesystems[1421]: Found /dev/vda6 Sep 5 05:35:16.789533 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 5 05:35:16.790785 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 5 05:35:16.790995 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 5 05:35:16.791257 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 5 05:35:16.791421 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 5 05:35:16.791890 extend-filesystems[1421]: Found /dev/vda9 Sep 5 05:35:16.798043 extend-filesystems[1421]: Checking size of /dev/vda9 Sep 5 05:35:16.813208 jq[1436]: true Sep 5 05:35:16.813556 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 5 05:35:16.816032 extend-filesystems[1421]: Old size kept for /dev/vda9 Sep 5 05:35:16.817172 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 5 05:35:16.817395 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 5 05:35:16.818084 systemd-networkd[1389]: lo: Link UP Sep 5 05:35:16.818299 systemd-networkd[1389]: lo: Gained carrier Sep 5 05:35:16.820328 dbus-daemon[1418]: [system] SELinux support is enabled Sep 5 05:35:16.818974 systemd[1]: motdgen.service: Deactivated successfully. Sep 5 05:35:16.819189 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 5 05:35:16.819801 systemd-networkd[1389]: Enumeration completed Sep 5 05:35:16.820270 systemd-networkd[1389]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:35:16.820273 systemd-networkd[1389]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 05:35:16.821864 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 05:35:16.822836 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 5 05:35:16.824958 update_engine[1433]: I20250905 05:35:16.824574 1433 main.cc:92] Flatcar Update Engine starting Sep 5 05:35:16.825479 systemd-networkd[1389]: eth0: Link UP Sep 5 05:35:16.827075 systemd-networkd[1389]: eth0: Gained carrier Sep 5 05:35:16.827095 systemd-networkd[1389]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:35:16.827679 systemd[1]: Reached target network.target - Network. Sep 5 05:35:16.827969 update_engine[1433]: I20250905 05:35:16.827822 1433 update_check_scheduler.cc:74] Next update check in 11m5s Sep 5 05:35:16.830020 systemd[1]: Starting containerd.service - containerd container runtime... Sep 5 05:35:16.831227 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 5 05:35:16.831259 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 5 05:35:16.837033 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 5 05:35:16.839419 jq[1462]: true Sep 5 05:35:16.840728 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 5 05:35:16.841767 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 5 05:35:16.841796 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 5 05:35:16.842721 systemd-networkd[1389]: eth0: DHCPv4 address 10.0.0.10/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 05:35:16.843586 systemd-timesyncd[1375]: Network configuration changed, trying to establish connection. Sep 5 05:35:16.844686 systemd-timesyncd[1375]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 5 05:35:16.844733 systemd-timesyncd[1375]: Initial clock synchronization to Fri 2025-09-05 05:35:16.960104 UTC. Sep 5 05:35:16.847580 systemd[1]: Started update-engine.service - Update Engine. Sep 5 05:35:16.853294 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 5 05:35:16.863381 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 5 05:35:16.866234 (ntainerd)[1478]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 5 05:35:16.890689 bash[1494]: Updated "/home/core/.ssh/authorized_keys" Sep 5 05:35:16.891746 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:35:16.894012 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 5 05:35:16.898218 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 5 05:35:16.989852 locksmithd[1476]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 5 05:35:16.996829 systemd-logind[1429]: Watching system buttons on /dev/input/event0 (Power Button) Sep 5 05:35:16.997128 systemd-logind[1429]: New seat seat0. Sep 5 05:35:16.998689 systemd[1]: Started systemd-logind.service - User Login Management. Sep 5 05:35:17.006567 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:35:17.054560 containerd[1478]: time="2025-09-05T05:35:17Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 5 05:35:17.055115 containerd[1478]: time="2025-09-05T05:35:17.055063674Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 5 05:35:17.064498 containerd[1478]: time="2025-09-05T05:35:17.064396458Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.677µs" Sep 5 05:35:17.064498 containerd[1478]: time="2025-09-05T05:35:17.064440373Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 5 05:35:17.064498 containerd[1478]: time="2025-09-05T05:35:17.064464868Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.064642381Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.064707971Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.064752409Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.064839836Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.064857080Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.065093615Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.065115694Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.065130359Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.065143493Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 5 05:35:17.065583 containerd[1478]: time="2025-09-05T05:35:17.065214804Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 5 05:35:17.066259 containerd[1478]: time="2025-09-05T05:35:17.066227625Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:35:17.066368 containerd[1478]: time="2025-09-05T05:35:17.066350425Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:35:17.066423 containerd[1478]: time="2025-09-05T05:35:17.066408602Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 5 05:35:17.066569 containerd[1478]: time="2025-09-05T05:35:17.066511137Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 5 05:35:17.066864 containerd[1478]: time="2025-09-05T05:35:17.066845534Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 5 05:35:17.066999 containerd[1478]: time="2025-09-05T05:35:17.066980663Z" level=info msg="metadata content store policy set" policy=shared Sep 5 05:35:17.070051 containerd[1478]: time="2025-09-05T05:35:17.070015378Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 5 05:35:17.070184 containerd[1478]: time="2025-09-05T05:35:17.070168435Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 5 05:35:17.070264 containerd[1478]: time="2025-09-05T05:35:17.070249295Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 5 05:35:17.070340 containerd[1478]: time="2025-09-05T05:35:17.070325158Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 5 05:35:17.070413 containerd[1478]: time="2025-09-05T05:35:17.070399531Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 5 05:35:17.070474 containerd[1478]: time="2025-09-05T05:35:17.070460206Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 5 05:35:17.070553 containerd[1478]: time="2025-09-05T05:35:17.070523339Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 5 05:35:17.070623 containerd[1478]: time="2025-09-05T05:35:17.070609759Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 5 05:35:17.070679 containerd[1478]: time="2025-09-05T05:35:17.070666042Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 5 05:35:17.070736 containerd[1478]: time="2025-09-05T05:35:17.070723131Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 5 05:35:17.070786 containerd[1478]: time="2025-09-05T05:35:17.070774177Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 5 05:35:17.070837 containerd[1478]: time="2025-09-05T05:35:17.070825102Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 5 05:35:17.071015 containerd[1478]: time="2025-09-05T05:35:17.070994074Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 5 05:35:17.071086 containerd[1478]: time="2025-09-05T05:35:17.071071025Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 5 05:35:17.071143 containerd[1478]: time="2025-09-05T05:35:17.071129847Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 5 05:35:17.071208 containerd[1478]: time="2025-09-05T05:35:17.071194994Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 5 05:35:17.071259 containerd[1478]: time="2025-09-05T05:35:17.071247369Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 5 05:35:17.071307 containerd[1478]: time="2025-09-05T05:35:17.071296320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 5 05:35:17.071428 containerd[1478]: time="2025-09-05T05:35:17.071410096Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 5 05:35:17.071493 containerd[1478]: time="2025-09-05T05:35:17.071479393Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 5 05:35:17.071575 containerd[1478]: time="2025-09-05T05:35:17.071562226Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 5 05:35:17.071629 containerd[1478]: time="2025-09-05T05:35:17.071616495Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 5 05:35:17.071679 containerd[1478]: time="2025-09-05T05:35:17.071667541Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 5 05:35:17.071925 containerd[1478]: time="2025-09-05T05:35:17.071907985Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 5 05:35:17.071986 containerd[1478]: time="2025-09-05T05:35:17.071973938Z" level=info msg="Start snapshots syncer" Sep 5 05:35:17.072062 containerd[1478]: time="2025-09-05T05:35:17.072048714Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 5 05:35:17.072354 containerd[1478]: time="2025-09-05T05:35:17.072311276Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 5 05:35:17.072520 containerd[1478]: time="2025-09-05T05:35:17.072501842Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 5 05:35:17.072719 containerd[1478]: time="2025-09-05T05:35:17.072699539Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 5 05:35:17.072906 containerd[1478]: time="2025-09-05T05:35:17.072883740Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 5 05:35:17.072981 containerd[1478]: time="2025-09-05T05:35:17.072966735Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 5 05:35:17.073031 containerd[1478]: time="2025-09-05T05:35:17.073019513Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 5 05:35:17.073088 containerd[1478]: time="2025-09-05T05:35:17.073075192Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 5 05:35:17.073152 containerd[1478]: time="2025-09-05T05:35:17.073139211Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 5 05:35:17.073204 containerd[1478]: time="2025-09-05T05:35:17.073191788Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 5 05:35:17.073263 containerd[1478]: time="2025-09-05T05:35:17.073250650Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 5 05:35:17.073339 containerd[1478]: time="2025-09-05T05:35:17.073325789Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 5 05:35:17.073412 containerd[1478]: time="2025-09-05T05:35:17.073398671Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 5 05:35:17.073469 containerd[1478]: time="2025-09-05T05:35:17.073453263Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 5 05:35:17.073616 containerd[1478]: time="2025-09-05T05:35:17.073562123Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:35:17.073616 containerd[1478]: time="2025-09-05T05:35:17.073582912Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:35:17.073616 containerd[1478]: time="2025-09-05T05:35:17.073593145Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073602855Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073778917Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073801680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073815660Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073891685Z" level=info msg="runtime interface created" Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073897406Z" level=info msg="created NRI interface" Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073905948Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073917309Z" level=info msg="Connect containerd service" Sep 5 05:35:17.073975 containerd[1478]: time="2025-09-05T05:35:17.073943295Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 5 05:35:17.075088 containerd[1478]: time="2025-09-05T05:35:17.075055388Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 5 05:35:17.143855 containerd[1478]: time="2025-09-05T05:35:17.143709100Z" level=info msg="Start subscribing containerd event" Sep 5 05:35:17.143855 containerd[1478]: time="2025-09-05T05:35:17.143799025Z" level=info msg="Start recovering state" Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143903897Z" level=info msg="Start event monitor" Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143931293Z" level=info msg="Start cni network conf syncer for default" Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143938666Z" level=info msg="Start streaming server" Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143947570Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143955104Z" level=info msg="runtime interface starting up..." Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143961308Z" level=info msg="starting plugins..." Sep 5 05:35:17.144002 containerd[1478]: time="2025-09-05T05:35:17.143975812Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 5 05:35:17.144372 containerd[1478]: time="2025-09-05T05:35:17.144268591Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 5 05:35:17.144372 containerd[1478]: time="2025-09-05T05:35:17.144334101Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 5 05:35:17.144490 containerd[1478]: time="2025-09-05T05:35:17.144477046Z" level=info msg="containerd successfully booted in 0.090380s" Sep 5 05:35:17.144675 systemd[1]: Started containerd.service - containerd container runtime. Sep 5 05:35:17.871945 sshd_keygen[1439]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 5 05:35:17.891601 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 5 05:35:17.893935 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 5 05:35:17.914612 systemd[1]: issuegen.service: Deactivated successfully. Sep 5 05:35:17.914818 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 5 05:35:17.917054 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 5 05:35:17.936667 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 5 05:35:17.938966 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 5 05:35:17.940775 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 5 05:35:17.941821 systemd[1]: Reached target getty.target - Login Prompts. Sep 5 05:35:17.978669 systemd-networkd[1389]: eth0: Gained IPv6LL Sep 5 05:35:17.980698 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 5 05:35:17.982060 systemd[1]: Reached target network-online.target - Network is Online. Sep 5 05:35:17.984036 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 5 05:35:17.985759 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 5 05:35:18.019591 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 5 05:35:18.020765 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 5 05:35:18.020942 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 5 05:35:18.023687 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 5 05:35:18.024562 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 5 05:35:18.042189 (-wrapper)[1560]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 5 05:35:18.141009 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 5 05:35:18.154826 (dockerd)[1572]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 5 05:35:18.349438 dockerd[1572]: time="2025-09-05T05:35:18.349379697Z" level=info msg="Starting up" Sep 5 05:35:18.350210 dockerd[1572]: time="2025-09-05T05:35:18.350189542Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 5 05:35:18.359609 dockerd[1572]: time="2025-09-05T05:35:18.359571503Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 5 05:35:18.388122 dockerd[1572]: time="2025-09-05T05:35:18.387959734Z" level=info msg="Loading containers: start." Sep 5 05:35:18.395547 kernel: Initializing XFRM netlink socket Sep 5 05:35:18.570795 systemd-networkd[1389]: docker0: Link UP Sep 5 05:35:18.573765 dockerd[1572]: time="2025-09-05T05:35:18.573724059Z" level=info msg="Loading containers: done." Sep 5 05:35:18.585361 dockerd[1572]: time="2025-09-05T05:35:18.585323529Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 5 05:35:18.585489 dockerd[1572]: time="2025-09-05T05:35:18.585401010Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 5 05:35:18.585489 dockerd[1572]: time="2025-09-05T05:35:18.585474182Z" level=info msg="Initializing buildkit" Sep 5 05:35:18.606587 dockerd[1572]: time="2025-09-05T05:35:18.606542840Z" level=info msg="Completed buildkit initialization" Sep 5 05:35:18.611102 dockerd[1572]: time="2025-09-05T05:35:18.611051071Z" level=info msg="Daemon has completed initialization" Sep 5 05:35:18.612245 dockerd[1572]: time="2025-09-05T05:35:18.611139022Z" level=info msg="API listen on /run/docker.sock" Sep 5 05:35:18.611306 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 5 05:35:18.613476 etcd-wrapper[1564]: Error response from daemon: No such container: etcd-member Sep 5 05:35:18.627632 etcd-wrapper[1770]: Error response from daemon: No such container: etcd-member Sep 5 05:35:18.652103 etcd-wrapper[1793]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally Sep 5 05:35:19.283531 etcd-wrapper[1793]: v3.5.0: Pulling from coreos/etcd Sep 5 05:35:19.369636 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck740139080-merged.mount: Deactivated successfully. Sep 5 05:35:19.489206 etcd-wrapper[1793]: 6022c6b01d76: Pulling fs layer Sep 5 05:35:19.489206 etcd-wrapper[1793]: 1d97b1ec77fc: Pulling fs layer Sep 5 05:35:19.489206 etcd-wrapper[1793]: 99ef4b690837: Pulling fs layer Sep 5 05:35:19.489206 etcd-wrapper[1793]: 435b7bf0967c: Pulling fs layer Sep 5 05:35:19.489206 etcd-wrapper[1793]: 17e4a5f7c1b5: Pulling fs layer Sep 5 05:35:19.489206 etcd-wrapper[1793]: 5b0292999756: Pulling fs layer Sep 5 05:35:19.489440 etcd-wrapper[1793]: 435b7bf0967c: Waiting Sep 5 05:35:19.489440 etcd-wrapper[1793]: 17e4a5f7c1b5: Waiting Sep 5 05:35:19.489440 etcd-wrapper[1793]: 5b0292999756: Waiting Sep 5 05:35:19.914956 etcd-wrapper[1793]: 99ef4b690837: Verifying Checksum Sep 5 05:35:19.914956 etcd-wrapper[1793]: 99ef4b690837: Download complete Sep 5 05:35:20.022839 etcd-wrapper[1793]: 1d97b1ec77fc: Verifying Checksum Sep 5 05:35:20.022839 etcd-wrapper[1793]: 1d97b1ec77fc: Download complete Sep 5 05:35:20.285891 etcd-wrapper[1793]: 435b7bf0967c: Verifying Checksum Sep 5 05:35:20.285891 etcd-wrapper[1793]: 435b7bf0967c: Download complete Sep 5 05:35:20.303503 etcd-wrapper[1793]: 17e4a5f7c1b5: Download complete Sep 5 05:35:20.419456 etcd-wrapper[1793]: 6022c6b01d76: Verifying Checksum Sep 5 05:35:20.419456 etcd-wrapper[1793]: 6022c6b01d76: Download complete Sep 5 05:35:20.531718 etcd-wrapper[1793]: 5b0292999756: Verifying Checksum Sep 5 05:35:20.531718 etcd-wrapper[1793]: 5b0292999756: Download complete Sep 5 05:35:20.963668 etcd-wrapper[1793]: 6022c6b01d76: Pull complete Sep 5 05:35:21.052039 systemd[1]: var-lib-docker-overlay2-b6acf4c0b7e78b7f2a6fe5e855d985c27c107f36f39ddf0dd8832e35dc9f7026-merged.mount: Deactivated successfully. Sep 5 05:35:21.193013 etcd-wrapper[1793]: 1d97b1ec77fc: Pull complete Sep 5 05:35:21.279474 systemd[1]: var-lib-docker-overlay2-0c1b34488e6078fd4d88b112bb63912b4397dd685ce726b3b82ffac524888579-merged.mount: Deactivated successfully. Sep 5 05:35:21.309690 etcd-wrapper[1793]: 99ef4b690837: Pull complete Sep 5 05:35:21.412921 etcd-wrapper[1793]: 435b7bf0967c: Pull complete Sep 5 05:35:21.437828 etcd-wrapper[1793]: 17e4a5f7c1b5: Pull complete Sep 5 05:35:21.471843 etcd-wrapper[1793]: 5b0292999756: Pull complete Sep 5 05:35:21.480643 etcd-wrapper[1793]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b Sep 5 05:35:21.483351 etcd-wrapper[1793]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 Sep 5 05:35:21.551518 containerd[1478]: time="2025-09-05T05:35:21.550854973Z" level=info msg="connecting to shim ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3" address="unix:///run/containerd/s/674a71c1a7114ae6dd741a429b1ae0699381730ee9a5a4580327ea61e746c7e5" namespace=moby protocol=ttrpc version=3 Sep 5 05:35:21.582708 systemd[1]: Started docker-ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3.scope - libcontainer container ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3. Sep 5 05:35:21.596078 systemd-resolved[1294]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:35:21.639065 etcd-wrapper[1793]: {"level":"info","ts":1757050521.6388085,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 5 05:35:21.639065 etcd-wrapper[1793]: {"level":"info","ts":1757050521.6388917,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"3268b321dfc847ec9fa14e92197cd97a"} Sep 5 05:35:21.639242 etcd-wrapper[1793]: {"level":"warn","ts":1757050521.638918,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 5 05:35:21.639242 etcd-wrapper[1793]: {"level":"warn","ts":1757050521.6389308,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Sep 5 05:35:21.639242 etcd-wrapper[1793]: {"level":"warn","ts":1757050521.6389377,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 5 05:35:21.639242 etcd-wrapper[1793]: {"level":"warn","ts":1757050521.638942,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 5 05:35:21.639242 etcd-wrapper[1793]: {"level":"warn","ts":1757050521.638947,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Sep 5 05:35:21.639841 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.639Z","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:36881/v2/keys/discovery/6002096040267097846","--enable-v2=true"]} Sep 5 05:35:21.639999 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.639Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.10:2380"]} Sep 5 05:35:21.640268 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.640Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 5 05:35:21.640548 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.640Z","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":"3268b321dfc847ec9fa14e92197cd97a","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":"3268b321dfc847ec9fa14e92197cd97a=http://10.0.0.10:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:36881/v2/keys/discovery/6002096040267097846","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:36881/v2/keys/discovery/6002096040267097846","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 5 05:35:21.642296 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.642Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.313244ms"} Sep 5 05:35:21.651824 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.651Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:36881","self":"40302e15c63acf7c"} Sep 5 05:35:21.651824 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.651Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:36881","found-peers":1,"needed-peers":2} Sep 5 05:35:21.904188 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.903Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:36881","peer":"7681c2b43c002c53"} Sep 5 05:35:21.904188 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:21.903Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:36881","found-peers":2,"needed-peers":1} Sep 5 05:35:21.971852 systemd[1]: var-lib-docker-overlay2-0da442b330e16e36540bfa2def0e307f0f0bf28bb54125c494780177704973e9-merged.mount: Deactivated successfully. Sep 5 05:35:22.684147 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.682Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:36881","peer":"660549d949ca3c97"} Sep 5 05:35:22.684147 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.683Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:36881","found-peers":3} Sep 5 05:35:22.686326 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"40302e15c63acf7c","cluster-id":"708259549588bf78"} Sep 5 05:35:22.686508 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=()"} Sep 5 05:35:22.686508 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became follower at term 0"} Sep 5 05:35:22.686508 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 40302e15c63acf7c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 5 05:35:22.686508 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became follower at term 1"} Sep 5 05:35:22.686508 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276)"} Sep 5 05:35:22.686508 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183)"} Sep 5 05:35:22.686843 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183 8539320447827717203)"} Sep 5 05:35:22.687366 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:22.687Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Sep 5 05:35:22.688372 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.688Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Sep 5 05:35:22.689013 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.688Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Sep 5 05:35:22.689554 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.689Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.689554 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.689Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.690605 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.690Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.691670 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.691762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.691762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.691762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97","remote-peer-urls":["http://10.0.0.12:2380"]} Sep 5 05:35:22.691762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.691762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.691762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.691Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.693549 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.692Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.693549 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.693Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.693962 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.693Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.693962 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.693Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.693962 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.693Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53","remote-peer-urls":["http://10.0.0.11:2380"]} Sep 5 05:35:22.693962 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.693Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"40302e15c63acf7c","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Sep 5 05:35:22.693962 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.693Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.694324 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.694Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Sep 5 05:35:22.695364 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183 8539320447827717203)"} Sep 5 05:35:22.695364 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.694Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","added-peer-id":"40302e15c63acf7c","added-peer-peer-urls":["http://10.0.0.10:2380"]} Sep 5 05:35:22.695364 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183 8539320447827717203)"} Sep 5 05:35:22.695364 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.695Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","added-peer-id":"660549d949ca3c97","added-peer-peer-urls":["http://10.0.0.12:2380"]} Sep 5 05:35:22.695364 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183 8539320447827717203)"} Sep 5 05:35:22.695364 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.695Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","added-peer-id":"7681c2b43c002c53","added-peer-peer-urls":["http://10.0.0.11:2380"]} Sep 5 05:35:22.695762 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:22.695Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Sep 5 05:35:22.695762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.695Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.10:2380"} Sep 5 05:35:22.695762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.695Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"40302e15c63acf7c","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 5 05:35:22.695762 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.695Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.10:2380"} Sep 5 05:35:22.696227 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"7681c2b43c002c53","stream-type":"stream Message"} Sep 5 05:35:22.696227 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.696227 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.696227 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"660549d949ca3c97","stream-type":"stream Message"} Sep 5 05:35:22.696227 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"660549d949ca3c97"} Sep 5 05:35:22.696227 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.697101 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"660549d949ca3c97","stream-type":"stream MsgApp v2"} Sep 5 05:35:22.697101 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.697101 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.697101 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"7681c2b43c002c53","stream-type":"stream MsgApp v2"} Sep 5 05:35:22.697101 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.697101 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.696Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:22.701205 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.700Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.701384 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.701Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:22.744769 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.744Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"40302e15c63acf7c","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Sep 5 05:35:22.889489 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 660549d949ca3c97 [logterm: 1, index: 3] at term 1"} Sep 5 05:35:22.890550 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.890Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [term: 1] received a MsgVote message with higher term from 660549d949ca3c97 [term: 2]"} Sep 5 05:35:22.890550 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.890Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became follower at term 2"} Sep 5 05:35:22.890550 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.890Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [logterm: 1, index: 3, vote: 0] cast MsgVote for 660549d949ca3c97 [logterm: 1, index: 3] at term 2"} Sep 5 05:35:22.891294 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40302e15c63acf7c elected leader 660549d949ca3c97 at term 2"} Sep 5 05:35:22.895109 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.894Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"40302e15c63acf7c","local-member-attributes":"{Name:3268b321dfc847ec9fa14e92197cd97a ClientURLs:[http://10.0.0.10:2379]}","request-path":"/0/members/40302e15c63acf7c/attributes","cluster-id":"708259549588bf78","publish-timeout":"7s"} Sep 5 05:35:22.895290 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.895Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Sep 5 05:35:22.895442 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.895Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Sep 5 05:35:22.895641 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 5 05:35:22.896658 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.895Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Sep 5 05:35:22.897011 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.896Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","cluster-version":"3.5"} Sep 5 05:35:22.897064 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.896Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 5 05:35:22.898659 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:22.898Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Sep 5 05:35:22.899016 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Sep 5 05:35:22.974661 etcdctl[1893]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Sep 5 05:35:23.010000 flannel-wrapper[1909]: Error response from daemon: No such container: flannel Sep 5 05:35:23.023148 flannel-wrapper[1918]: Error response from daemon: No such container: flannel Sep 5 05:35:23.037673 flannel-wrapper[1938]: Unable to find image 'quay.io/coreos/flannel:v0.14.0-arm64' locally Sep 5 05:35:23.680558 flannel-wrapper[1938]: v0.14.0-arm64: Pulling from coreos/flannel Sep 5 05:35:23.680558 flannel-wrapper[1938]: b538f80385f9: Pulling fs layer Sep 5 05:35:23.680558 flannel-wrapper[1938]: 782376d11ccb: Pulling fs layer Sep 5 05:35:23.680558 flannel-wrapper[1938]: ab023a03e512: Pulling fs layer Sep 5 05:35:23.680558 flannel-wrapper[1938]: 1ce603871d35: Pulling fs layer Sep 5 05:35:23.680848 flannel-wrapper[1938]: 2ff40439b6d5: Pulling fs layer Sep 5 05:35:23.680848 flannel-wrapper[1938]: f6c30695e556: Pulling fs layer Sep 5 05:35:23.680848 flannel-wrapper[1938]: 071b96dd834b: Pulling fs layer Sep 5 05:35:23.680848 flannel-wrapper[1938]: e9e292d9edba: Pulling fs layer Sep 5 05:35:23.680848 flannel-wrapper[1938]: 2ff40439b6d5: Waiting Sep 5 05:35:23.680848 flannel-wrapper[1938]: f6c30695e556: Waiting Sep 5 05:35:23.680848 flannel-wrapper[1938]: e9e292d9edba: Waiting Sep 5 05:35:23.680848 flannel-wrapper[1938]: 071b96dd834b: Waiting Sep 5 05:35:23.681064 flannel-wrapper[1938]: 1ce603871d35: Waiting Sep 5 05:35:23.953025 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 5 05:35:23.954117 systemd[1]: Started sshd@0-10.0.0.10:22-10.0.0.1:57544.service - OpenSSH per-connection server daemon (10.0.0.1:57544). Sep 5 05:35:24.037334 sshd[1950]: Accepted publickey for core from 10.0.0.1 port 57544 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:24.039465 sshd-session[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:24.046947 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 5 05:35:24.047997 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 5 05:35:24.055766 systemd-logind[1429]: New session 1 of user core. Sep 5 05:35:24.078019 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 5 05:35:24.080609 flannel-wrapper[1938]: 782376d11ccb: Verifying Checksum Sep 5 05:35:24.080609 flannel-wrapper[1938]: 782376d11ccb: Download complete Sep 5 05:35:24.081642 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 5 05:35:24.101652 (systemd)[1955]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 5 05:35:24.103916 systemd-logind[1429]: New session c1 of user core. Sep 5 05:35:24.112180 flannel-wrapper[1938]: ab023a03e512: Verifying Checksum Sep 5 05:35:24.112180 flannel-wrapper[1938]: ab023a03e512: Download complete Sep 5 05:35:24.181490 flannel-wrapper[1938]: b538f80385f9: Verifying Checksum Sep 5 05:35:24.182684 flannel-wrapper[1938]: b538f80385f9: Download complete Sep 5 05:35:24.209097 systemd[1955]: Queued start job for default target default.target. Sep 5 05:35:24.223415 systemd[1955]: Created slice app.slice - User Application Slice. Sep 5 05:35:24.223444 systemd[1955]: Reached target paths.target - Paths. Sep 5 05:35:24.223480 systemd[1955]: Reached target timers.target - Timers. Sep 5 05:35:24.224678 systemd[1955]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 5 05:35:24.235102 systemd[1955]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 5 05:35:24.235203 systemd[1955]: Reached target sockets.target - Sockets. Sep 5 05:35:24.235245 systemd[1955]: Reached target basic.target - Basic System. Sep 5 05:35:24.235272 systemd[1955]: Reached target default.target - Main User Target. Sep 5 05:35:24.235297 systemd[1955]: Startup finished in 125ms. Sep 5 05:35:24.235358 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 5 05:35:24.236671 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 5 05:35:24.259348 flannel-wrapper[1938]: b538f80385f9: Pull complete Sep 5 05:35:24.301313 systemd[1]: Started sshd@1-10.0.0.10:22-10.0.0.1:57560.service - OpenSSH per-connection server daemon (10.0.0.1:57560). Sep 5 05:35:24.302614 systemd[1]: var-lib-docker-overlay2-988532ae37f51bac2bf24ddd1c9925e85f843a7c5838b1f758efb787cbf9e47c-merged.mount: Deactivated successfully. Sep 5 05:35:24.342356 flannel-wrapper[1938]: 782376d11ccb: Pull complete Sep 5 05:35:24.357826 sshd[1976]: Accepted publickey for core from 10.0.0.1 port 57560 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:24.359357 sshd-session[1976]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:24.366404 systemd-logind[1429]: New session 2 of user core. Sep 5 05:35:24.373671 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 5 05:35:24.429846 sshd[1984]: Connection closed by 10.0.0.1 port 57560 Sep 5 05:35:24.429922 sshd-session[1976]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:24.433056 flannel-wrapper[1938]: f6c30695e556: Verifying Checksum Sep 5 05:35:24.433056 flannel-wrapper[1938]: f6c30695e556: Download complete Sep 5 05:35:24.440029 systemd[1]: sshd@1-10.0.0.10:22-10.0.0.1:57560.service: Deactivated successfully. Sep 5 05:35:24.442116 systemd[1]: session-2.scope: Deactivated successfully. Sep 5 05:35:24.443362 systemd-logind[1429]: Session 2 logged out. Waiting for processes to exit. Sep 5 05:35:24.444720 flannel-wrapper[1938]: 1ce603871d35: Verifying Checksum Sep 5 05:35:24.444720 flannel-wrapper[1938]: 1ce603871d35: Download complete Sep 5 05:35:24.446228 systemd[1]: Started sshd@2-10.0.0.10:22-10.0.0.1:57566.service - OpenSSH per-connection server daemon (10.0.0.1:57566). Sep 5 05:35:24.448519 systemd-logind[1429]: Removed session 2. Sep 5 05:35:24.505787 sshd[1990]: Accepted publickey for core from 10.0.0.1 port 57566 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:24.507611 sshd-session[1990]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:24.512684 systemd-logind[1429]: New session 3 of user core. Sep 5 05:35:24.517669 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 5 05:35:24.573885 sshd[1993]: Connection closed by 10.0.0.1 port 57566 Sep 5 05:35:24.574340 sshd-session[1990]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:24.578416 systemd[1]: sshd@2-10.0.0.10:22-10.0.0.1:57566.service: Deactivated successfully. Sep 5 05:35:24.581511 systemd[1]: session-3.scope: Deactivated successfully. Sep 5 05:35:24.584459 systemd-logind[1429]: Session 3 logged out. Waiting for processes to exit. Sep 5 05:35:24.586017 systemd-logind[1429]: Removed session 3. Sep 5 05:35:24.602630 systemd[1]: var-lib-docker-overlay2-9e8cd334834b1ca45e2208b8657138d0c40ac736f692479a79076c5f7dc4e4b8-merged.mount: Deactivated successfully. Sep 5 05:35:24.613928 flannel-wrapper[1938]: 2ff40439b6d5: Verifying Checksum Sep 5 05:35:24.614080 flannel-wrapper[1938]: 2ff40439b6d5: Download complete Sep 5 05:35:24.656247 flannel-wrapper[1938]: ab023a03e512: Pull complete Sep 5 05:35:24.693389 flannel-wrapper[1938]: 071b96dd834b: Verifying Checksum Sep 5 05:35:24.693582 flannel-wrapper[1938]: 071b96dd834b: Download complete Sep 5 05:35:24.711144 flannel-wrapper[1938]: 1ce603871d35: Pull complete Sep 5 05:35:24.746431 flannel-wrapper[1938]: e9e292d9edba: Verifying Checksum Sep 5 05:35:24.746431 flannel-wrapper[1938]: e9e292d9edba: Download complete Sep 5 05:35:24.956087 flannel-wrapper[1938]: 2ff40439b6d5: Pull complete Sep 5 05:35:24.976435 flannel-wrapper[1938]: f6c30695e556: Pull complete Sep 5 05:35:24.993248 flannel-wrapper[1938]: 071b96dd834b: Pull complete Sep 5 05:35:25.009189 flannel-wrapper[1938]: e9e292d9edba: Pull complete Sep 5 05:35:25.014191 flannel-wrapper[1938]: Digest: sha256:dad4e92d4eb00d129a664ac7b44a71a5cbadea8a7f11b5b239e1e2b2701baac6 Sep 5 05:35:25.016104 flannel-wrapper[1938]: Status: Downloaded newer image for quay.io/coreos/flannel:v0.14.0-arm64 Sep 5 05:35:25.053247 containerd[1478]: time="2025-09-05T05:35:25.052935043Z" level=info msg="connecting to shim 4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f" address="unix:///run/containerd/s/a8c068f51f3b2740830bd746633b71e68853e8613078c180f8c2eb440256df7b" namespace=moby protocol=ttrpc version=3 Sep 5 05:35:25.075698 systemd[1]: Started docker-4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f.scope - libcontainer container 4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f. Sep 5 05:35:25.089827 systemd-resolved[1294]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:35:25.131564 flannel-wrapper[1938]: I0905 05:35:25.131289 1 main.go:520] Determining IP address of default interface Sep 5 05:35:25.132218 flannel-wrapper[1938]: I0905 05:35:25.132070 1 main.go:533] Using interface with name eth0 and address 10.0.0.10 Sep 5 05:35:25.132218 flannel-wrapper[1938]: I0905 05:35:25.132095 1 main.go:550] Defaulting external address to interface address (10.0.0.10) Sep 5 05:35:25.132601 flannel-wrapper[1938]: I0905 05:35:25.132465 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: None Sep 5 05:35:25.132601 flannel-wrapper[1938]: I0905 05:35:25.132481 1 main.go:257] Installing signal handlers Sep 5 05:35:25.135570 flannel-wrapper[1938]: I0905 05:35:25.135170 1 main.go:392] Found network config - Backend type: vxlan Sep 5 05:35:25.135570 flannel-wrapper[1938]: I0905 05:35:25.135212 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Sep 5 05:35:25.149257 flannel-wrapper[1938]: I0905 05:35:25.149051 1 local_manager.go:234] Picking subnet in range 10.254.1.0 ... 10.254.255.0 Sep 5 05:35:25.150943 flannel-wrapper[1938]: I0905 05:35:25.150700 1 local_manager.go:220] Allocated lease (10.254.18.0/24) to current node (10.0.0.10) Sep 5 05:35:25.151609 systemd-networkd[1389]: flannel.1: Link UP Sep 5 05:35:25.151615 systemd-networkd[1389]: flannel.1: Gained carrier Sep 5 05:35:25.152084 flannel-wrapper[1938]: I0905 05:35:25.151279 1 main.go:357] Current network or subnet (10.254.0.0/16, 10.254.18.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 5 05:35:25.166259 flannel-wrapper[1938]: I0905 05:35:25.166095 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Sep 5 05:35:25.167676 flannel-wrapper[1938]: I0905 05:35:25.167516 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Sep 5 05:35:25.168790 flannel-wrapper[1938]: I0905 05:35:25.168653 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Sep 5 05:35:25.169819 flannel-wrapper[1938]: I0905 05:35:25.169661 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j MASQUERADE --random-fully Sep 5 05:35:25.170601 flannel-wrapper[1938]: I0905 05:35:25.170482 1 main.go:307] Setting up masking rules Sep 5 05:35:25.172210 flannel-wrapper[1938]: I0905 05:35:25.172056 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Sep 5 05:35:25.172298 flannel-wrapper[1938]: I0905 05:35:25.172145 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Sep 5 05:35:25.172298 flannel-wrapper[1938]: I0905 05:35:25.172211 1 main.go:327] Running backend. Sep 5 05:35:25.172636 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Sep 5 05:35:25.173154 flannel-wrapper[1938]: I0905 05:35:25.172791 1 vxlan_network.go:59] watching for new subnet leases Sep 5 05:35:25.173056 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 5 05:35:25.174777 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Sep 5 05:35:25.176266 flannel-wrapper[1938]: I0905 05:35:25.175949 1 main.go:439] Waiting for 22h59m59.973338501s to renew lease Sep 5 05:35:25.177563 flannel-wrapper[1938]: I0905 05:35:25.177354 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Sep 5 05:35:25.177563 flannel-wrapper[1938]: I0905 05:35:25.177366 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Sep 5 05:35:25.178588 flannel-wrapper[1938]: I0905 05:35:25.177915 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Sep 5 05:35:25.178588 flannel-wrapper[1938]: I0905 05:35:25.177964 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -j ACCEPT Sep 5 05:35:25.178740 flannel-wrapper[1938]: I0905 05:35:25.178639 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Sep 5 05:35:25.179582 flannel-wrapper[1938]: I0905 05:35:25.179448 1 iptables.go:172] Deleting iptables rule: -d 10.254.0.0/16 -j ACCEPT Sep 5 05:35:25.179743 flannel-wrapper[1938]: I0905 05:35:25.179658 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.18.0/24 -j RETURN Sep 5 05:35:25.180945 flannel-wrapper[1938]: I0905 05:35:25.180675 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Sep 5 05:35:25.180945 flannel-wrapper[1938]: I0905 05:35:25.180700 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -j ACCEPT Sep 5 05:35:25.181847 flannel-wrapper[1938]: I0905 05:35:25.181703 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Sep 5 05:35:25.183753 flannel-wrapper[1938]: I0905 05:35:25.182967 1 iptables.go:160] Adding iptables rule: -d 10.254.0.0/16 -j ACCEPT Sep 5 05:35:25.184038 flannel-wrapper[1938]: I0905 05:35:25.183877 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Sep 5 05:35:25.186375 flannel-wrapper[1938]: I0905 05:35:25.186202 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.18.0/24 -j RETURN Sep 5 05:35:25.187512 sh[2110]: + for try in 1 2 3 4 5 6 Sep 5 05:35:25.187794 sh[2110]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Sep 5 05:35:25.188731 flannel-wrapper[1938]: I0905 05:35:25.187960 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Sep 5 05:35:25.202420 sh[2135]: Error response from daemon: No such container: flannel-docker-opts Sep 5 05:35:25.215592 sh[2145]: Error response from daemon: No such container: flannel-docker-opts Sep 5 05:35:25.237939 systemd[1]: var-lib-docker-overlay2-5f591c990c546a7acaef6d2fbb5d81d75467a4e908a68c6b8acddb5299fde4ff\x2dinit-merged.mount: Deactivated successfully. Sep 5 05:35:25.270241 containerd[1478]: time="2025-09-05T05:35:25.270186626Z" level=info msg="connecting to shim 0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909" address="unix:///run/containerd/s/1bfa5ea2bd43df4c70b48e509567340feb7b7d9c0671eaa586e9cd80502afd94" namespace=moby protocol=ttrpc version=3 Sep 5 05:35:25.296699 systemd[1]: Started docker-0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909.scope - libcontainer container 0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909. Sep 5 05:35:25.310736 systemd-resolved[1294]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:35:25.332812 systemd[1]: docker-0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909.scope: Deactivated successfully. Sep 5 05:35:25.347192 containerd[1478]: time="2025-09-05T05:35:25.347158119Z" level=info msg="shim disconnected" id=0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909 namespace=moby Sep 5 05:35:25.347544 dockerd[1572]: time="2025-09-05T05:35:25.347351026Z" level=info msg="ignoring event" container=0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 5 05:35:25.347797 containerd[1478]: time="2025-09-05T05:35:25.347411084Z" level=warning msg="cleaning up after shim disconnected" id=0c29e2112c049085e88aad188115bc4541220c1221920cd46d977c65ead8b909 namespace=moby Sep 5 05:35:25.347797 containerd[1478]: time="2025-09-05T05:35:25.347454189Z" level=info msg="cleaning up dead shim" namespace=moby Sep 5 05:35:25.377169 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 5 05:35:25.377658 dockerd[1572]: time="2025-09-05T05:35:25.377624059Z" level=info msg="Processing signal 'terminated'" Sep 5 05:35:25.384981 flannel-wrapper[1938]: I0905 05:35:25.384085 1 main.go:376] shutdownHandler sent cancel signal... Sep 5 05:35:25.384981 flannel-wrapper[1938]: I0905 05:35:25.384185 1 watch.go:40] context canceled, close receiver chan Sep 5 05:35:25.384981 flannel-wrapper[1938]: I0905 05:35:25.384196 1 vxlan_network.go:74] evts chan closed Sep 5 05:35:25.384981 flannel-wrapper[1938]: I0905 05:35:25.384210 1 watch.go:174] context canceled, close receiver chan Sep 5 05:35:25.385145 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.383Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} Sep 5 05:35:25.385145 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.383Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"3268b321dfc847ec9fa14e92197cd97a","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"]} Sep 5 05:35:25.386121 flannel-wrapper[1938]: I0905 05:35:25.384228 1 main.go:432] Stopped monitoring lease Sep 5 05:35:25.386121 flannel-wrapper[1938]: I0905 05:35:25.384236 1 main.go:345] Waiting for all goroutines to exit Sep 5 05:35:25.386121 flannel-wrapper[1938]: I0905 05:35:25.384241 1 main.go:348] Exiting cleanly... Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.385Z","caller":"etcdserver/server.go:1429","msg":"skipped leadership transfer; local server is not leader","local-member-id":"40302e15c63acf7c","current-leader-member-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: WARNING: 2025/09/05 05:35:25 [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 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.385Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.388625 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97","error":"context canceled"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"660549d949ca3c97","error":"failed to read 660549d949ca3c97 on stream MsgApp v2 (context canceled)"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97","error":"context canceled"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.386Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389427 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53","error":"context canceled"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"7681c2b43c002c53","error":"failed to read 7681c2b43c002c53 on stream MsgApp v2 (context canceled)"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53","error":"context canceled"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.389667 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"40302e15c63acf7c","remote-peer-id-stream-handler":"40302e15c63acf7c","remote-peer-id-from":"660549d949ca3c97","cluster-id":"708259549588bf78"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.387Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"40302e15c63acf7c","remote-peer-id-stream-handler":"40302e15c63acf7c","remote-peer-id-from":"7681c2b43c002c53","cluster-id":"708259549588bf78"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.388Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"40302e15c63acf7c","remote-peer-id-stream-handler":"40302e15c63acf7c","remote-peer-id-from":"7681c2b43c002c53","cluster-id":"708259549588bf78"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.388Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"10.0.0.10:2380"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"warn","ts":"2025-09-05T05:35:25.388Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"40302e15c63acf7c","remote-peer-id-stream-handler":"40302e15c63acf7c","remote-peer-id-from":"660549d949ca3c97","cluster-id":"708259549588bf78"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.389Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"10.0.0.10:2380"} Sep 5 05:35:25.391439 etcd-wrapper[1793]: {"level":"info","ts":"2025-09-05T05:35:25.389Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"3268b321dfc847ec9fa14e92197cd97a","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"]} Sep 5 05:35:25.390836 systemd[1]: docker-4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f.scope: Deactivated successfully. Sep 5 05:35:25.392925 systemd[1]: docker-ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3.scope: Deactivated successfully. Sep 5 05:35:25.404362 containerd[1478]: time="2025-09-05T05:35:25.404315005Z" level=info msg="shim disconnected" id=4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f namespace=moby Sep 5 05:35:25.404362 containerd[1478]: time="2025-09-05T05:35:25.404350598Z" level=warning msg="cleaning up after shim disconnected" id=4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f namespace=moby Sep 5 05:35:25.404362 containerd[1478]: time="2025-09-05T05:35:25.404358592Z" level=info msg="cleaning up dead shim" namespace=moby Sep 5 05:35:25.404681 dockerd[1572]: time="2025-09-05T05:35:25.404634616Z" level=info msg="ignoring event" container=4887f77ee8fee78a102312dc1b24d44ce53299e70a3d3c8bbf2899621133615f module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 5 05:35:25.408112 containerd[1478]: time="2025-09-05T05:35:25.408079234Z" level=info msg="shim disconnected" id=ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3 namespace=moby Sep 5 05:35:25.408112 containerd[1478]: time="2025-09-05T05:35:25.408108399Z" level=warning msg="cleaning up after shim disconnected" id=ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3 namespace=moby Sep 5 05:35:25.408112 containerd[1478]: time="2025-09-05T05:35:25.408117518Z" level=info msg="cleaning up dead shim" namespace=moby Sep 5 05:35:25.408475 dockerd[1572]: time="2025-09-05T05:35:25.408439299Z" level=info msg="ignoring event" container=ce299af2c44f41f64999818410dc21f1efc773af41108c3f90fecb1f37ed59c3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 5 05:35:25.440599 dockerd[1572]: time="2025-09-05T05:35:25.440557207Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Sep 5 05:35:25.440991 dockerd[1572]: time="2025-09-05T05:35:25.440968089Z" level=info msg="Daemon shutdown complete" Sep 5 05:35:25.441169 dockerd[1572]: time="2025-09-05T05:35:25.441061851Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Sep 5 05:35:25.450982 systemd[1]: docker.service: Deactivated successfully. Sep 5 05:35:25.451492 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 5 05:35:25.451562 systemd[1]: docker.service: Consumed 3.104s CPU time, 331.1M memory peak. Sep 5 05:35:25.451994 systemd[1]: docker.socket: Deactivated successfully. Sep 5 05:35:25.452330 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 5 05:35:25.452397 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 5 05:35:25.454784 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 05:35:25.455069 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 05:35:25.457048 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 5 05:35:25.466831 (dockerd)[2322]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS Sep 5 05:35:25.490936 dockerd[2322]: time="2025-09-05T05:35:25.490883389Z" level=info msg="Starting up" Sep 5 05:35:25.491397 dockerd[2322]: time="2025-09-05T05:35:25.491378955Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 5 05:35:25.500370 dockerd[2322]: time="2025-09-05T05:35:25.500337427Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 5 05:35:25.512800 dockerd[2322]: time="2025-09-05T05:35:25.512755060Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 5 05:35:25.523474 dockerd[2322]: time="2025-09-05T05:35:25.523431984Z" level=info msg="Loading containers: start." Sep 5 05:35:26.077163 systemd[1]: var-lib-docker-overlay2-a88a8183108fd9642e54dd5ff7009c50adbc816617074a7500099e81d7d668b7-merged.mount: Deactivated successfully. Sep 5 05:35:26.077266 systemd[1]: var-lib-docker-overlay2-5597f72036727be65dadc0fe250dff00e1c32896beac01e898b5216950e84bf4-merged.mount: Deactivated successfully. Sep 5 05:35:26.133845 dockerd[2322]: time="2025-09-05T05:35:26.133792188Z" level=info msg="Loading containers: done." Sep 5 05:35:26.142666 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck501698213-merged.mount: Deactivated successfully. Sep 5 05:35:26.143868 dockerd[2322]: time="2025-09-05T05:35:26.143816074Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 5 05:35:26.143947 dockerd[2322]: time="2025-09-05T05:35:26.143888164Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 5 05:35:26.143947 dockerd[2322]: time="2025-09-05T05:35:26.143920374Z" level=info msg="Initializing buildkit" Sep 5 05:35:26.157887 dockerd[2322]: time="2025-09-05T05:35:26.157858929Z" level=info msg="Completed buildkit initialization" Sep 5 05:35:26.163560 dockerd[2322]: time="2025-09-05T05:35:26.163501388Z" level=info msg="Daemon has completed initialization" Sep 5 05:35:26.164016 dockerd[2322]: time="2025-09-05T05:35:26.163631873Z" level=info msg="API listen on /run/docker.sock" Sep 5 05:35:26.163684 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 5 05:35:26.164830 sh[2131]: Restarted Docker to apply Flannel options Sep 5 05:35:26.165305 sh[2110]: + break Sep 5 05:35:26.165305 sh[2110]: + '[' 1 '!=' fail ']' Sep 5 05:35:26.165679 docker[2304]: flannel Sep 5 05:35:26.165837 docker[2306]: etcd-member Sep 5 05:35:26.167175 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Sep 5 05:35:26.170584 systemd[1]: Startup finished in 1.985s (kernel) + 3.799s (initrd) + 10.823s (userspace) = 16.608s. Sep 5 05:35:26.204346 docker[2554]: etcd-member Sep 5 05:35:26.205148 docker[2553]: flannel Sep 5 05:35:26.206603 systemd[1]: flanneld.service: Deactivated successfully. Sep 5 05:35:26.208114 systemd[1]: etcd-member.service: Deactivated successfully. Sep 5 05:35:26.875040 systemd-networkd[1389]: flannel.1: Gained IPv6LL Sep 5 05:35:34.622516 systemd[1]: Started sshd@3-10.0.0.10:22-10.0.0.1:58394.service - OpenSSH per-connection server daemon (10.0.0.1:58394). Sep 5 05:35:34.678854 sshd[2575]: Accepted publickey for core from 10.0.0.1 port 58394 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:34.680020 sshd-session[2575]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:34.683635 systemd-logind[1429]: New session 4 of user core. Sep 5 05:35:34.693675 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 5 05:35:34.745017 sshd[2578]: Connection closed by 10.0.0.1 port 58394 Sep 5 05:35:34.745321 sshd-session[2575]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:34.755851 systemd[1]: sshd@3-10.0.0.10:22-10.0.0.1:58394.service: Deactivated successfully. Sep 5 05:35:34.757856 systemd[1]: session-4.scope: Deactivated successfully. Sep 5 05:35:34.758497 systemd-logind[1429]: Session 4 logged out. Waiting for processes to exit. Sep 5 05:35:34.760753 systemd[1]: Started sshd@4-10.0.0.10:22-10.0.0.1:58398.service - OpenSSH per-connection server daemon (10.0.0.1:58398). Sep 5 05:35:34.761626 systemd-logind[1429]: Removed session 4. Sep 5 05:35:34.807683 sshd[2584]: Accepted publickey for core from 10.0.0.1 port 58398 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:34.808756 sshd-session[2584]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:34.812982 systemd-logind[1429]: New session 5 of user core. Sep 5 05:35:34.828717 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 5 05:35:34.876878 sshd[2587]: Connection closed by 10.0.0.1 port 58398 Sep 5 05:35:34.876377 sshd-session[2584]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:34.893552 systemd[1]: sshd@4-10.0.0.10:22-10.0.0.1:58398.service: Deactivated successfully. Sep 5 05:35:34.895023 systemd[1]: session-5.scope: Deactivated successfully. Sep 5 05:35:34.895716 systemd-logind[1429]: Session 5 logged out. Waiting for processes to exit. Sep 5 05:35:34.897747 systemd[1]: Started sshd@5-10.0.0.10:22-10.0.0.1:58410.service - OpenSSH per-connection server daemon (10.0.0.1:58410). Sep 5 05:35:34.898371 systemd-logind[1429]: Removed session 5. Sep 5 05:35:34.947410 sshd[2593]: Accepted publickey for core from 10.0.0.1 port 58410 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:34.948425 sshd-session[2593]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:34.951936 systemd-logind[1429]: New session 6 of user core. Sep 5 05:35:34.959655 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 5 05:35:35.010563 sshd[2596]: Connection closed by 10.0.0.1 port 58410 Sep 5 05:35:35.011018 sshd-session[2593]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:35.024601 systemd[1]: sshd@5-10.0.0.10:22-10.0.0.1:58410.service: Deactivated successfully. Sep 5 05:35:35.026056 systemd[1]: session-6.scope: Deactivated successfully. Sep 5 05:35:35.026781 systemd-logind[1429]: Session 6 logged out. Waiting for processes to exit. Sep 5 05:35:35.028617 systemd[1]: Started sshd@6-10.0.0.10:22-10.0.0.1:58414.service - OpenSSH per-connection server daemon (10.0.0.1:58414). Sep 5 05:35:35.029482 systemd-logind[1429]: Removed session 6. Sep 5 05:35:35.076010 sshd[2602]: Accepted publickey for core from 10.0.0.1 port 58414 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:35.076985 sshd-session[2602]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:35.080323 systemd-logind[1429]: New session 7 of user core. Sep 5 05:35:35.087650 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 5 05:35:35.142778 sudo[2606]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 5 05:35:35.143038 sudo[2606]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:35:35.155754 sudo[2606]: pam_unix(sudo:session): session closed for user root Sep 5 05:35:35.157479 sshd[2605]: Connection closed by 10.0.0.1 port 58414 Sep 5 05:35:35.157321 sshd-session[2602]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:35.172559 systemd[1]: sshd@6-10.0.0.10:22-10.0.0.1:58414.service: Deactivated successfully. Sep 5 05:35:35.174689 systemd[1]: session-7.scope: Deactivated successfully. Sep 5 05:35:35.175325 systemd-logind[1429]: Session 7 logged out. Waiting for processes to exit. Sep 5 05:35:35.177346 systemd[1]: Started sshd@7-10.0.0.10:22-10.0.0.1:58426.service - OpenSSH per-connection server daemon (10.0.0.1:58426). Sep 5 05:35:35.177940 systemd-logind[1429]: Removed session 7. Sep 5 05:35:35.226421 sshd[2612]: Accepted publickey for core from 10.0.0.1 port 58426 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:35:35.227574 sshd-session[2612]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:35:35.231802 systemd-logind[1429]: New session 8 of user core. Sep 5 05:35:35.246653 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 5 05:35:35.296294 sudo[2617]: 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 5 05:35:35.296822 sudo[2617]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:35:35.301231 sudo[2617]: pam_unix(sudo:session): session closed for user root Sep 5 05:35:35.305440 sudo[2616]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 5 05:35:35.305713 sudo[2616]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:35:35.313117 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 05:35:35.348625 augenrules[2639]: No rules Sep 5 05:35:35.349678 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 05:35:35.349882 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 05:35:35.351267 sudo[2616]: pam_unix(sudo:session): session closed for user root Sep 5 05:35:35.354269 sshd[2615]: Connection closed by 10.0.0.1 port 58426 Sep 5 05:35:35.354569 sshd-session[2612]: pam_unix(sshd:session): session closed for user core Sep 5 05:35:35.357039 systemd[1]: sshd@7-10.0.0.10:22-10.0.0.1:58426.service: Deactivated successfully. Sep 5 05:35:35.358295 systemd[1]: session-8.scope: Deactivated successfully. Sep 5 05:35:35.359409 systemd-logind[1429]: Session 8 logged out. Waiting for processes to exit. Sep 5 05:35:35.360445 systemd-logind[1429]: Removed session 8. Sep 5 05:35:36.457476 systemd[1]: flanneld.service: Scheduled restart job, restart counter is at 1. Sep 5 05:35:36.458131 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. Sep 5 05:35:36.459615 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 5 05:35:36.460553 systemd[1]: Stopping flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Sep 5 05:35:36.484127 docker[2648]: flannel-docker-opts Sep 5 05:35:36.486753 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 5 05:35:36.486971 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 5 05:35:36.506690 docker[2662]: flannel-docker-opts Sep 5 05:35:36.508056 systemd[1]: flannel-docker-opts.service: Deactivated successfully. Sep 5 05:35:36.508326 systemd[1]: Stopped flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Sep 5 05:35:36.508729 systemd[1]: Stopped flanneld.service - flannel - Network fabric for containers (System Application Container). Sep 5 05:35:36.509861 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 5 05:35:36.522772 (-wrapper)[2671]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 5 05:35:36.538745 etcd-wrapper[2675]: Error response from daemon: No such container: etcd-member Sep 5 05:35:36.549493 etcd-wrapper[2684]: Error response from daemon: No such container: etcd-member Sep 5 05:35:36.575411 systemd[1]: var-lib-docker-overlay2-ca84d7e94971becb309ca395eed088d303609c3a535f060b937d7a0ea3d8a4d8\x2dinit-merged.mount: Deactivated successfully. Sep 5 05:35:36.586937 systemd[1]: var-lib-docker-overlay2-ca84d7e94971becb309ca395eed088d303609c3a535f060b937d7a0ea3d8a4d8-merged.mount: Deactivated successfully. Sep 5 05:35:36.611550 containerd[1478]: time="2025-09-05T05:35:36.611031478Z" level=info msg="connecting to shim e3c6835ef2a8fb0b99d175af7cbf7d517b7dc681c874079b09155b65f4a7dfd6" address="unix:///run/containerd/s/b28d7bb2a8e9679a043adf51f1849227e4543885378b90ea1dc2e5c2d563692d" namespace=moby protocol=ttrpc version=3 Sep 5 05:35:36.636725 systemd[1]: Started docker-e3c6835ef2a8fb0b99d175af7cbf7d517b7dc681c874079b09155b65f4a7dfd6.scope - libcontainer container e3c6835ef2a8fb0b99d175af7cbf7d517b7dc681c874079b09155b65f4a7dfd6. Sep 5 05:35:36.646499 systemd-resolved[1294]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:35:36.679489 etcd-wrapper[2704]: {"level":"info","ts":1757050536.6792357,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"info","ts":1757050536.6794934,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"3268b321dfc847ec9fa14e92197cd97a"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"warn","ts":1757050536.6795623,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"warn","ts":1757050536.6795902,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"warn","ts":1757050536.6796389,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"warn","ts":1757050536.6796494,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"warn","ts":1757050536.679656,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.679Z","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:36881/v2/keys/discovery/6002096040267097846","--enable-v2=true"]} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.679Z","caller":"etcdmain/etcd.go:115","msg":"server has been already initialized","data-dir":"/var/lib/etcd","dir-type":"member"} Sep 5 05:35:36.679952 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.679Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.10:2380"]} Sep 5 05:35:36.680417 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.680Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 5 05:35:36.680417 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.680Z","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":"3268b321dfc847ec9fa14e92197cd97a","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:36881/v2/keys/discovery/6002096040267097846","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 5 05:35:36.680648 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.680Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"158.255µs"} Sep 5 05:35:36.680779 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:36.680Z","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 5 05:35:36.680924 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.680Z","caller":"etcdserver/server.go:526","msg":"No snapshot found. Recovering WAL from scratch!"} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","caller":"etcdserver/raft.go:483","msg":"restarting local member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","commit-index":24} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=()"} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became follower at term 2"} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 40302e15c63acf7c [peers: [], term: 2, commit: 24, applied: 0, lastindex: 24, lastterm: 2]"} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","recovered-remote-peer-id":"40302e15c63acf7c","recovered-remote-peer-urls":["http://10.0.0.10:2380"]} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","recovered-remote-peer-id":"660549d949ca3c97","recovered-remote-peer-urls":["http://10.0.0.12:2380"]} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","recovered-remote-peer-id":"7681c2b43c002c53","recovered-remote-peer-urls":["http://10.0.0.11:2380"]} Sep 5 05:35:36.681885 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.681Z","caller":"membership/cluster.go:285","msg":"set cluster version from store","cluster-version":"3.5"} Sep 5 05:35:36.682332 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:36.682Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Sep 5 05:35:36.683345 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.683Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Sep 5 05:35:36.683679 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.683Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Sep 5 05:35:36.683981 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.683Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.684083 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.683Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.684Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97","remote-peer-urls":["http://10.0.0.12:2380"]} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53","remote-peer-urls":["http://10.0.0.11:2380"]} Sep 5 05:35:36.686676 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.685Z","caller":"etcdserver/server.go:834","msg":"starting etcd server","local-member-id":"40302e15c63acf7c","local-server-version":"3.5.0","cluster-id":"708259549588bf78","cluster-version":"3.5"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276)"} Sep 5 05:35:36.688632 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","added-peer-id":"40302e15c63acf7c","added-peer-peer-urls":["http://10.0.0.10:2380"]} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183)"} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","added-peer-id":"660549d949ca3c97","added-peer-peer-urls":["http://10.0.0.12:2380"]} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c switched to configuration voters=(4625247488364433276 7351363164346924183 8539320447827717203)"} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","added-peer-id":"7681c2b43c002c53","added-peer-peer-urls":["http://10.0.0.11:2380"]} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.687Z","caller":"membership/cluster.go:523","msg":"updated cluster version","cluster-id":"708259549588bf78","local-member-id":"40302e15c63acf7c","from":"3.5","to":"3.5"} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:36.687Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"40302e15c63acf7c","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 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.10:2380"} Sep 5 05:35:36.688990 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.10:2380"} Sep 5 05:35:36.689190 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.689190 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"660549d949ca3c97"} Sep 5 05:35:36.689190 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.689190 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.688Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.696757 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.696Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"660549d949ca3c97","stream-type":"stream MsgApp v2"} Sep 5 05:35:36.696757 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.696Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:36.697495 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.697Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"660549d949ca3c97","stream-type":"stream Message"} Sep 5 05:35:36.697495 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:36.697Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:37.101773 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [logterm: 2, index: 24, vote: 660549d949ca3c97] cast MsgPreVote for 660549d949ca3c97 [logterm: 2, index: 28] at term 2"} Sep 5 05:35:37.102672 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [term: 2] received a MsgVote message with higher term from 660549d949ca3c97 [term: 3]"} Sep 5 05:35:37.102672 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became follower at term 3"} Sep 5 05:35:37.102672 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [logterm: 2, index: 24, vote: 0] cast MsgVote for 660549d949ca3c97 [logterm: 2, index: 28] at term 3"} Sep 5 05:35:37.104455 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40302e15c63acf7c elected leader 660549d949ca3c97 at term 3"} Sep 5 05:35:37.107273 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.107Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"40302e15c63acf7c","local-member-attributes":"{Name:3268b321dfc847ec9fa14e92197cd97a ClientURLs:[http://10.0.0.10:2379]}","request-path":"/0/members/40302e15c63acf7c/attributes","cluster-id":"708259549588bf78","publish-timeout":"7s"} Sep 5 05:35:37.107365 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.107Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Sep 5 05:35:37.107540 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.107Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Sep 5 05:35:37.107694 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.107Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Sep 5 05:35:37.107715 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 5 05:35:37.108389 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.108Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Sep 5 05:35:37.109850 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Sep 5 05:35:37.151041 etcdctl[2771]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Sep 5 05:35:37.181768 flannel-wrapper[2781]: Error response from daemon: No such container: flannel Sep 5 05:35:37.194094 flannel-wrapper[2789]: Error response from daemon: No such container: flannel Sep 5 05:35:37.247592 containerd[1478]: time="2025-09-05T05:35:37.247548415Z" level=info msg="connecting to shim 0065262a9830f8cacd8699fbd2f2cc3677ce3fd606845b1e52e2d549115c63ca" address="unix:///run/containerd/s/7ebb15e199586a10958864529b615fd00ce465d2c700dbd8f818c9ad541d34eb" namespace=moby protocol=ttrpc version=3 Sep 5 05:35:37.280687 systemd[1]: Started docker-0065262a9830f8cacd8699fbd2f2cc3677ce3fd606845b1e52e2d549115c63ca.scope - libcontainer container 0065262a9830f8cacd8699fbd2f2cc3677ce3fd606845b1e52e2d549115c63ca. Sep 5 05:35:37.295329 systemd-resolved[1294]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:35:37.324504 flannel-wrapper[2808]: I0905 05:35:37.324275 1 main.go:520] Determining IP address of default interface Sep 5 05:35:37.324822 flannel-wrapper[2808]: I0905 05:35:37.324639 1 main.go:533] Using interface with name eth0 and address 10.0.0.10 Sep 5 05:35:37.324822 flannel-wrapper[2808]: I0905 05:35:37.324659 1 main.go:550] Defaulting external address to interface address (10.0.0.10) Sep 5 05:35:37.324918 flannel-wrapper[2808]: I0905 05:35:37.324811 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: 10.254.18.0/24 Sep 5 05:35:37.324918 flannel-wrapper[2808]: I0905 05:35:37.324836 1 main.go:257] Installing signal handlers Sep 5 05:35:37.327671 flannel-wrapper[2808]: I0905 05:35:37.327435 1 main.go:392] Found network config - Backend type: vxlan Sep 5 05:35:37.327671 flannel-wrapper[2808]: I0905 05:35:37.327478 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Sep 5 05:35:37.331294 flannel-wrapper[2808]: I0905 05:35:37.331010 1 local_manager.go:147] Found lease (10.254.18.0/24) for current IP (10.0.0.10), reusing Sep 5 05:35:37.332822 flannel-wrapper[2808]: I0905 05:35:37.332673 1 main.go:307] Setting up masking rules Sep 5 05:35:37.343758 flannel-wrapper[2808]: I0905 05:35:37.343090 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Sep 5 05:35:37.343758 flannel-wrapper[2808]: I0905 05:35:37.343215 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Sep 5 05:35:37.343758 flannel-wrapper[2808]: I0905 05:35:37.343243 1 main.go:327] Running backend. Sep 5 05:35:37.343758 flannel-wrapper[2808]: I0905 05:35:37.343320 1 vxlan_network.go:59] watching for new subnet leases Sep 5 05:35:37.344117 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Sep 5 05:35:37.346274 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Sep 5 05:35:37.349736 flannel-wrapper[2808]: I0905 05:35:37.349536 1 main.go:439] Waiting for 22h59m59.98170626s to renew lease Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [term 3] received MsgTimeoutNow from 660549d949ca3c97 and starts an election to get leadership."} Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c is starting a new election at term 3"} Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became candidate at term 4"} Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c received MsgVoteResp from 40302e15c63acf7c at term 4"} Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [logterm: 3, index: 45] sent MsgVote request to 660549d949ca3c97 at term 4"} Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c [logterm: 3, index: 45] sent MsgVote request to 7681c2b43c002c53 at term 4"} Sep 5 05:35:37.356890 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40302e15c63acf7c lost leader 660549d949ca3c97 at term 4"} Sep 5 05:35:37.359043 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c received MsgVoteResp from 660549d949ca3c97 at term 4"} Sep 5 05:35:37.359043 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c has received 2 MsgVoteResp votes and 0 vote rejections"} Sep 5 05:35:37.359043 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40302e15c63acf7c became leader at term 4"} Sep 5 05:35:37.359043 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40302e15c63acf7c elected leader 40302e15c63acf7c at term 4"} Sep 5 05:35:37.361363 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.361Z","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://10.0.0.11:2380/version","remote-member-id":"7681c2b43c002c53","error":"Get \"http://10.0.0.11:2380/version\": dial tcp 10.0.0.11:2380: connect: connection refused"} Sep 5 05:35:37.361363 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.361Z","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"7681c2b43c002c53","error":"Get \"http://10.0.0.11:2380/version\": dial tcp 10.0.0.11:2380: connect: connection refused"} Sep 5 05:35:37.362777 sh[2897]: + for try in 1 2 3 4 5 6 Sep 5 05:35:37.362777 sh[2897]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Sep 5 05:35:37.376667 sh[2906]: Error response from daemon: No such container: flannel-docker-opts Sep 5 05:35:37.388941 sh[2915]: Error response from daemon: No such container: flannel-docker-opts Sep 5 05:35:37.439867 containerd[1478]: time="2025-09-05T05:35:37.439824484Z" level=info msg="connecting to shim 3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3" address="unix:///run/containerd/s/87e010b83c6a4d7e2f2f48a86310ebd26056bbe8fd9a0acd87a612b53f06871d" namespace=moby protocol=ttrpc version=3 Sep 5 05:35:37.457431 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.456Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97","error":"EOF"} Sep 5 05:35:37.457431 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.457Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97","error":"EOF"} Sep 5 05:35:37.458434 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.458Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"660549d949ca3c97","error":"failed to dial 660549d949ca3c97 on stream MsgApp v2 (peer 660549d949ca3c97 failed to find local node 40302e15c63acf7c)"} Sep 5 05:35:37.459693 systemd[1]: Started docker-3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3.scope - libcontainer container 3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3. Sep 5 05:35:37.474725 systemd-resolved[1294]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:35:37.496643 systemd[1]: docker-3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3.scope: Deactivated successfully. Sep 5 05:35:37.508334 containerd[1478]: time="2025-09-05T05:35:37.508143178Z" level=info msg="shim disconnected" id=3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3 namespace=moby Sep 5 05:35:37.508334 containerd[1478]: time="2025-09-05T05:35:37.508177286Z" level=warning msg="cleaning up after shim disconnected" id=3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3 namespace=moby Sep 5 05:35:37.508334 containerd[1478]: time="2025-09-05T05:35:37.508185502Z" level=info msg="cleaning up dead shim" namespace=moby Sep 5 05:35:37.508481 dockerd[2322]: time="2025-09-05T05:35:37.508159450Z" level=info msg="ignoring event" container=3f1df3a14a132e14687948f78ee886212fc66910fb317c61f4d4b205164766e3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 5 05:35:37.530193 sh[2897]: + break Sep 5 05:35:37.530193 sh[2897]: + '[' 1 '!=' fail ']' Sep 5 05:35:37.531608 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Sep 5 05:35:37.678943 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.678Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"7681c2b43c002c53","stream-type":"stream Message"} Sep 5 05:35:37.678943 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.678Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"7681c2b43c002c53","stream-type":"stream MsgApp v2"} Sep 5 05:35:37.678943 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.678Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7681c2b43c002c53"} Sep 5 05:35:37.679461 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.678Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:37.679461 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.678Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:37.689618 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.689Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:37.689618 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:37.689Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"7681c2b43c002c53"} Sep 5 05:35:37.727945 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.727Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:37.728736 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:37.728Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:41.362557 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:41.362Z","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://10.0.0.12:2380/version","remote-member-id":"660549d949ca3c97","error":"Get \"http://10.0.0.12:2380/version\": dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:41.362557 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:41.362Z","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"660549d949ca3c97","error":"Get \"http://10.0.0.12:2380/version\": dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:41.687535 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:41.687Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"660549d949ca3c97","rtt":"0s","error":"dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:41.687535 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:41.687Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"660549d949ca3c97","rtt":"0s","error":"dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:45.363833 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:45.363Z","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://10.0.0.12:2380/version","remote-member-id":"660549d949ca3c97","error":"Get \"http://10.0.0.12:2380/version\": dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:45.363833 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:45.363Z","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"660549d949ca3c97","error":"Get \"http://10.0.0.12:2380/version\": dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:46.688279 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:46.687Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"660549d949ca3c97","rtt":"0s","error":"dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:46.688279 etcd-wrapper[2704]: {"level":"warn","ts":"2025-09-05T05:35:46.688Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"660549d949ca3c97","rtt":"0s","error":"dial tcp 10.0.0.12:2380: connect: connection refused"} Sep 5 05:35:48.564230 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.563Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"660549d949ca3c97","stream-type":"stream Message"} Sep 5 05:35:48.564230 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.563Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"40302e15c63acf7c","to":"660549d949ca3c97","stream-type":"stream MsgApp v2"} Sep 5 05:35:48.564230 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.563Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"660549d949ca3c97"} Sep 5 05:35:48.564230 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.564Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:48.564230 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.564Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:48.569628 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.569Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:35:48.569893 etcd-wrapper[2704]: {"level":"info","ts":"2025-09-05T05:35:48.569Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"40302e15c63acf7c","remote-peer-id":"660549d949ca3c97"} Sep 5 05:36:02.581473 update_engine[1433]: I20250905 05:36:02.581398 1433 update_attempter.cc:509] Updating boot flags...