Apr 22 15:06:19.997519 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Apr 22 15:06:19.997546 kernel: Linux version 6.6.83-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Mon Mar 24 23:39:14 -00 2025 Apr 22 15:06:19.997557 kernel: KASLR enabled Apr 22 15:06:19.997563 kernel: efi: EFI v2.7 by EDK II Apr 22 15:06:19.997569 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb4ff018 ACPI 2.0=0xd93ef018 RNG=0xd93efa18 MEMRESERVE=0xd91d9d18 Apr 22 15:06:19.997575 kernel: random: crng init done Apr 22 15:06:19.997582 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Apr 22 15:06:19.997588 kernel: secureboot: Secure boot enabled Apr 22 15:06:19.997608 kernel: ACPI: Early table checksum verification disabled Apr 22 15:06:19.997614 kernel: ACPI: RSDP 0x00000000D93EF018 000024 (v02 BOCHS ) Apr 22 15:06:19.997623 kernel: ACPI: XSDT 0x00000000D93EFF18 000064 (v01 BOCHS BXPC 00000001 01000013) Apr 22 15:06:19.997629 kernel: ACPI: FACP 0x00000000D93EFB18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997635 kernel: ACPI: DSDT 0x00000000D93ED018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997641 kernel: ACPI: APIC 0x00000000D93EFC98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997648 kernel: ACPI: PPTT 0x00000000D93EF098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997656 kernel: ACPI: GTDT 0x00000000D93EF818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997662 kernel: ACPI: MCFG 0x00000000D93EFA98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997668 kernel: ACPI: SPCR 0x00000000D93EF918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997674 kernel: ACPI: DBG2 0x00000000D93EF998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997681 kernel: ACPI: IORT 0x00000000D93EF198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Apr 22 15:06:19.997687 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Apr 22 15:06:19.997693 kernel: NUMA: Failed to initialise from firmware Apr 22 15:06:19.997699 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Apr 22 15:06:19.997705 kernel: NUMA: NODE_DATA [mem 0xdc72a800-0xdc72ffff] Apr 22 15:06:19.997711 kernel: Zone ranges: Apr 22 15:06:19.997719 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Apr 22 15:06:19.997725 kernel: DMA32 empty Apr 22 15:06:19.997731 kernel: Normal empty Apr 22 15:06:19.997737 kernel: Movable zone start for each node Apr 22 15:06:19.997743 kernel: Early memory node ranges Apr 22 15:06:19.997749 kernel: node 0: [mem 0x0000000040000000-0x00000000d93effff] Apr 22 15:06:19.997755 kernel: node 0: [mem 0x00000000d93f0000-0x00000000d972ffff] Apr 22 15:06:19.997761 kernel: node 0: [mem 0x00000000d9730000-0x00000000dcbfffff] Apr 22 15:06:19.997767 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Apr 22 15:06:19.997773 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Apr 22 15:06:19.997779 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Apr 22 15:06:19.997785 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Apr 22 15:06:19.997792 kernel: psci: probing for conduit method from ACPI. Apr 22 15:06:19.997798 kernel: psci: PSCIv1.1 detected in firmware. Apr 22 15:06:19.997804 kernel: psci: Using standard PSCI v0.2 function IDs Apr 22 15:06:19.997813 kernel: psci: Trusted OS migration not required Apr 22 15:06:19.997819 kernel: psci: SMC Calling Convention v1.1 Apr 22 15:06:19.997826 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Apr 22 15:06:19.997833 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Apr 22 15:06:19.997841 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Apr 22 15:06:19.997847 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Apr 22 15:06:19.997854 kernel: Detected PIPT I-cache on CPU0 Apr 22 15:06:19.997861 kernel: CPU features: detected: GIC system register CPU interface Apr 22 15:06:19.997869 kernel: CPU features: detected: Hardware dirty bit management Apr 22 15:06:19.997876 kernel: CPU features: detected: Spectre-v4 Apr 22 15:06:19.997882 kernel: CPU features: detected: Spectre-BHB Apr 22 15:06:19.997888 kernel: CPU features: kernel page table isolation forced ON by KASLR Apr 22 15:06:19.997895 kernel: CPU features: detected: Kernel page table isolation (KPTI) Apr 22 15:06:19.997901 kernel: CPU features: detected: ARM erratum 1418040 Apr 22 15:06:19.997909 kernel: CPU features: detected: SSBS not fully self-synchronizing Apr 22 15:06:19.997915 kernel: alternatives: applying boot alternatives Apr 22 15:06:19.997923 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=b84e5f613acd6cd0a8a878f32f5653a14f2e6fb2820997fecd5b2bd33a4ba3ab Apr 22 15:06:19.997930 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Apr 22 15:06:19.997936 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 22 15:06:19.997943 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 22 15:06:19.997949 kernel: Fallback order for Node 0: 0 Apr 22 15:06:19.997956 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Apr 22 15:06:19.997962 kernel: Policy zone: DMA Apr 22 15:06:19.997968 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 22 15:06:19.997976 kernel: software IO TLB: area num 4. Apr 22 15:06:19.997983 kernel: software IO TLB: mapped [mem 0x00000000d2800000-0x00000000d6800000] (64MB) Apr 22 15:06:19.997990 kernel: Memory: 2385820K/2572288K available (10304K kernel code, 2186K rwdata, 8096K rodata, 38464K init, 897K bss, 186468K reserved, 0K cma-reserved) Apr 22 15:06:19.997996 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 22 15:06:19.998003 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 22 15:06:19.998010 kernel: rcu: RCU event tracing is enabled. Apr 22 15:06:19.998016 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Apr 22 15:06:19.998023 kernel: Trampoline variant of Tasks RCU enabled. Apr 22 15:06:19.998029 kernel: Tracing variant of Tasks RCU enabled. Apr 22 15:06:19.998035 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 22 15:06:19.998042 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 22 15:06:19.998048 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Apr 22 15:06:19.998056 kernel: GICv3: 256 SPIs implemented Apr 22 15:06:19.998062 kernel: GICv3: 0 Extended SPIs implemented Apr 22 15:06:19.998068 kernel: Root IRQ handler: gic_handle_irq Apr 22 15:06:19.998074 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Apr 22 15:06:19.998080 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Apr 22 15:06:19.998087 kernel: ITS [mem 0x08080000-0x0809ffff] Apr 22 15:06:19.998093 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Apr 22 15:06:19.998099 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Apr 22 15:06:19.998106 kernel: GICv3: using LPI property table @0x00000000400f0000 Apr 22 15:06:19.998112 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Apr 22 15:06:19.998118 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 22 15:06:19.998126 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 22 15:06:19.998132 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Apr 22 15:06:19.998139 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Apr 22 15:06:19.998145 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Apr 22 15:06:19.998152 kernel: arm-pv: using stolen time PV Apr 22 15:06:19.998158 kernel: Console: colour dummy device 80x25 Apr 22 15:06:19.998165 kernel: ACPI: Core revision 20230628 Apr 22 15:06:19.998171 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Apr 22 15:06:19.998186 kernel: pid_max: default: 32768 minimum: 301 Apr 22 15:06:19.998192 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 22 15:06:19.998201 kernel: landlock: Up and running. Apr 22 15:06:19.998208 kernel: SELinux: Initializing. Apr 22 15:06:19.998214 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 22 15:06:19.998221 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 22 15:06:19.998227 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 22 15:06:19.998234 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 22 15:06:19.998240 kernel: rcu: Hierarchical SRCU implementation. Apr 22 15:06:19.998247 kernel: rcu: Max phase no-delay instances is 400. Apr 22 15:06:19.998254 kernel: Platform MSI: ITS@0x8080000 domain created Apr 22 15:06:19.998261 kernel: PCI/MSI: ITS@0x8080000 domain created Apr 22 15:06:19.998268 kernel: Remapping and enabling EFI services. Apr 22 15:06:19.998274 kernel: smp: Bringing up secondary CPUs ... Apr 22 15:06:19.998281 kernel: Detected PIPT I-cache on CPU1 Apr 22 15:06:19.998287 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Apr 22 15:06:19.998294 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Apr 22 15:06:19.998301 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 22 15:06:19.998307 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Apr 22 15:06:19.998314 kernel: Detected PIPT I-cache on CPU2 Apr 22 15:06:19.998320 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Apr 22 15:06:19.998329 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Apr 22 15:06:19.998335 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 22 15:06:19.998347 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Apr 22 15:06:19.998355 kernel: Detected PIPT I-cache on CPU3 Apr 22 15:06:19.998362 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Apr 22 15:06:19.998382 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Apr 22 15:06:19.998389 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 22 15:06:19.998396 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Apr 22 15:06:19.998403 kernel: smp: Brought up 1 node, 4 CPUs Apr 22 15:06:19.998420 kernel: SMP: Total of 4 processors activated. Apr 22 15:06:19.998428 kernel: CPU features: detected: 32-bit EL0 Support Apr 22 15:06:19.998436 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Apr 22 15:06:19.998442 kernel: CPU features: detected: Common not Private translations Apr 22 15:06:19.998449 kernel: CPU features: detected: CRC32 instructions Apr 22 15:06:19.998456 kernel: CPU features: detected: Enhanced Virtualization Traps Apr 22 15:06:19.998463 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Apr 22 15:06:19.998470 kernel: CPU features: detected: LSE atomic instructions Apr 22 15:06:19.998479 kernel: CPU features: detected: Privileged Access Never Apr 22 15:06:19.998486 kernel: CPU features: detected: RAS Extension Support Apr 22 15:06:19.998493 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Apr 22 15:06:19.998500 kernel: CPU: All CPU(s) started at EL1 Apr 22 15:06:19.998507 kernel: alternatives: applying system-wide alternatives Apr 22 15:06:19.998514 kernel: devtmpfs: initialized Apr 22 15:06:19.998521 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 22 15:06:19.998528 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 22 15:06:19.998535 kernel: pinctrl core: initialized pinctrl subsystem Apr 22 15:06:19.998544 kernel: SMBIOS 3.0.0 present. Apr 22 15:06:19.998551 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Apr 22 15:06:19.998558 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 22 15:06:19.998565 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Apr 22 15:06:19.998572 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Apr 22 15:06:19.998579 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Apr 22 15:06:19.998586 kernel: audit: initializing netlink subsys (disabled) Apr 22 15:06:20.001886 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Apr 22 15:06:20.001901 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 22 15:06:20.001915 kernel: cpuidle: using governor menu Apr 22 15:06:20.001923 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 22 15:06:20.001930 kernel: ASID allocator initialised with 32768 entries Apr 22 15:06:20.001937 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 22 15:06:20.001944 kernel: Serial: AMBA PL011 UART driver Apr 22 15:06:20.001951 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Apr 22 15:06:20.001958 kernel: Modules: 0 pages in range for non-PLT usage Apr 22 15:06:20.001965 kernel: Modules: 509248 pages in range for PLT usage Apr 22 15:06:20.001972 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 22 15:06:20.001981 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Apr 22 15:06:20.001988 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Apr 22 15:06:20.001995 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Apr 22 15:06:20.002002 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 22 15:06:20.002009 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Apr 22 15:06:20.002015 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Apr 22 15:06:20.002022 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Apr 22 15:06:20.002030 kernel: ACPI: Added _OSI(Module Device) Apr 22 15:06:20.002036 kernel: ACPI: Added _OSI(Processor Device) Apr 22 15:06:20.002045 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 22 15:06:20.002052 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 22 15:06:20.002059 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 22 15:06:20.002066 kernel: ACPI: Interpreter enabled Apr 22 15:06:20.002073 kernel: ACPI: Using GIC for interrupt routing Apr 22 15:06:20.002080 kernel: ACPI: MCFG table detected, 1 entries Apr 22 15:06:20.002087 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Apr 22 15:06:20.002095 kernel: printk: console [ttyAMA0] enabled Apr 22 15:06:20.002102 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 22 15:06:20.002266 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 22 15:06:20.002346 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Apr 22 15:06:20.002416 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Apr 22 15:06:20.002487 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Apr 22 15:06:20.002553 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Apr 22 15:06:20.002563 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Apr 22 15:06:20.002570 kernel: PCI host bridge to bus 0000:00 Apr 22 15:06:20.002658 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Apr 22 15:06:20.002721 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Apr 22 15:06:20.002783 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Apr 22 15:06:20.002846 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 22 15:06:20.002927 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Apr 22 15:06:20.003006 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Apr 22 15:06:20.003079 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Apr 22 15:06:20.003150 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Apr 22 15:06:20.003240 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Apr 22 15:06:20.003318 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Apr 22 15:06:20.003388 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Apr 22 15:06:20.003457 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Apr 22 15:06:20.003519 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Apr 22 15:06:20.003580 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Apr 22 15:06:20.003661 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Apr 22 15:06:20.003671 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Apr 22 15:06:20.003678 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Apr 22 15:06:20.003685 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Apr 22 15:06:20.003692 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Apr 22 15:06:20.003699 kernel: iommu: Default domain type: Translated Apr 22 15:06:20.003706 kernel: iommu: DMA domain TLB invalidation policy: strict mode Apr 22 15:06:20.003713 kernel: efivars: Registered efivars operations Apr 22 15:06:20.003723 kernel: vgaarb: loaded Apr 22 15:06:20.003730 kernel: clocksource: Switched to clocksource arch_sys_counter Apr 22 15:06:20.003737 kernel: VFS: Disk quotas dquot_6.6.0 Apr 22 15:06:20.003744 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 22 15:06:20.003751 kernel: pnp: PnP ACPI init Apr 22 15:06:20.003831 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Apr 22 15:06:20.003842 kernel: pnp: PnP ACPI: found 1 devices Apr 22 15:06:20.003849 kernel: NET: Registered PF_INET protocol family Apr 22 15:06:20.003858 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 22 15:06:20.003866 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 22 15:06:20.003873 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 22 15:06:20.003880 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 22 15:06:20.003888 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 22 15:06:20.003895 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 22 15:06:20.003902 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 22 15:06:20.003909 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 22 15:06:20.003916 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 22 15:06:20.003924 kernel: PCI: CLS 0 bytes, default 64 Apr 22 15:06:20.003931 kernel: kvm [1]: HYP mode not available Apr 22 15:06:20.003938 kernel: Initialise system trusted keyrings Apr 22 15:06:20.003945 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 22 15:06:20.003952 kernel: Key type asymmetric registered Apr 22 15:06:20.003959 kernel: Asymmetric key parser 'x509' registered Apr 22 15:06:20.003966 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 22 15:06:20.003973 kernel: io scheduler mq-deadline registered Apr 22 15:06:20.003980 kernel: io scheduler kyber registered Apr 22 15:06:20.003988 kernel: io scheduler bfq registered Apr 22 15:06:20.003996 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 22 15:06:20.004003 kernel: ACPI: button: Power Button [PWRB] Apr 22 15:06:20.004010 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Apr 22 15:06:20.004082 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Apr 22 15:06:20.004091 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 22 15:06:20.004099 kernel: thunder_xcv, ver 1.0 Apr 22 15:06:20.004106 kernel: thunder_bgx, ver 1.0 Apr 22 15:06:20.004112 kernel: nicpf, ver 1.0 Apr 22 15:06:20.004121 kernel: nicvf, ver 1.0 Apr 22 15:06:20.004209 kernel: rtc-efi rtc-efi.0: registered as rtc0 Apr 22 15:06:20.004318 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-04-22T15:06:19 UTC (1745334379) Apr 22 15:06:20.004331 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 22 15:06:20.004338 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Apr 22 15:06:20.004345 kernel: watchdog: Delayed init of the lockup detector failed: -19 Apr 22 15:06:20.004352 kernel: watchdog: Hard watchdog permanently disabled Apr 22 15:06:20.004359 kernel: NET: Registered PF_INET6 protocol family Apr 22 15:06:20.004370 kernel: Segment Routing with IPv6 Apr 22 15:06:20.004377 kernel: In-situ OAM (IOAM) with IPv6 Apr 22 15:06:20.004385 kernel: NET: Registered PF_PACKET protocol family Apr 22 15:06:20.004392 kernel: Key type dns_resolver registered Apr 22 15:06:20.004399 kernel: registered taskstats version 1 Apr 22 15:06:20.004406 kernel: Loading compiled-in X.509 certificates Apr 22 15:06:20.004414 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.83-flatcar: ed4ababe871f0afac8b4236504477de11a6baf07' Apr 22 15:06:20.004421 kernel: Key type .fscrypt registered Apr 22 15:06:20.004429 kernel: Key type fscrypt-provisioning registered Apr 22 15:06:20.004438 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 22 15:06:20.004452 kernel: ima: Allocated hash algorithm: sha1 Apr 22 15:06:20.004461 kernel: ima: No architecture policies found Apr 22 15:06:20.004468 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Apr 22 15:06:20.004475 kernel: clk: Disabling unused clocks Apr 22 15:06:20.004482 kernel: Freeing unused kernel memory: 38464K Apr 22 15:06:20.004489 kernel: Run /init as init process Apr 22 15:06:20.004496 kernel: with arguments: Apr 22 15:06:20.004503 kernel: /init Apr 22 15:06:20.004511 kernel: with environment: Apr 22 15:06:20.004518 kernel: HOME=/ Apr 22 15:06:20.004525 kernel: TERM=linux Apr 22 15:06:20.004532 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Apr 22 15:06:20.004540 systemd[1]: Successfully made /usr/ read-only. Apr 22 15:06:20.004549 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) Apr 22 15:06:20.004557 systemd[1]: Detected virtualization kvm. Apr 22 15:06:20.004565 systemd[1]: Detected architecture arm64. Apr 22 15:06:20.004573 systemd[1]: Running in initrd. Apr 22 15:06:20.004581 systemd[1]: No hostname configured, using default hostname. Apr 22 15:06:20.004589 systemd[1]: Hostname set to . Apr 22 15:06:20.004666 systemd[1]: Initializing machine ID from VM UUID. Apr 22 15:06:20.004675 systemd[1]: Queued start job for default target initrd.target. Apr 22 15:06:20.004683 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 22 15:06:20.004691 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 22 15:06:20.004699 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 22 15:06:20.004710 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 22 15:06:20.004718 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 22 15:06:20.004727 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 22 15:06:20.004735 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 22 15:06:20.004743 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 22 15:06:20.004750 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 22 15:06:20.004758 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 22 15:06:20.004767 systemd[1]: Reached target paths.target - Path Units. Apr 22 15:06:20.004775 systemd[1]: Reached target slices.target - Slice Units. Apr 22 15:06:20.004782 systemd[1]: Reached target swap.target - Swaps. Apr 22 15:06:20.004790 systemd[1]: Reached target timers.target - Timer Units. Apr 22 15:06:20.004797 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 22 15:06:20.004805 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 22 15:06:20.004813 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 22 15:06:20.004821 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Apr 22 15:06:20.004830 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 22 15:06:20.004838 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 22 15:06:20.004845 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 22 15:06:20.004853 systemd[1]: Reached target sockets.target - Socket Units. Apr 22 15:06:20.004861 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 22 15:06:20.004868 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 22 15:06:20.004876 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 22 15:06:20.004883 systemd[1]: Starting systemd-fsck-usr.service... Apr 22 15:06:20.004891 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 22 15:06:20.004900 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 22 15:06:20.004908 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 22 15:06:20.004915 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 22 15:06:20.004923 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 22 15:06:20.004931 systemd[1]: Finished systemd-fsck-usr.service. Apr 22 15:06:20.004941 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 22 15:06:20.004949 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 22 15:06:20.004980 systemd-journald[237]: Collecting audit messages is disabled. Apr 22 15:06:20.005001 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 22 15:06:20.005009 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 22 15:06:20.005017 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 22 15:06:20.005024 kernel: Bridge firewalling registered Apr 22 15:06:20.005032 systemd-journald[237]: Journal started Apr 22 15:06:20.005050 systemd-journald[237]: Runtime Journal (/run/log/journal/eb01c42710f64c0eb5ade329e547ccaa) is 5.9M, max 47.3M, 41.4M free. Apr 22 15:06:19.990234 systemd-modules-load[240]: Inserted module 'overlay' Apr 22 15:06:20.005223 systemd-modules-load[240]: Inserted module 'br_netfilter' Apr 22 15:06:20.008766 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 22 15:06:20.009616 systemd[1]: Started systemd-journald.service - Journal Service. Apr 22 15:06:20.015022 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 22 15:06:20.017877 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 22 15:06:20.022026 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 22 15:06:20.023714 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 22 15:06:20.026735 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 22 15:06:20.036844 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 22 15:06:20.044389 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 22 15:06:20.045546 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 22 15:06:20.048653 dracut-cmdline[269]: dracut-dracut-053 Apr 22 15:06:20.049166 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 22 15:06:20.050965 dracut-cmdline[269]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=b84e5f613acd6cd0a8a878f32f5653a14f2e6fb2820997fecd5b2bd33a4ba3ab Apr 22 15:06:20.093351 systemd-resolved[290]: Positive Trust Anchors: Apr 22 15:06:20.093366 systemd-resolved[290]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 22 15:06:20.093397 systemd-resolved[290]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 22 15:06:20.099451 systemd-resolved[290]: Defaulting to hostname 'linux'. Apr 22 15:06:20.100418 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 22 15:06:20.102105 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 22 15:06:20.127624 kernel: SCSI subsystem initialized Apr 22 15:06:20.132614 kernel: Loading iSCSI transport class v2.0-870. Apr 22 15:06:20.139616 kernel: iscsi: registered transport (tcp) Apr 22 15:06:20.154637 kernel: iscsi: registered transport (qla4xxx) Apr 22 15:06:20.154686 kernel: QLogic iSCSI HBA Driver Apr 22 15:06:20.198484 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 22 15:06:20.200366 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 22 15:06:20.238530 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 22 15:06:20.238564 kernel: device-mapper: uevent: version 1.0.3 Apr 22 15:06:20.239802 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 22 15:06:20.284622 kernel: raid6: neonx8 gen() 15751 MB/s Apr 22 15:06:20.301608 kernel: raid6: neonx4 gen() 15820 MB/s Apr 22 15:06:20.318607 kernel: raid6: neonx2 gen() 13193 MB/s Apr 22 15:06:20.335613 kernel: raid6: neonx1 gen() 10513 MB/s Apr 22 15:06:20.352618 kernel: raid6: int64x8 gen() 6799 MB/s Apr 22 15:06:20.369610 kernel: raid6: int64x4 gen() 7283 MB/s Apr 22 15:06:20.386607 kernel: raid6: int64x2 gen() 6109 MB/s Apr 22 15:06:20.403608 kernel: raid6: int64x1 gen() 5043 MB/s Apr 22 15:06:20.403628 kernel: raid6: using algorithm neonx4 gen() 15820 MB/s Apr 22 15:06:20.420613 kernel: raid6: .... xor() 12399 MB/s, rmw enabled Apr 22 15:06:20.420633 kernel: raid6: using neon recovery algorithm Apr 22 15:06:20.425929 kernel: xor: measuring software checksum speed Apr 22 15:06:20.425948 kernel: 8regs : 21630 MB/sec Apr 22 15:06:20.425958 kernel: 32regs : 21699 MB/sec Apr 22 15:06:20.426958 kernel: arm64_neon : 27955 MB/sec Apr 22 15:06:20.426991 kernel: xor: using function: arm64_neon (27955 MB/sec) Apr 22 15:06:20.484640 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 22 15:06:20.496694 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 22 15:06:20.499040 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 22 15:06:20.527316 systemd-udevd[463]: Using default interface naming scheme 'v255'. Apr 22 15:06:20.531246 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 22 15:06:20.533780 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 22 15:06:20.559982 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Apr 22 15:06:20.587434 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 22 15:06:20.589605 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 22 15:06:20.649562 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 22 15:06:20.652261 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 22 15:06:20.673100 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 22 15:06:20.675222 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 22 15:06:20.676798 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 22 15:06:20.679005 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 22 15:06:20.683319 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 22 15:06:20.703342 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Apr 22 15:06:20.713920 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Apr 22 15:06:20.714024 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 22 15:06:20.704640 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 22 15:06:20.713338 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 22 15:06:20.713443 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 22 15:06:20.715887 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 22 15:06:20.717652 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 22 15:06:20.718196 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 22 15:06:20.721963 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 22 15:06:20.723819 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 22 15:06:20.740094 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by (udev-worker) (507) Apr 22 15:06:20.745679 kernel: BTRFS: device fsid bf348154-9cb1-474d-801c-0e035a5758cf devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (519) Apr 22 15:06:20.745880 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Apr 22 15:06:20.747204 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 22 15:06:20.760242 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Apr 22 15:06:20.767939 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 22 15:06:20.778272 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Apr 22 15:06:20.779315 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Apr 22 15:06:20.782030 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 22 15:06:20.784281 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 22 15:06:20.804843 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 22 15:06:20.815796 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 22 15:06:21.817619 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 22 15:06:21.818228 disk-uuid[551]: The operation has completed successfully. Apr 22 15:06:21.851704 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 22 15:06:21.851799 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 22 15:06:21.874919 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 22 15:06:21.887712 sh[570]: Success Apr 22 15:06:21.907622 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Apr 22 15:06:21.938891 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 22 15:06:21.940884 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 22 15:06:21.954291 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 22 15:06:21.961214 kernel: BTRFS info (device dm-0): first mount of filesystem bf348154-9cb1-474d-801c-0e035a5758cf Apr 22 15:06:21.961263 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Apr 22 15:06:21.961274 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 22 15:06:21.962141 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 22 15:06:21.962826 kernel: BTRFS info (device dm-0): using free space tree Apr 22 15:06:21.969514 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 22 15:06:21.970528 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 22 15:06:21.971280 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 22 15:06:21.973789 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 22 15:06:21.995726 kernel: BTRFS info (device vda6): first mount of filesystem 09629b08-d05c-4ce3-8bf7-615041c4b2c9 Apr 22 15:06:21.995779 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Apr 22 15:06:21.995791 kernel: BTRFS info (device vda6): using free space tree Apr 22 15:06:21.998614 kernel: BTRFS info (device vda6): auto enabling async discard Apr 22 15:06:22.001654 kernel: BTRFS info (device vda6): last unmount of filesystem 09629b08-d05c-4ce3-8bf7-615041c4b2c9 Apr 22 15:06:22.004923 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 22 15:06:22.007008 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 22 15:06:22.097249 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 22 15:06:22.102129 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 22 15:06:22.153893 systemd-networkd[753]: lo: Link UP Apr 22 15:06:22.153905 systemd-networkd[753]: lo: Gained carrier Apr 22 15:06:22.154913 systemd-networkd[753]: Enumeration completed Apr 22 15:06:22.155695 systemd-networkd[753]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 22 15:06:22.155698 systemd-networkd[753]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 22 15:06:22.156418 systemd-networkd[753]: eth0: Link UP Apr 22 15:06:22.156421 systemd-networkd[753]: eth0: Gained carrier Apr 22 15:06:22.156428 systemd-networkd[753]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 22 15:06:22.156660 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 22 15:06:22.157866 systemd[1]: Reached target network.target - Network. Apr 22 15:06:22.176665 systemd-networkd[753]: eth0: DHCPv4 address 10.0.0.37/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 22 15:06:22.188777 ignition[661]: Ignition 2.20.0 Apr 22 15:06:22.188788 ignition[661]: Stage: fetch-offline Apr 22 15:06:22.188822 ignition[661]: no configs at "/usr/lib/ignition/base.d" Apr 22 15:06:22.188830 ignition[661]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 22 15:06:22.189126 ignition[661]: parsed url from cmdline: "" Apr 22 15:06:22.189130 ignition[661]: no config URL provided Apr 22 15:06:22.189135 ignition[661]: reading system config file "/usr/lib/ignition/user.ign" Apr 22 15:06:22.189143 ignition[661]: no config at "/usr/lib/ignition/user.ign" Apr 22 15:06:22.189167 ignition[661]: op(1): [started] loading QEMU firmware config module Apr 22 15:06:22.189172 ignition[661]: op(1): executing: "modprobe" "qemu_fw_cfg" Apr 22 15:06:22.199018 ignition[661]: op(1): [finished] loading QEMU firmware config module Apr 22 15:06:22.204872 ignition[661]: parsing config with SHA512: f45c8c1c51d3cefc0d39ad8d618907c06a1ad166bcf24ca3fb8e0ad6cdf66d532a66fbee1e0235cecc059a7117ff89558866d7e1204e48154da24c2566e4405a Apr 22 15:06:22.214517 unknown[661]: fetched base config from "system" Apr 22 15:06:22.214530 unknown[661]: fetched user config from "qemu" Apr 22 15:06:22.214794 ignition[661]: fetch-offline: fetch-offline passed Apr 22 15:06:22.214875 ignition[661]: Ignition finished successfully Apr 22 15:06:22.217558 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 22 15:06:22.218714 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Apr 22 15:06:22.219535 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 22 15:06:22.244784 ignition[766]: Ignition 2.20.0 Apr 22 15:06:22.244795 ignition[766]: Stage: kargs Apr 22 15:06:22.244960 ignition[766]: no configs at "/usr/lib/ignition/base.d" Apr 22 15:06:22.244970 ignition[766]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 22 15:06:22.248033 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 22 15:06:22.245659 ignition[766]: kargs: kargs passed Apr 22 15:06:22.245703 ignition[766]: Ignition finished successfully Apr 22 15:06:22.249948 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 22 15:06:22.281031 ignition[775]: Ignition 2.20.0 Apr 22 15:06:22.281042 ignition[775]: Stage: disks Apr 22 15:06:22.281219 ignition[775]: no configs at "/usr/lib/ignition/base.d" Apr 22 15:06:22.281230 ignition[775]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 22 15:06:22.281934 ignition[775]: disks: disks passed Apr 22 15:06:22.283851 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 22 15:06:22.281977 ignition[775]: Ignition finished successfully Apr 22 15:06:22.285304 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 22 15:06:22.286339 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 22 15:06:22.287736 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 22 15:06:22.288836 systemd[1]: Reached target sysinit.target - System Initialization. Apr 22 15:06:22.290150 systemd[1]: Reached target basic.target - Basic System. Apr 22 15:06:22.292347 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 22 15:06:22.314554 systemd-fsck[786]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 22 15:06:22.317952 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 22 15:06:22.320373 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 22 15:06:22.383515 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 22 15:06:22.384676 kernel: EXT4-fs (vda9): mounted filesystem a7a89271-ee7d-4bda-a834-705261d6cda9 r/w with ordered data mode. Quota mode: none. Apr 22 15:06:22.384584 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 22 15:06:22.386492 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 22 15:06:22.387835 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 22 15:06:22.388624 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 22 15:06:22.388665 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 22 15:06:22.388691 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 22 15:06:22.398942 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 22 15:06:22.400929 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 22 15:06:22.405609 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (794) Apr 22 15:06:22.405643 kernel: BTRFS info (device vda6): first mount of filesystem 09629b08-d05c-4ce3-8bf7-615041c4b2c9 Apr 22 15:06:22.407251 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Apr 22 15:06:22.407264 kernel: BTRFS info (device vda6): using free space tree Apr 22 15:06:22.409608 kernel: BTRFS info (device vda6): auto enabling async discard Apr 22 15:06:22.410589 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 22 15:06:22.444802 initrd-setup-root[818]: cut: /sysroot/etc/passwd: No such file or directory Apr 22 15:06:22.448832 initrd-setup-root[825]: cut: /sysroot/etc/group: No such file or directory Apr 22 15:06:22.452543 initrd-setup-root[832]: cut: /sysroot/etc/shadow: No such file or directory Apr 22 15:06:22.456159 initrd-setup-root[839]: cut: /sysroot/etc/gshadow: No such file or directory Apr 22 15:06:22.548816 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 22 15:06:22.550651 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 22 15:06:22.552291 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 22 15:06:22.569706 kernel: BTRFS info (device vda6): last unmount of filesystem 09629b08-d05c-4ce3-8bf7-615041c4b2c9 Apr 22 15:06:22.610858 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 22 15:06:22.620986 ignition[908]: INFO : Ignition 2.20.0 Apr 22 15:06:22.620986 ignition[908]: INFO : Stage: mount Apr 22 15:06:22.622645 ignition[908]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 22 15:06:22.622645 ignition[908]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 22 15:06:22.622645 ignition[908]: INFO : mount: mount passed Apr 22 15:06:22.622645 ignition[908]: INFO : Ignition finished successfully Apr 22 15:06:22.623837 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 22 15:06:22.627910 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 22 15:06:22.969545 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 22 15:06:22.971042 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 22 15:06:22.990652 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/vda6 scanned by mount (921) Apr 22 15:06:22.993797 kernel: BTRFS info (device vda6): first mount of filesystem 09629b08-d05c-4ce3-8bf7-615041c4b2c9 Apr 22 15:06:22.993839 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Apr 22 15:06:22.993850 kernel: BTRFS info (device vda6): using free space tree Apr 22 15:06:22.996623 kernel: BTRFS info (device vda6): auto enabling async discard Apr 22 15:06:22.997181 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 22 15:06:23.031710 ignition[939]: INFO : Ignition 2.20.0 Apr 22 15:06:23.031710 ignition[939]: INFO : Stage: files Apr 22 15:06:23.033931 ignition[939]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 22 15:06:23.033931 ignition[939]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 22 15:06:23.033931 ignition[939]: DEBUG : files: compiled without relabeling support, skipping Apr 22 15:06:23.033931 ignition[939]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 22 15:06:23.033931 ignition[939]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 22 15:06:23.042949 ignition[939]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 22 15:06:23.042949 ignition[939]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 22 15:06:23.042949 ignition[939]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 22 15:06:23.042949 ignition[939]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 22 15:06:23.042949 ignition[939]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 22 15:06:23.042949 ignition[939]: INFO : files: op(4): [started] processing unit "flanneld.service" Apr 22 15:06:23.042949 ignition[939]: INFO : files: op(4): op(5): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Apr 22 15:06:23.042949 ignition[939]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Apr 22 15:06:23.042949 ignition[939]: INFO : files: op(4): [finished] processing unit "flanneld.service" Apr 22 15:06:23.042949 ignition[939]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Apr 22 15:06:23.042949 ignition[939]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 22 15:06:23.038129 unknown[939]: wrote ssh authorized keys file for user: core Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(8): [started] processing unit "etcd-member.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(8): op(9): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(8): [finished] processing unit "etcd-member.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(a): [started] processing unit "flannel-docker-opts.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(a): op(b): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(a): op(b): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(a): [finished] processing unit "flannel-docker-opts.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(c): [started] processing unit "docker.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(c): [finished] processing unit "docker.service" Apr 22 15:06:23.069562 ignition[939]: INFO : files: op(d): [started] setting preset to disabled for "coreos-metadata.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(d): op(e): [started] removing enablement symlink(s) for "coreos-metadata.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(d): op(e): [finished] removing enablement symlink(s) for "coreos-metadata.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(d): [finished] setting preset to disabled for "coreos-metadata.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(f): [started] setting preset to enabled for "docker.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(f): [finished] setting preset to enabled for "docker.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(10): [started] setting preset to enabled for "etcd-member.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(10): [finished] setting preset to enabled for "etcd-member.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(11): [started] setting preset to enabled for "flanneld.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: op(11): [finished] setting preset to enabled for "flanneld.service" Apr 22 15:06:23.095885 ignition[939]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 22 15:06:23.095885 ignition[939]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 22 15:06:23.095885 ignition[939]: INFO : files: files passed Apr 22 15:06:23.095885 ignition[939]: INFO : Ignition finished successfully Apr 22 15:06:23.079136 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 22 15:06:23.083182 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 22 15:06:23.088219 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 22 15:06:23.107383 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 22 15:06:23.128225 initrd-setup-root-after-ignition[966]: grep: /sysroot/oem/oem-release: No such file or directory Apr 22 15:06:23.107487 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 22 15:06:23.130872 initrd-setup-root-after-ignition[968]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 22 15:06:23.130872 initrd-setup-root-after-ignition[968]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 22 15:06:23.118125 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 22 15:06:23.135411 initrd-setup-root-after-ignition[972]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 22 15:06:23.122507 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 22 15:06:23.124299 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 22 15:06:23.169725 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 22 15:06:23.170838 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 22 15:06:23.172057 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 22 15:06:23.173734 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 22 15:06:23.175516 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 22 15:06:23.176504 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 22 15:06:23.202693 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 22 15:06:23.208074 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 22 15:06:23.228457 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 22 15:06:23.229686 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 22 15:06:23.231813 systemd[1]: Stopped target timers.target - Timer Units. Apr 22 15:06:23.233637 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 22 15:06:23.233770 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 22 15:06:23.236445 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 22 15:06:23.238600 systemd[1]: Stopped target basic.target - Basic System. Apr 22 15:06:23.240319 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 22 15:06:23.242092 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 22 15:06:23.244138 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 22 15:06:23.246209 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 22 15:06:23.248296 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 22 15:06:23.250606 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 22 15:06:23.252682 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 22 15:06:23.254466 systemd[1]: Stopped target swap.target - Swaps. Apr 22 15:06:23.256045 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 22 15:06:23.256180 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 22 15:06:23.258524 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 22 15:06:23.260585 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 22 15:06:23.262654 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 22 15:06:23.263697 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 22 15:06:23.265501 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 22 15:06:23.265643 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 22 15:06:23.268421 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 22 15:06:23.268544 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 22 15:06:23.270371 systemd[1]: Stopped target paths.target - Path Units. Apr 22 15:06:23.271846 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 22 15:06:23.276640 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 22 15:06:23.277704 systemd[1]: Stopped target slices.target - Slice Units. Apr 22 15:06:23.279785 systemd[1]: Stopped target sockets.target - Socket Units. Apr 22 15:06:23.281283 systemd[1]: iscsid.socket: Deactivated successfully. Apr 22 15:06:23.281376 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 22 15:06:23.282832 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 22 15:06:23.282915 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 22 15:06:23.284371 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 22 15:06:23.284487 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 22 15:06:23.286216 systemd[1]: ignition-files.service: Deactivated successfully. Apr 22 15:06:23.286323 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 22 15:06:23.288554 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 22 15:06:23.291141 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 22 15:06:23.292316 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 22 15:06:23.292438 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 22 15:06:23.294170 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 22 15:06:23.294278 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 22 15:06:23.304927 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 22 15:06:23.305029 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 22 15:06:23.315099 ignition[993]: INFO : Ignition 2.20.0 Apr 22 15:06:23.315099 ignition[993]: INFO : Stage: umount Apr 22 15:06:23.316868 ignition[993]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 22 15:06:23.316868 ignition[993]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 22 15:06:23.316868 ignition[993]: INFO : umount: umount passed Apr 22 15:06:23.316868 ignition[993]: INFO : Ignition finished successfully Apr 22 15:06:23.315442 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 22 15:06:23.317810 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 22 15:06:23.317933 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 22 15:06:23.321853 systemd[1]: Stopped target network.target - Network. Apr 22 15:06:23.323159 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 22 15:06:23.323238 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 22 15:06:23.324865 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 22 15:06:23.324905 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 22 15:06:23.326440 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 22 15:06:23.326478 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 22 15:06:23.328135 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 22 15:06:23.328173 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 22 15:06:23.329959 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 22 15:06:23.332179 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 22 15:06:23.333531 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 22 15:06:23.335094 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 22 15:06:23.338227 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 22 15:06:23.338333 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 22 15:06:23.342191 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Apr 22 15:06:23.343403 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 22 15:06:23.343471 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 22 15:06:23.345071 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 22 15:06:23.345126 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 22 15:06:23.348902 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Apr 22 15:06:23.349162 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 22 15:06:23.349294 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 22 15:06:23.352438 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 22 15:06:23.352510 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 22 15:06:23.354944 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 22 15:06:23.356480 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 22 15:06:23.356538 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 22 15:06:23.358508 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 22 15:06:23.358548 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 22 15:06:23.361023 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 22 15:06:23.361068 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 22 15:06:23.362670 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 22 15:06:23.386899 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 22 15:06:23.387122 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 22 15:06:23.389342 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 22 15:06:23.389389 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 22 15:06:23.390503 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 22 15:06:23.390531 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 22 15:06:23.392060 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 22 15:06:23.392102 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 22 15:06:23.394324 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 22 15:06:23.394373 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 22 15:06:23.396640 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 22 15:06:23.396690 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 22 15:06:23.400001 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 22 15:06:23.401572 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 22 15:06:23.401640 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 22 15:06:23.404570 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Apr 22 15:06:23.404625 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 22 15:06:23.406485 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 22 15:06:23.406526 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 22 15:06:23.408396 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 22 15:06:23.408437 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 22 15:06:23.412781 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 22 15:06:23.412903 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 22 15:06:23.418017 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 22 15:06:23.418116 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 22 15:06:23.419977 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 22 15:06:23.422080 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 22 15:06:23.442159 systemd[1]: Switching root. Apr 22 15:06:23.476585 systemd-journald[237]: Journal stopped Apr 22 15:06:24.197100 systemd-journald[237]: Received SIGTERM from PID 1 (systemd). Apr 22 15:06:24.197157 kernel: SELinux: policy capability network_peer_controls=1 Apr 22 15:06:24.197170 kernel: SELinux: policy capability open_perms=1 Apr 22 15:06:24.197180 kernel: SELinux: policy capability extended_socket_class=1 Apr 22 15:06:24.197197 kernel: SELinux: policy capability always_check_network=0 Apr 22 15:06:24.197229 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 22 15:06:24.197246 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 22 15:06:24.197255 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 22 15:06:24.197265 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 22 15:06:24.197278 kernel: audit: type=1403 audit(1745334383.542:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 22 15:06:24.197289 systemd[1]: Successfully loaded SELinux policy in 32.086ms. Apr 22 15:06:24.197306 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 10.246ms. Apr 22 15:06:24.197317 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) Apr 22 15:06:24.197330 systemd[1]: Detected virtualization kvm. Apr 22 15:06:24.197341 systemd[1]: Detected architecture arm64. Apr 22 15:06:24.197352 systemd[1]: Detected first boot. Apr 22 15:06:24.197362 systemd[1]: Initializing machine ID from VM UUID. Apr 22 15:06:24.197372 zram_generator::config[1042]: No configuration found. Apr 22 15:06:24.197382 kernel: NET: Registered PF_VSOCK protocol family Apr 22 15:06:24.197392 systemd[1]: Populated /etc with preset unit settings. Apr 22 15:06:24.197403 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Apr 22 15:06:24.197414 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 22 15:06:24.197429 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 22 15:06:24.197439 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 22 15:06:24.197450 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 22 15:06:24.197460 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 22 15:06:24.197471 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 22 15:06:24.197481 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 22 15:06:24.197497 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 22 15:06:24.197508 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 22 15:06:24.197521 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 22 15:06:24.197531 systemd[1]: Created slice user.slice - User and Session Slice. Apr 22 15:06:24.197549 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 22 15:06:24.197559 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 22 15:06:24.197573 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 22 15:06:24.197584 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 22 15:06:24.197617 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 22 15:06:24.197631 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 22 15:06:24.197642 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Apr 22 15:06:24.197655 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 22 15:06:24.197666 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 22 15:06:24.197676 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 22 15:06:24.197686 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 22 15:06:24.197697 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 22 15:06:24.197708 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 22 15:06:24.197718 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 22 15:06:24.197729 systemd[1]: Reached target slices.target - Slice Units. Apr 22 15:06:24.197741 systemd[1]: Reached target swap.target - Swaps. Apr 22 15:06:24.197752 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 22 15:06:24.197763 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 22 15:06:24.197773 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Apr 22 15:06:24.197783 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 22 15:06:24.197796 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 22 15:06:24.197809 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 22 15:06:24.197820 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 22 15:06:24.197830 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 22 15:06:24.197843 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 22 15:06:24.197855 systemd[1]: Mounting media.mount - External Media Directory... Apr 22 15:06:24.197865 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 22 15:06:24.197876 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 22 15:06:24.197886 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 22 15:06:24.197896 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). Apr 22 15:06:24.197906 systemd[1]: Reached target machines.target - Containers. Apr 22 15:06:24.197916 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 22 15:06:24.197930 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 22 15:06:24.197940 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 22 15:06:24.197950 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 22 15:06:24.197961 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 22 15:06:24.197971 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 22 15:06:24.197981 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 22 15:06:24.197992 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 22 15:06:24.198002 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 22 15:06:24.198013 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 22 15:06:24.198025 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 22 15:06:24.198036 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 22 15:06:24.198046 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 22 15:06:24.198056 systemd[1]: Stopped systemd-fsck-usr.service. Apr 22 15:06:24.198067 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). Apr 22 15:06:24.198078 kernel: fuse: init (API version 7.39) Apr 22 15:06:24.198088 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 22 15:06:24.198099 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 22 15:06:24.198112 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 22 15:06:24.198122 kernel: loop: module loaded Apr 22 15:06:24.198131 kernel: ACPI: bus type drm_connector registered Apr 22 15:06:24.198141 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 22 15:06:24.198152 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Apr 22 15:06:24.198163 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 22 15:06:24.198175 systemd[1]: verity-setup.service: Deactivated successfully. Apr 22 15:06:24.198185 systemd[1]: Stopped verity-setup.service. Apr 22 15:06:24.198195 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 22 15:06:24.198212 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 22 15:06:24.198225 systemd[1]: Mounted media.mount - External Media Directory. Apr 22 15:06:24.198235 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 22 15:06:24.198246 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 22 15:06:24.198277 systemd-journald[1107]: Collecting audit messages is disabled. Apr 22 15:06:24.198301 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 22 15:06:24.198314 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 22 15:06:24.198328 systemd-journald[1107]: Journal started Apr 22 15:06:24.198350 systemd-journald[1107]: Runtime Journal (/run/log/journal/eb01c42710f64c0eb5ade329e547ccaa) is 5.9M, max 47.3M, 41.4M free. Apr 22 15:06:23.989897 systemd[1]: Queued start job for default target multi-user.target. Apr 22 15:06:24.002429 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Apr 22 15:06:24.002787 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 22 15:06:24.201902 systemd[1]: Started systemd-journald.service - Journal Service. Apr 22 15:06:24.202727 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 22 15:06:24.204067 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 22 15:06:24.204348 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 22 15:06:24.205855 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 22 15:06:24.206125 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 22 15:06:24.207438 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 22 15:06:24.207764 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 22 15:06:24.209046 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 22 15:06:24.209259 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 22 15:06:24.210727 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 22 15:06:24.210899 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 22 15:06:24.212143 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 22 15:06:24.212363 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 22 15:06:24.213641 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 22 15:06:24.214859 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 22 15:06:24.216344 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 22 15:06:24.217723 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Apr 22 15:06:24.231679 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 22 15:06:24.234092 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 22 15:06:24.236049 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 22 15:06:24.237031 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 22 15:06:24.237078 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 22 15:06:24.239026 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Apr 22 15:06:24.243617 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 22 15:06:24.245622 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 22 15:06:24.246567 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 22 15:06:24.247695 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 22 15:06:24.252780 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 22 15:06:24.254033 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 22 15:06:24.255048 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 22 15:06:24.256260 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 22 15:06:24.258255 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 22 15:06:24.260882 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 22 15:06:24.268026 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 22 15:06:24.271084 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 22 15:06:24.273614 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 22 15:06:24.275574 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 22 15:06:24.276891 systemd-journald[1107]: Time spent on flushing to /var/log/journal/eb01c42710f64c0eb5ade329e547ccaa is 17.818ms for 853 entries. Apr 22 15:06:24.276891 systemd-journald[1107]: System Journal (/var/log/journal/eb01c42710f64c0eb5ade329e547ccaa) is 8M, max 195.6M, 187.6M free. Apr 22 15:06:24.316880 systemd-journald[1107]: Received client request to flush runtime journal. Apr 22 15:06:24.316937 kernel: loop0: detected capacity change from 0 to 126448 Apr 22 15:06:24.316950 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 22 15:06:24.276980 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 22 15:06:24.283758 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 22 15:06:24.286061 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 22 15:06:24.287407 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 22 15:06:24.292783 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Apr 22 15:06:24.294327 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 22 15:06:24.297432 systemd-tmpfiles[1160]: ACLs are not supported, ignoring. Apr 22 15:06:24.297442 systemd-tmpfiles[1160]: ACLs are not supported, ignoring. Apr 22 15:06:24.309034 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 22 15:06:24.312233 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 22 15:06:24.324083 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 22 15:06:24.329129 udevadm[1167]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Apr 22 15:06:24.352020 kernel: loop1: detected capacity change from 0 to 103832 Apr 22 15:06:24.354272 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Apr 22 15:06:24.368659 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 22 15:06:24.372100 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 22 15:06:24.388446 kernel: loop2: detected capacity change from 0 to 126448 Apr 22 15:06:24.399797 systemd-tmpfiles[1184]: ACLs are not supported, ignoring. Apr 22 15:06:24.399819 systemd-tmpfiles[1184]: ACLs are not supported, ignoring. Apr 22 15:06:24.401616 kernel: loop3: detected capacity change from 0 to 103832 Apr 22 15:06:24.405640 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 22 15:06:24.410779 (sd-merge)[1185]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Apr 22 15:06:24.411160 (sd-merge)[1185]: Merged extensions into '/usr'. Apr 22 15:06:24.415617 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 22 15:06:24.419100 systemd[1]: Starting ensure-sysext.service... Apr 22 15:06:24.421416 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 22 15:06:24.445742 systemd[1]: Reload requested from client PID 1190 ('systemctl') (unit ensure-sysext.service)... Apr 22 15:06:24.445767 systemd[1]: Reloading... Apr 22 15:06:24.457898 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 22 15:06:24.458103 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 22 15:06:24.458771 systemd-tmpfiles[1191]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 22 15:06:24.458971 systemd-tmpfiles[1191]: ACLs are not supported, ignoring. Apr 22 15:06:24.459019 systemd-tmpfiles[1191]: ACLs are not supported, ignoring. Apr 22 15:06:24.462149 systemd-tmpfiles[1191]: Detected autofs mount point /boot during canonicalization of boot. Apr 22 15:06:24.462159 systemd-tmpfiles[1191]: Skipping /boot Apr 22 15:06:24.473788 systemd-tmpfiles[1191]: Detected autofs mount point /boot during canonicalization of boot. Apr 22 15:06:24.473816 systemd-tmpfiles[1191]: Skipping /boot Apr 22 15:06:24.511618 zram_generator::config[1221]: No configuration found. Apr 22 15:06:24.592408 ldconfig[1154]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 22 15:06:24.619907 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 22 15:06:24.675724 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 22 15:06:24.676232 systemd[1]: Reloading finished in 230 ms. Apr 22 15:06:24.691507 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 22 15:06:24.707841 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 22 15:06:24.716725 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 22 15:06:24.719361 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 22 15:06:24.733673 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 22 15:06:24.736758 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 22 15:06:24.741265 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 22 15:06:24.746292 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 22 15:06:24.747633 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 22 15:06:24.749750 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 22 15:06:24.754839 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 22 15:06:24.756098 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 22 15:06:24.756287 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). Apr 22 15:06:24.758094 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 22 15:06:24.763400 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 22 15:06:24.763562 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 22 15:06:24.765729 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 22 15:06:24.765908 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 22 15:06:24.767900 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 22 15:06:24.768053 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 22 15:06:24.776712 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 22 15:06:24.778315 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 22 15:06:24.781875 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 22 15:06:24.809981 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 22 15:06:24.815947 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 22 15:06:24.817318 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 22 15:06:24.817509 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). Apr 22 15:06:24.819809 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 22 15:06:24.821671 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 22 15:06:24.823835 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 22 15:06:24.824015 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 22 15:06:24.826954 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 22 15:06:24.827113 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 22 15:06:24.830988 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 22 15:06:24.831169 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 22 15:06:24.833071 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 22 15:06:24.833245 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 22 15:06:24.842161 systemd[1]: Finished ensure-sysext.service. Apr 22 15:06:24.843797 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 22 15:06:24.848510 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 22 15:06:24.848705 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 22 15:06:24.852417 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Apr 22 15:06:24.858357 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 22 15:06:24.861397 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 22 15:06:24.865347 augenrules[1304]: No rules Apr 22 15:06:24.872795 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 22 15:06:24.877319 systemd[1]: audit-rules.service: Deactivated successfully. Apr 22 15:06:24.877548 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 22 15:06:24.879935 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 22 15:06:24.881955 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 22 15:06:24.884572 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). Apr 22 15:06:24.910914 systemd-udevd[1301]: Using default interface naming scheme 'v255'. Apr 22 15:06:24.924342 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Apr 22 15:06:24.926038 systemd[1]: Reached target time-set.target - System Time Set. Apr 22 15:06:24.930114 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 22 15:06:24.934997 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 22 15:06:24.936264 systemd-resolved[1261]: Positive Trust Anchors: Apr 22 15:06:24.936277 systemd-resolved[1261]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 22 15:06:24.936309 systemd-resolved[1261]: 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 Apr 22 15:06:24.948199 systemd-resolved[1261]: Defaulting to hostname 'linux'. Apr 22 15:06:24.952787 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 22 15:06:24.954158 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 22 15:06:24.968154 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Apr 22 15:06:24.982660 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1337) Apr 22 15:06:25.027310 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 22 15:06:25.031922 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 22 15:06:25.058107 systemd-networkd[1326]: lo: Link UP Apr 22 15:06:25.058115 systemd-networkd[1326]: lo: Gained carrier Apr 22 15:06:25.059251 systemd-networkd[1326]: Enumeration completed Apr 22 15:06:25.071250 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 22 15:06:25.072861 systemd[1]: Reached target network.target - Network. Apr 22 15:06:25.080857 systemd-networkd[1326]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 22 15:06:25.080867 systemd-networkd[1326]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 22 15:06:25.081450 systemd-networkd[1326]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 22 15:06:25.081484 systemd-networkd[1326]: eth0: Link UP Apr 22 15:06:25.081486 systemd-networkd[1326]: eth0: Gained carrier Apr 22 15:06:25.081495 systemd-networkd[1326]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 22 15:06:25.081784 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Apr 22 15:06:25.085168 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 22 15:06:25.089632 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 22 15:06:25.096910 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 22 15:06:25.100685 systemd-networkd[1326]: eth0: DHCPv4 address 10.0.0.37/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 22 15:06:25.101704 systemd-timesyncd[1300]: Network configuration changed, trying to establish connection. Apr 22 15:06:25.102912 systemd-timesyncd[1300]: Contacted time server 10.0.0.1:123 (10.0.0.1). Apr 22 15:06:25.102956 systemd-timesyncd[1300]: Initial clock synchronization to Tue 2025-04-22 15:06:25.186185 UTC. Apr 22 15:06:25.111524 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Apr 22 15:06:25.113341 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 22 15:06:25.117485 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 22 15:06:25.144587 lvm[1359]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 22 15:06:25.145460 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 22 15:06:25.173689 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 22 15:06:25.175148 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 22 15:06:25.176317 systemd[1]: Reached target sysinit.target - System Initialization. Apr 22 15:06:25.177486 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 22 15:06:25.178788 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 22 15:06:25.180190 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 22 15:06:25.181429 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 22 15:06:25.182723 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 22 15:06:25.183973 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 22 15:06:25.184029 systemd[1]: Reached target paths.target - Path Units. Apr 22 15:06:25.184952 systemd[1]: Reached target timers.target - Timer Units. Apr 22 15:06:25.187001 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 22 15:06:25.189392 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 22 15:06:25.192796 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Apr 22 15:06:25.194233 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Apr 22 15:06:25.195455 systemd[1]: Reached target ssh-access.target - SSH Access Available. Apr 22 15:06:25.202573 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 22 15:06:25.204237 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Apr 22 15:06:25.206490 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 22 15:06:25.208143 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 22 15:06:25.209329 systemd[1]: Reached target sockets.target - Socket Units. Apr 22 15:06:25.210309 systemd[1]: Reached target basic.target - Basic System. Apr 22 15:06:25.211270 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 22 15:06:25.211302 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 22 15:06:25.212177 systemd[1]: Starting containerd.service - containerd container runtime... Apr 22 15:06:25.216628 lvm[1366]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 22 15:06:25.214196 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 22 15:06:25.216911 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 22 15:06:25.218877 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 22 15:06:25.219959 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). Apr 22 15:06:25.225478 jq[1369]: false Apr 22 15:06:25.226147 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 22 15:06:25.227817 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 22 15:06:25.231800 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 22 15:06:25.234799 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 22 15:06:25.236577 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 22 15:06:25.236938 extend-filesystems[1370]: Found loop2 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found loop3 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda1 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda2 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda3 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found usr Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda4 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda6 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda7 Apr 22 15:06:25.237877 extend-filesystems[1370]: Found vda9 Apr 22 15:06:25.237877 extend-filesystems[1370]: Checking size of /dev/vda9 Apr 22 15:06:25.237062 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 22 15:06:25.237903 systemd[1]: Starting update-engine.service - Update Engine... Apr 22 15:06:25.240761 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 22 15:06:25.244276 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 22 15:06:25.244482 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 22 15:06:25.255367 jq[1379]: true Apr 22 15:06:25.246945 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 22 15:06:25.249001 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 22 15:06:25.249180 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 22 15:06:25.259073 dbus-daemon[1368]: [system] SELinux support is enabled Apr 22 15:06:25.261932 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 22 15:06:25.265800 systemd[1]: motdgen.service: Deactivated successfully. Apr 22 15:06:25.270843 extend-filesystems[1370]: Old size kept for /dev/vda9 Apr 22 15:06:25.274076 (ntainerd)[1391]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 22 15:06:25.274784 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 22 15:06:25.280498 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 22 15:06:25.280725 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 22 15:06:25.288576 update_engine[1378]: I20250422 15:06:25.288080 1378 main.cc:92] Flatcar Update Engine starting Apr 22 15:06:25.290797 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). Apr 22 15:06:25.290830 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 22 15:06:25.291871 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). Apr 22 15:06:25.291886 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 22 15:06:25.301616 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1329) Apr 22 15:06:25.315829 jq[1396]: true Apr 22 15:06:25.317892 update_engine[1378]: I20250422 15:06:25.317799 1378 update_check_scheduler.cc:74] Next update check in 3m51s Apr 22 15:06:25.317943 systemd[1]: Started update-engine.service - Update Engine. Apr 22 15:06:25.323755 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 22 15:06:25.329113 systemd-logind[1376]: Watching system buttons on /dev/input/event0 (Power Button) Apr 22 15:06:25.329565 systemd-logind[1376]: New seat seat0. Apr 22 15:06:25.336483 systemd[1]: Started systemd-logind.service - User Login Management. Apr 22 15:06:25.412123 bash[1418]: Updated "/home/core/.ssh/authorized_keys" Apr 22 15:06:25.415413 locksmithd[1404]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 22 15:06:25.415631 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 22 15:06:25.417538 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Apr 22 15:06:25.587119 containerd[1391]: time="2025-04-22T15:06:25Z" 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 Apr 22 15:06:25.587860 containerd[1391]: time="2025-04-22T15:06:25.587822000Z" level=info msg="starting containerd" revision=88aa2f531d6c2922003cc7929e51daf1c14caa0a version=v2.0.1 Apr 22 15:06:25.596967 containerd[1391]: time="2025-04-22T15:06:25.596917960Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.36µs" Apr 22 15:06:25.597002 containerd[1391]: time="2025-04-22T15:06:25.596968680Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Apr 22 15:06:25.597002 containerd[1391]: time="2025-04-22T15:06:25.596996960Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Apr 22 15:06:25.597692 containerd[1391]: time="2025-04-22T15:06:25.597175880Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Apr 22 15:06:25.597692 containerd[1391]: time="2025-04-22T15:06:25.597278720Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Apr 22 15:06:25.597692 containerd[1391]: time="2025-04-22T15:06:25.597349400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Apr 22 15:06:25.597692 containerd[1391]: time="2025-04-22T15:06:25.597449400Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Apr 22 15:06:25.597692 containerd[1391]: time="2025-04-22T15:06:25.597464520Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Apr 22 15:06:25.597957 containerd[1391]: time="2025-04-22T15:06:25.597911640Z" 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 Apr 22 15:06:25.597957 containerd[1391]: time="2025-04-22T15:06:25.597939760Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Apr 22 15:06:25.597957 containerd[1391]: time="2025-04-22T15:06:25.597953520Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Apr 22 15:06:25.598020 containerd[1391]: time="2025-04-22T15:06:25.597963760Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Apr 22 15:06:25.598048 containerd[1391]: time="2025-04-22T15:06:25.598038120Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Apr 22 15:06:25.598276 containerd[1391]: time="2025-04-22T15:06:25.598245400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Apr 22 15:06:25.598305 containerd[1391]: time="2025-04-22T15:06:25.598284320Z" 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 Apr 22 15:06:25.598305 containerd[1391]: time="2025-04-22T15:06:25.598295880Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Apr 22 15:06:25.598354 containerd[1391]: time="2025-04-22T15:06:25.598324840Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Apr 22 15:06:25.598583 containerd[1391]: time="2025-04-22T15:06:25.598552560Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Apr 22 15:06:25.598666 containerd[1391]: time="2025-04-22T15:06:25.598648960Z" level=info msg="metadata content store policy set" policy=shared Apr 22 15:06:25.605265 containerd[1391]: time="2025-04-22T15:06:25.605225040Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Apr 22 15:06:25.605301 containerd[1391]: time="2025-04-22T15:06:25.605283440Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Apr 22 15:06:25.605320 containerd[1391]: time="2025-04-22T15:06:25.605298080Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Apr 22 15:06:25.605320 containerd[1391]: time="2025-04-22T15:06:25.605311160Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Apr 22 15:06:25.605369 containerd[1391]: time="2025-04-22T15:06:25.605324840Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Apr 22 15:06:25.605369 containerd[1391]: time="2025-04-22T15:06:25.605337760Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Apr 22 15:06:25.605369 containerd[1391]: time="2025-04-22T15:06:25.605351640Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Apr 22 15:06:25.605421 containerd[1391]: time="2025-04-22T15:06:25.605374440Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Apr 22 15:06:25.605421 containerd[1391]: time="2025-04-22T15:06:25.605386960Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Apr 22 15:06:25.605421 containerd[1391]: time="2025-04-22T15:06:25.605398440Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Apr 22 15:06:25.605421 containerd[1391]: time="2025-04-22T15:06:25.605411240Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Apr 22 15:06:25.605484 containerd[1391]: time="2025-04-22T15:06:25.605423560Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Apr 22 15:06:25.605596 containerd[1391]: time="2025-04-22T15:06:25.605563200Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Apr 22 15:06:25.605628 containerd[1391]: time="2025-04-22T15:06:25.605607560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Apr 22 15:06:25.605659 containerd[1391]: time="2025-04-22T15:06:25.605635640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Apr 22 15:06:25.605659 containerd[1391]: time="2025-04-22T15:06:25.605647400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Apr 22 15:06:25.605693 containerd[1391]: time="2025-04-22T15:06:25.605658440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Apr 22 15:06:25.605693 containerd[1391]: time="2025-04-22T15:06:25.605669440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Apr 22 15:06:25.605693 containerd[1391]: time="2025-04-22T15:06:25.605682480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Apr 22 15:06:25.605754 containerd[1391]: time="2025-04-22T15:06:25.605693720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Apr 22 15:06:25.605754 containerd[1391]: time="2025-04-22T15:06:25.605705440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Apr 22 15:06:25.605754 containerd[1391]: time="2025-04-22T15:06:25.605717000Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Apr 22 15:06:25.605754 containerd[1391]: time="2025-04-22T15:06:25.605728080Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Apr 22 15:06:25.606078 containerd[1391]: time="2025-04-22T15:06:25.606051200Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Apr 22 15:06:25.606078 containerd[1391]: time="2025-04-22T15:06:25.606074680Z" level=info msg="Start snapshots syncer" Apr 22 15:06:25.606133 containerd[1391]: time="2025-04-22T15:06:25.606094920Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Apr 22 15:06:25.606370 containerd[1391]: time="2025-04-22T15:06:25.606325840Z" 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\"}" Apr 22 15:06:25.606583 containerd[1391]: time="2025-04-22T15:06:25.606381240Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Apr 22 15:06:25.606583 containerd[1391]: time="2025-04-22T15:06:25.606453920Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Apr 22 15:06:25.606583 containerd[1391]: time="2025-04-22T15:06:25.606564000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Apr 22 15:06:25.606682 containerd[1391]: time="2025-04-22T15:06:25.606614960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Apr 22 15:06:25.606682 containerd[1391]: time="2025-04-22T15:06:25.606631320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Apr 22 15:06:25.606682 containerd[1391]: time="2025-04-22T15:06:25.606642400Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Apr 22 15:06:25.606682 containerd[1391]: time="2025-04-22T15:06:25.606655000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Apr 22 15:06:25.606682 containerd[1391]: time="2025-04-22T15:06:25.606665640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Apr 22 15:06:25.606682 containerd[1391]: time="2025-04-22T15:06:25.606677000Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Apr 22 15:06:25.606782 containerd[1391]: time="2025-04-22T15:06:25.606704480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Apr 22 15:06:25.606782 containerd[1391]: time="2025-04-22T15:06:25.606717880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Apr 22 15:06:25.606782 containerd[1391]: time="2025-04-22T15:06:25.606728240Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Apr 22 15:06:25.606782 containerd[1391]: time="2025-04-22T15:06:25.606761960Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Apr 22 15:06:25.606782 containerd[1391]: time="2025-04-22T15:06:25.606774760Z" 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 Apr 22 15:06:25.606861 containerd[1391]: time="2025-04-22T15:06:25.606784520Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Apr 22 15:06:25.606861 containerd[1391]: time="2025-04-22T15:06:25.606794480Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Apr 22 15:06:25.606861 containerd[1391]: time="2025-04-22T15:06:25.606802200Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Apr 22 15:06:25.606861 containerd[1391]: time="2025-04-22T15:06:25.606813160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Apr 22 15:06:25.606861 containerd[1391]: time="2025-04-22T15:06:25.606824360Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Apr 22 15:06:25.607291 containerd[1391]: time="2025-04-22T15:06:25.606950360Z" level=info msg="runtime interface created" Apr 22 15:06:25.607291 containerd[1391]: time="2025-04-22T15:06:25.606967520Z" level=info msg="created NRI interface" Apr 22 15:06:25.607291 containerd[1391]: time="2025-04-22T15:06:25.606978600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Apr 22 15:06:25.607291 containerd[1391]: time="2025-04-22T15:06:25.606991720Z" level=info msg="Connect containerd service" Apr 22 15:06:25.607291 containerd[1391]: time="2025-04-22T15:06:25.607030520Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 22 15:06:25.607757 containerd[1391]: time="2025-04-22T15:06:25.607715000Z" 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" Apr 22 15:06:25.654895 sshd_keygen[1395]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 22 15:06:25.674839 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 22 15:06:25.680303 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 22 15:06:25.699783 systemd[1]: issuegen.service: Deactivated successfully. Apr 22 15:06:25.699987 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 22 15:06:25.706794 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 22 15:06:25.734970 containerd[1391]: time="2025-04-22T15:06:25.734918680Z" level=info msg="Start subscribing containerd event" Apr 22 15:06:25.735226 containerd[1391]: time="2025-04-22T15:06:25.735101360Z" level=info msg="Start recovering state" Apr 22 15:06:25.735350 containerd[1391]: time="2025-04-22T15:06:25.735318320Z" level=info msg="Start event monitor" Apr 22 15:06:25.735466 containerd[1391]: time="2025-04-22T15:06:25.735390120Z" level=info msg="Start cni network conf syncer for default" Apr 22 15:06:25.735466 containerd[1391]: time="2025-04-22T15:06:25.735402840Z" level=info msg="Start streaming server" Apr 22 15:06:25.735466 containerd[1391]: time="2025-04-22T15:06:25.735412640Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Apr 22 15:06:25.735466 containerd[1391]: time="2025-04-22T15:06:25.735419080Z" level=info msg="runtime interface starting up..." Apr 22 15:06:25.735466 containerd[1391]: time="2025-04-22T15:06:25.735424640Z" level=info msg="starting plugins..." Apr 22 15:06:25.735466 containerd[1391]: time="2025-04-22T15:06:25.735440640Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Apr 22 15:06:25.735950 containerd[1391]: time="2025-04-22T15:06:25.735669040Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 22 15:06:25.735950 containerd[1391]: time="2025-04-22T15:06:25.735714360Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 22 15:06:25.736998 containerd[1391]: time="2025-04-22T15:06:25.736192600Z" level=info msg="containerd successfully booted in 0.149466s" Apr 22 15:06:25.736315 systemd[1]: Started containerd.service - containerd container runtime. Apr 22 15:06:25.739127 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 22 15:06:25.742942 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 22 15:06:25.745146 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Apr 22 15:06:25.746320 systemd[1]: Reached target getty.target - Login Prompts. Apr 22 15:06:26.298053 systemd-networkd[1326]: eth0: Gained IPv6LL Apr 22 15:06:26.300611 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 22 15:06:26.302528 systemd[1]: Reached target network-online.target - Network is Online. Apr 22 15:06:26.305155 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 22 15:06:26.307236 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 22 15:06:26.334702 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 22 15:06:26.334981 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 22 15:06:26.337652 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 22 15:06:26.341040 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Apr 22 15:06:26.342236 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 22 15:06:26.362047 (-wrapper)[1477]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Apr 22 15:06:26.498896 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 22 15:06:26.511891 (dockerd)[1489]: 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 Apr 22 15:06:26.802934 dockerd[1489]: time="2025-04-22T15:06:26.802876687Z" level=info msg="Starting up" Apr 22 15:06:26.804796 dockerd[1489]: time="2025-04-22T15:06:26.804766318Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Apr 22 15:06:26.844878 dockerd[1489]: time="2025-04-22T15:06:26.844831467Z" level=info msg="Loading containers: start." Apr 22 15:06:26.989629 kernel: Initializing XFRM netlink socket Apr 22 15:06:27.051837 systemd-networkd[1326]: docker0: Link UP Apr 22 15:06:27.122915 dockerd[1489]: time="2025-04-22T15:06:27.122801575Z" level=info msg="Loading containers: done." Apr 22 15:06:27.135917 dockerd[1489]: time="2025-04-22T15:06:27.135871925Z" 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 Apr 22 15:06:27.136119 dockerd[1489]: time="2025-04-22T15:06:27.135958425Z" level=info msg="Docker daemon" commit=c710b88579fcb5e0d53f96dcae976d79323b9166 containerd-snapshotter=false storage-driver=overlay2 version=27.4.1 Apr 22 15:06:27.136205 dockerd[1489]: time="2025-04-22T15:06:27.136186413Z" level=info msg="Daemon has completed initialization" Apr 22 15:06:27.162920 dockerd[1489]: time="2025-04-22T15:06:27.162862553Z" level=info msg="API listen on /run/docker.sock" Apr 22 15:06:27.163095 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 22 15:06:27.164278 etcd-wrapper[1481]: Error response from daemon: No such container: etcd-member Apr 22 15:06:27.176195 etcd-wrapper[1678]: Error response from daemon: No such container: etcd-member Apr 22 15:06:27.201486 etcd-wrapper[1698]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally Apr 22 15:06:28.022543 etcd-wrapper[1698]: v3.5.0: Pulling from coreos/etcd Apr 22 15:06:28.684628 etcd-wrapper[1698]: 6022c6b01d76: Pulling fs layer Apr 22 15:06:28.684628 etcd-wrapper[1698]: 1d97b1ec77fc: Pulling fs layer Apr 22 15:06:28.684628 etcd-wrapper[1698]: 99ef4b690837: Pulling fs layer Apr 22 15:06:28.684628 etcd-wrapper[1698]: 435b7bf0967c: Pulling fs layer Apr 22 15:06:28.684628 etcd-wrapper[1698]: 17e4a5f7c1b5: Pulling fs layer Apr 22 15:06:28.684628 etcd-wrapper[1698]: 5b0292999756: Pulling fs layer Apr 22 15:06:28.684628 etcd-wrapper[1698]: 17e4a5f7c1b5: Waiting Apr 22 15:06:28.684628 etcd-wrapper[1698]: 435b7bf0967c: Waiting Apr 22 15:06:28.684628 etcd-wrapper[1698]: 5b0292999756: Waiting Apr 22 15:06:28.975704 etcd-wrapper[1698]: 1d97b1ec77fc: Verifying Checksum Apr 22 15:06:28.975704 etcd-wrapper[1698]: 1d97b1ec77fc: Download complete Apr 22 15:06:29.335216 etcd-wrapper[1698]: 435b7bf0967c: Verifying Checksum Apr 22 15:06:29.335216 etcd-wrapper[1698]: 435b7bf0967c: Download complete Apr 22 15:06:29.439185 etcd-wrapper[1698]: 99ef4b690837: Verifying Checksum Apr 22 15:06:29.439185 etcd-wrapper[1698]: 99ef4b690837: Download complete Apr 22 15:06:29.727560 etcd-wrapper[1698]: 17e4a5f7c1b5: Verifying Checksum Apr 22 15:06:29.727560 etcd-wrapper[1698]: 17e4a5f7c1b5: Download complete Apr 22 15:06:30.000305 etcd-wrapper[1698]: 5b0292999756: Verifying Checksum Apr 22 15:06:30.000305 etcd-wrapper[1698]: 5b0292999756: Download complete Apr 22 15:06:32.483134 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 22 15:06:32.484275 systemd[1]: Started sshd@0-10.0.0.37:22-10.0.0.1:45524.service - OpenSSH per-connection server daemon (10.0.0.1:45524). Apr 22 15:06:32.567330 sshd[1715]: Accepted publickey for core from 10.0.0.1 port 45524 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:32.569305 sshd-session[1715]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:32.575193 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 22 15:06:32.576118 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 22 15:06:32.581302 systemd-logind[1376]: New session 1 of user core. Apr 22 15:06:32.599265 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 22 15:06:32.601737 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 22 15:06:32.616516 (systemd)[1719]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 22 15:06:32.618338 systemd-logind[1376]: New session c1 of user core. Apr 22 15:06:32.721518 systemd[1719]: Queued start job for default target default.target. Apr 22 15:06:32.732492 systemd[1719]: Created slice app.slice - User Application Slice. Apr 22 15:06:32.732519 systemd[1719]: Reached target paths.target - Paths. Apr 22 15:06:32.732554 systemd[1719]: Reached target timers.target - Timers. Apr 22 15:06:32.733738 systemd[1719]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 22 15:06:32.743044 systemd[1719]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 22 15:06:32.743106 systemd[1719]: Reached target sockets.target - Sockets. Apr 22 15:06:32.743142 systemd[1719]: Reached target basic.target - Basic System. Apr 22 15:06:32.743172 systemd[1719]: Reached target default.target - Main User Target. Apr 22 15:06:32.743196 systemd[1719]: Startup finished in 120ms. Apr 22 15:06:32.743382 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 22 15:06:32.754784 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 22 15:06:32.820516 systemd[1]: Started sshd@1-10.0.0.37:22-10.0.0.1:45536.service - OpenSSH per-connection server daemon (10.0.0.1:45536). Apr 22 15:06:32.887109 sshd[1730]: Accepted publickey for core from 10.0.0.1 port 45536 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:32.888292 sshd-session[1730]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:32.892398 systemd-logind[1376]: New session 2 of user core. Apr 22 15:06:32.901796 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 22 15:06:32.952486 sshd[1732]: Connection closed by 10.0.0.1 port 45536 Apr 22 15:06:32.952934 sshd-session[1730]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:32.969720 systemd[1]: sshd@1-10.0.0.37:22-10.0.0.1:45536.service: Deactivated successfully. Apr 22 15:06:32.971063 systemd[1]: session-2.scope: Deactivated successfully. Apr 22 15:06:32.973758 systemd-logind[1376]: Session 2 logged out. Waiting for processes to exit. Apr 22 15:06:32.974743 systemd[1]: Started sshd@2-10.0.0.37:22-10.0.0.1:45544.service - OpenSSH per-connection server daemon (10.0.0.1:45544). Apr 22 15:06:32.975883 systemd-logind[1376]: Removed session 2. Apr 22 15:06:33.023888 sshd[1737]: Accepted publickey for core from 10.0.0.1 port 45544 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:33.025027 sshd-session[1737]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:33.028660 systemd-logind[1376]: New session 3 of user core. Apr 22 15:06:33.036724 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 22 15:06:33.086827 sshd[1740]: Connection closed by 10.0.0.1 port 45544 Apr 22 15:06:33.087124 sshd-session[1737]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:33.089981 systemd[1]: sshd@2-10.0.0.37:22-10.0.0.1:45544.service: Deactivated successfully. Apr 22 15:06:33.091281 systemd[1]: session-3.scope: Deactivated successfully. Apr 22 15:06:33.091988 systemd-logind[1376]: Session 3 logged out. Waiting for processes to exit. Apr 22 15:06:33.092777 systemd-logind[1376]: Removed session 3. Apr 22 15:06:34.995640 etcd-wrapper[1698]: 6022c6b01d76: Verifying Checksum Apr 22 15:06:34.995640 etcd-wrapper[1698]: 6022c6b01d76: Download complete Apr 22 15:06:35.544455 etcd-wrapper[1698]: 6022c6b01d76: Pull complete Apr 22 15:06:35.631415 systemd[1]: var-lib-docker-overlay2-d981f04430307dbd8e89cf4f724f86ee8fc397bef12cbdbc355d8d4bd471e661-merged.mount: Deactivated successfully. Apr 22 15:06:35.744917 etcd-wrapper[1698]: 1d97b1ec77fc: Pull complete Apr 22 15:06:35.814030 systemd[1]: var-lib-docker-overlay2-b9458288214a7c8b495b3fa88f4ee29d82432f8647e5d9b52ec36bef59f9bf78-merged.mount: Deactivated successfully. Apr 22 15:06:35.839028 etcd-wrapper[1698]: 99ef4b690837: Pull complete Apr 22 15:06:35.931876 etcd-wrapper[1698]: 435b7bf0967c: Pull complete Apr 22 15:06:35.946440 etcd-wrapper[1698]: 17e4a5f7c1b5: Pull complete Apr 22 15:06:35.959216 etcd-wrapper[1698]: 5b0292999756: Pull complete Apr 22 15:06:35.964902 etcd-wrapper[1698]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b Apr 22 15:06:35.966965 etcd-wrapper[1698]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 Apr 22 15:06:36.009830 containerd[1391]: time="2025-04-22T15:06:36.009788380Z" level=info msg="connecting to shim 01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603" address="unix:///run/containerd/s/ca3b45abd7c5d3e4cbf08d6e078bc650dd414436f9a946d0ee28e789df79575f" namespace=moby protocol=ttrpc version=3 Apr 22 15:06:36.033766 systemd[1]: Started docker-01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603.scope - libcontainer container 01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603. Apr 22 15:06:36.045928 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"info","ts":1745334396.0948853,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"info","ts":1745334396.0949528,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"eb01c42710f64c0eb5ade329e547ccaa"} Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"warn","ts":1745334396.094975,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"warn","ts":1745334396.0949857,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"warn","ts":1745334396.0949907,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"warn","ts":1745334396.0949967,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Apr 22 15:06:36.095203 etcd-wrapper[1698]: {"level":"warn","ts":1745334396.0950022,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Apr 22 15:06:36.095872 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.095Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.37:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.37:2380","--advertise-client-urls=http://10.0.0.37:2379","--discovery=http://10.0.0.1:42587/v2/keys/discovery/7413413644825116267","--enable-v2=true"]} Apr 22 15:06:36.095872 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.095Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.37:2380"]} Apr 22 15:06:36.095872 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.095Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Apr 22 15:06:36.096001 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.095Z","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":"eb01c42710f64c0eb5ade329e547ccaa","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.37:2380"],"listen-peer-urls":["http://10.0.0.37:2380"],"advertise-client-urls":["http://10.0.0.37:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"eb01c42710f64c0eb5ade329e547ccaa=http://10.0.0.37:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:42587/v2/keys/discovery/7413413644825116267","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:42587/v2/keys/discovery/7413413644825116267","discovery-proxy":"","downgrade-check-interval":"5s"} Apr 22 15:06:36.097660 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.097Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.615802ms"} Apr 22 15:06:36.100814 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.100Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:42587","peer":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.100814 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.100Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:42587","peer":"c55982034cf1fff5"} Apr 22 15:06:36.100814 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.100Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:42587","self":"17de436639338112"} Apr 22 15:06:36.100814 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.100Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:42587","found-peers":3} Apr 22 15:06:36.104741 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.104Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"17de436639338112","cluster-id":"73366b117b0a884d"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=()"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became follower at term 0"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 17de436639338112 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became follower at term 1"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034)"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295)"} Apr 22 15:06:36.106632 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295 14220540249086492661)"} Apr 22 15:06:36.108500 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:36.108Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Apr 22 15:06:36.110610 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.110Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Apr 22 15:06:36.112052 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.111Z","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"} Apr 22 15:06:36.112670 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.112Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.112670 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.112Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.113972 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.113Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.113972 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.113Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.114318 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.114Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.114318 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.114Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.114318 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.114Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f","remote-peer-urls":["http://10.0.0.38:2380"]} Apr 22 15:06:36.114318 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.114Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.114518 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.114Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.114518 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.114Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.115Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.115Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5","remote-peer-urls":["http://10.0.0.39:2380"]} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"17de436639338112","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.116676 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Apr 22 15:06:36.117011 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.117011 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.117011 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.117079 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.116Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.117409 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295 14220540249086492661)"} Apr 22 15:06:36.117409 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.117Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","added-peer-id":"17de436639338112","added-peer-peer-urls":["http://10.0.0.37:2380"]} Apr 22 15:06:36.117654 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295 14220540249086492661)"} Apr 22 15:06:36.117654 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.117Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","added-peer-id":"1f1c4ab1462d0f0f","added-peer-peer-urls":["http://10.0.0.38:2380"]} Apr 22 15:06:36.117654 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295 14220540249086492661)"} Apr 22 15:06:36.117654 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.117Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","added-peer-id":"c55982034cf1fff5","added-peer-peer-urls":["http://10.0.0.39:2380"]} Apr 22 15:06:36.118294 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:36.118Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Apr 22 15:06:36.118402 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.37:2380"} Apr 22 15:06:36.118402 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.37:2380"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"17de436639338112","initial-advertise-peer-urls":["http://10.0.0.37:2380"],"listen-peer-urls":["http://10.0.0.37:2380"],"advertise-client-urls":["http://10.0.0.37:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"c55982034cf1fff5","stream-type":"stream Message"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"1f1c4ab1462d0f0f","stream-type":"stream MsgApp v2"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"1f1c4ab1462d0f0f","stream-type":"stream Message"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:36.118787 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.119051 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"c55982034cf1fff5","stream-type":"stream MsgApp v2"} Apr 22 15:06:36.119051 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.118Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.120944 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.120Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.121222 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.121Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:36.167570 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.167Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"17de436639338112","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Apr 22 15:06:36.405503 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 1f1c4ab1462d0f0f [logterm: 1, index: 3] at term 1"} Apr 22 15:06:36.407620 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [term: 1] received a MsgVote message with higher term from 1f1c4ab1462d0f0f [term: 2]"} Apr 22 15:06:36.407620 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became follower at term 2"} Apr 22 15:06:36.407620 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 1, index: 3, vote: 0] cast MsgVote for 1f1c4ab1462d0f0f [logterm: 1, index: 3] at term 2"} Apr 22 15:06:36.408398 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 17de436639338112 elected leader 1f1c4ab1462d0f0f at term 2"} Apr 22 15:06:36.410511 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.410Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"17de436639338112","local-member-attributes":"{Name:eb01c42710f64c0eb5ade329e547ccaa ClientURLs:[http://10.0.0.37:2379]}","request-path":"/0/members/17de436639338112/attributes","cluster-id":"73366b117b0a884d","publish-timeout":"7s"} Apr 22 15:06:36.410660 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.410Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Apr 22 15:06:36.410660 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.410Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Apr 22 15:06:36.411344 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.411Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Apr 22 15:06:36.411430 systemd[1]: Started etcd-member.service - etcd (System Application Container). Apr 22 15:06:36.412117 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.411Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Apr 22 15:06:36.412542 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.412Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","cluster-version":"3.5"} Apr 22 15:06:36.412542 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:36.412Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Apr 22 15:06:36.413393 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Apr 22 15:06:36.516731 etcdctl[1831]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Apr 22 15:06:36.547536 flannel-wrapper[1840]: Error response from daemon: No such container: flannel Apr 22 15:06:36.552920 systemd[1]: var-lib-docker-overlay2-8dbd4132932768a59b2ac77735cc28d72d43adbe6baba94eb9930acdeb990f8c-merged.mount: Deactivated successfully. Apr 22 15:06:36.559844 flannel-wrapper[1849]: Error response from daemon: No such container: flannel Apr 22 15:06:36.574486 flannel-wrapper[1868]: Unable to find image 'quay.io/coreos/flannel:v0.14.0-arm64' locally Apr 22 15:06:37.268303 flannel-wrapper[1868]: v0.14.0-arm64: Pulling from coreos/flannel Apr 22 15:06:37.268406 flannel-wrapper[1868]: b538f80385f9: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: 782376d11ccb: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: ab023a03e512: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: 1ce603871d35: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: 2ff40439b6d5: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: f6c30695e556: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: 071b96dd834b: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: e9e292d9edba: Pulling fs layer Apr 22 15:06:37.268406 flannel-wrapper[1868]: 1ce603871d35: Waiting Apr 22 15:06:37.268406 flannel-wrapper[1868]: 2ff40439b6d5: Waiting Apr 22 15:06:37.268406 flannel-wrapper[1868]: f6c30695e556: Waiting Apr 22 15:06:37.268406 flannel-wrapper[1868]: 071b96dd834b: Waiting Apr 22 15:06:37.268406 flannel-wrapper[1868]: e9e292d9edba: Waiting Apr 22 15:06:37.682665 flannel-wrapper[1868]: b538f80385f9: Verifying Checksum Apr 22 15:06:37.682665 flannel-wrapper[1868]: b538f80385f9: Download complete Apr 22 15:06:37.757399 flannel-wrapper[1868]: b538f80385f9: Pull complete Apr 22 15:06:37.897718 flannel-wrapper[1868]: 782376d11ccb: Verifying Checksum Apr 22 15:06:37.897718 flannel-wrapper[1868]: 782376d11ccb: Download complete Apr 22 15:06:37.931671 systemd[1]: var-lib-docker-overlay2-7b048d6c1d966f7046b6010e0e76d129cd27e5ff0b9b1c34eedd2fee62c1fdcb-merged.mount: Deactivated successfully. Apr 22 15:06:37.957071 flannel-wrapper[1868]: 782376d11ccb: Pull complete Apr 22 15:06:38.024659 flannel-wrapper[1868]: ab023a03e512: Verifying Checksum Apr 22 15:06:38.024659 flannel-wrapper[1868]: ab023a03e512: Download complete Apr 22 15:06:38.121817 flannel-wrapper[1868]: 1ce603871d35: Verifying Checksum Apr 22 15:06:38.121817 flannel-wrapper[1868]: 1ce603871d35: Download complete Apr 22 15:06:38.222118 systemd[1]: var-lib-docker-overlay2-73c522e3e8d3f6d4527e31a639f414f73d066a1b558a8710711c49cb31a3e3f9-merged.mount: Deactivated successfully. Apr 22 15:06:38.248059 flannel-wrapper[1868]: ab023a03e512: Pull complete Apr 22 15:06:38.293107 flannel-wrapper[1868]: 1ce603871d35: Pull complete Apr 22 15:06:38.494195 flannel-wrapper[1868]: 071b96dd834b: Verifying Checksum Apr 22 15:06:38.494195 flannel-wrapper[1868]: 071b96dd834b: Download complete Apr 22 15:06:38.632270 flannel-wrapper[1868]: f6c30695e556: Verifying Checksum Apr 22 15:06:38.632270 flannel-wrapper[1868]: f6c30695e556: Download complete Apr 22 15:06:38.853229 flannel-wrapper[1868]: e9e292d9edba: Download complete Apr 22 15:06:38.903280 systemd[1]: var-lib-docker-overlay2-7f10589ee279369afacda2d4afd44c6cd6e90c9a2be6ac1133e715f649c94dde-merged.mount: Deactivated successfully. Apr 22 15:06:38.981475 dockerd[1489]: time="2025-04-22T15:06:38.981354911Z" level=info msg="Download failed, retrying (1/5): unexpected EOF" Apr 22 15:06:38.981876 flannel-wrapper[1868]: 2ff40439b6d5: Retrying in 5 seconds Apr 22 15:06:39.981864 flannel-wrapper[1868]: 2ff40439b6d5: Retrying in 4 seconds Apr 22 15:06:40.982132 flannel-wrapper[1868]: 2ff40439b6d5: Retrying in 3 seconds Apr 22 15:06:41.981827 flannel-wrapper[1868]: 2ff40439b6d5: Retrying in 2 seconds Apr 22 15:06:42.982587 flannel-wrapper[1868]: 2ff40439b6d5: Retrying in 1 second Apr 22 15:06:43.131165 systemd[1]: Started sshd@3-10.0.0.37:22-10.0.0.1:41048.service - OpenSSH per-connection server daemon (10.0.0.1:41048). Apr 22 15:06:43.190170 sshd[1897]: Accepted publickey for core from 10.0.0.1 port 41048 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:43.191434 sshd-session[1897]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:43.195622 systemd-logind[1376]: New session 4 of user core. Apr 22 15:06:43.204767 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 22 15:06:43.256392 sshd[1899]: Connection closed by 10.0.0.1 port 41048 Apr 22 15:06:43.256795 sshd-session[1897]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:43.266019 systemd[1]: sshd@3-10.0.0.37:22-10.0.0.1:41048.service: Deactivated successfully. Apr 22 15:06:43.267451 systemd[1]: session-4.scope: Deactivated successfully. Apr 22 15:06:43.268104 systemd-logind[1376]: Session 4 logged out. Waiting for processes to exit. Apr 22 15:06:43.271783 systemd[1]: Started sshd@4-10.0.0.37:22-10.0.0.1:41060.service - OpenSSH per-connection server daemon (10.0.0.1:41060). Apr 22 15:06:43.272658 systemd-logind[1376]: Removed session 4. Apr 22 15:06:43.330086 sshd[1904]: Accepted publickey for core from 10.0.0.1 port 41060 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:43.331335 sshd-session[1904]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:43.335669 systemd-logind[1376]: New session 5 of user core. Apr 22 15:06:43.344744 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 22 15:06:43.396150 sshd[1907]: Connection closed by 10.0.0.1 port 41060 Apr 22 15:06:43.396650 sshd-session[1904]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:43.399826 systemd[1]: sshd@4-10.0.0.37:22-10.0.0.1:41060.service: Deactivated successfully. Apr 22 15:06:43.401420 systemd[1]: session-5.scope: Deactivated successfully. Apr 22 15:06:43.402716 systemd-logind[1376]: Session 5 logged out. Waiting for processes to exit. Apr 22 15:06:43.403580 systemd-logind[1376]: Removed session 5. Apr 22 15:06:44.126722 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [term 2] received MsgTimeoutNow from 1f1c4ab1462d0f0f and starts an election to get leadership."} Apr 22 15:06:44.126722 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 is starting a new election at term 2"} Apr 22 15:06:44.126722 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became candidate at term 3"} Apr 22 15:06:44.126722 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 received MsgVoteResp from 17de436639338112 at term 3"} Apr 22 15:06:44.126722 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 2, index: 18] sent MsgVote request to 1f1c4ab1462d0f0f at term 3"} Apr 22 15:06:44.126722 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 2, index: 18] sent MsgVote request to c55982034cf1fff5 at term 3"} Apr 22 15:06:44.127230 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 17de436639338112 lost leader 1f1c4ab1462d0f0f at term 3"} Apr 22 15:06:44.128622 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 received MsgVoteResp from c55982034cf1fff5 at term 3"} Apr 22 15:06:44.128622 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 has received 2 MsgVoteResp votes and 0 vote rejections"} Apr 22 15:06:44.128622 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became leader at term 3"} Apr 22 15:06:44.128622 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:44.128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 17de436639338112 elected leader 17de436639338112 at term 3"} Apr 22 15:06:44.226738 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:44.226Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f","error":"EOF"} Apr 22 15:06:44.227148 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:44.226Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f","error":"EOF"} Apr 22 15:06:44.231918 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:44.231Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"1f1c4ab1462d0f0f","error":"failed to dial 1f1c4ab1462d0f0f on stream Message (peer 1f1c4ab1462d0f0f failed to find local node 17de436639338112)"} Apr 22 15:06:44.348128 flannel-wrapper[1868]: 2ff40439b6d5: Verifying Checksum Apr 22 15:06:44.348128 flannel-wrapper[1868]: 2ff40439b6d5: Download complete Apr 22 15:06:44.504154 systemd[1]: var-lib-docker-overlay2-f5871f8595526bf263f6ae8f61c41420c3a85186773bc775a88de01896391d82-merged.mount: Deactivated successfully. Apr 22 15:06:44.507555 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:44.507Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:44.596677 flannel-wrapper[1868]: 2ff40439b6d5: Pull complete Apr 22 15:06:44.605906 systemd[1]: var-lib-docker-overlay2-7b5d446d54171b91fe731b6b2d5f41c49f84d8b5c3b4569e6ab8992fdea9dd6e-merged.mount: Deactivated successfully. Apr 22 15:06:44.611937 flannel-wrapper[1868]: f6c30695e556: Pull complete Apr 22 15:06:44.627360 flannel-wrapper[1868]: 071b96dd834b: Pull complete Apr 22 15:06:44.647388 flannel-wrapper[1868]: e9e292d9edba: Pull complete Apr 22 15:06:44.654246 flannel-wrapper[1868]: Digest: sha256:dad4e92d4eb00d129a664ac7b44a71a5cbadea8a7f11b5b239e1e2b2701baac6 Apr 22 15:06:44.656357 flannel-wrapper[1868]: Status: Downloaded newer image for quay.io/coreos/flannel:v0.14.0-arm64 Apr 22 15:06:44.698878 containerd[1391]: time="2025-04-22T15:06:44.698826265Z" level=info msg="connecting to shim 5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62" address="unix:///run/containerd/s/02808f12662f297557baa88ef90c1c48955fa331793048208317b91e63300b1d" namespace=moby protocol=ttrpc version=3 Apr 22 15:06:44.721781 systemd[1]: Started docker-5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62.scope - libcontainer container 5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62. Apr 22 15:06:44.737012 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 22 15:06:44.880939 flannel-wrapper[1868]: I0422 15:06:44.880506 1 main.go:520] Determining IP address of default interface Apr 22 15:06:44.880939 flannel-wrapper[1868]: I0422 15:06:44.880773 1 main.go:533] Using interface with name eth0 and address 10.0.0.37 Apr 22 15:06:44.880939 flannel-wrapper[1868]: I0422 15:06:44.880789 1 main.go:550] Defaulting external address to interface address (10.0.0.37) Apr 22 15:06:44.881572 flannel-wrapper[1868]: I0422 15:06:44.880956 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: None Apr 22 15:06:44.881572 flannel-wrapper[1868]: I0422 15:06:44.880963 1 main.go:257] Installing signal handlers Apr 22 15:06:44.883925 flannel-wrapper[1868]: I0422 15:06:44.883736 1 main.go:392] Found network config - Backend type: vxlan Apr 22 15:06:44.884267 flannel-wrapper[1868]: I0422 15:06:44.883862 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Apr 22 15:06:44.904271 flannel-wrapper[1868]: I0422 15:06:44.904016 1 local_manager.go:234] Picking subnet in range 10.254.1.0 ... 10.254.255.0 Apr 22 15:06:44.905200 flannel-wrapper[1868]: I0422 15:06:44.905075 1 local_manager.go:220] Allocated lease (10.254.26.0/24) to current node (10.0.0.37) Apr 22 15:06:44.905765 systemd-networkd[1326]: flannel.1: Link UP Apr 22 15:06:44.905770 systemd-networkd[1326]: flannel.1: Gained carrier Apr 22 15:06:44.906339 flannel-wrapper[1868]: I0422 15:06:44.905693 1 main.go:357] Current network or subnet (10.254.0.0/16, 10.254.26.0/24) is not equal to previous one (0.0.0.0/0, 0.0.0.0/0), trying to recycle old iptables rules Apr 22 15:06:44.935407 flannel-wrapper[1868]: I0422 15:06:44.935213 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Apr 22 15:06:44.936361 flannel-wrapper[1868]: I0422 15:06:44.936228 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Apr 22 15:06:44.937698 flannel-wrapper[1868]: I0422 15:06:44.937503 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Apr 22 15:06:44.938832 flannel-wrapper[1868]: I0422 15:06:44.938692 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j MASQUERADE --random-fully Apr 22 15:06:44.939667 flannel-wrapper[1868]: I0422 15:06:44.939508 1 main.go:307] Setting up masking rules Apr 22 15:06:44.940272 flannel-wrapper[1868]: I0422 15:06:44.940146 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Apr 22 15:06:44.940564 flannel-wrapper[1868]: I0422 15:06:44.940272 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Apr 22 15:06:44.940564 flannel-wrapper[1868]: I0422 15:06:44.940281 1 main.go:327] Running backend. Apr 22 15:06:44.941318 flannel-wrapper[1868]: I0422 15:06:44.940445 1 vxlan_network.go:59] watching for new subnet leases Apr 22 15:06:44.940824 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Apr 22 15:06:44.941147 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 22 15:06:44.943116 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Apr 22 15:06:44.943655 flannel-wrapper[1868]: I0422 15:06:44.942373 1 main.go:439] Waiting for 22h59m59.96185781s to renew lease Apr 22 15:06:44.944734 flannel-wrapper[1868]: I0422 15:06:44.944599 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Apr 22 15:06:44.944734 flannel-wrapper[1868]: I0422 15:06:44.944611 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -j ACCEPT Apr 22 15:06:44.945974 flannel-wrapper[1868]: I0422 15:06:44.945827 1 iptables.go:172] Deleting iptables rule: -d 10.254.0.0/16 -j ACCEPT Apr 22 15:06:44.946401 flannel-wrapper[1868]: I0422 15:06:44.946273 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Apr 22 15:06:44.946401 flannel-wrapper[1868]: I0422 15:06:44.946290 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Apr 22 15:06:44.947338 flannel-wrapper[1868]: I0422 15:06:44.947111 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -j ACCEPT Apr 22 15:06:44.947338 flannel-wrapper[1868]: I0422 15:06:44.947242 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Apr 22 15:06:44.948369 flannel-wrapper[1868]: I0422 15:06:44.948215 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.26.0/24 -j RETURN Apr 22 15:06:44.949373 flannel-wrapper[1868]: I0422 15:06:44.949212 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Apr 22 15:06:44.950109 flannel-wrapper[1868]: I0422 15:06:44.949990 1 iptables.go:160] Adding iptables rule: -d 10.254.0.0/16 -j ACCEPT Apr 22 15:06:44.950381 flannel-wrapper[1868]: I0422 15:06:44.950214 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Apr 22 15:06:44.952415 flannel-wrapper[1868]: I0422 15:06:44.952083 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Apr 22 15:06:44.953852 flannel-wrapper[1868]: I0422 15:06:44.953699 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.26.0/24 -j RETURN Apr 22 15:06:44.954398 sh[2022]: + for try in 1 2 3 4 5 6 Apr 22 15:06:44.954398 sh[2022]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Apr 22 15:06:44.955394 flannel-wrapper[1868]: I0422 15:06:44.955240 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Apr 22 15:06:44.968581 sh[2046]: Error response from daemon: No such container: flannel-docker-opts Apr 22 15:06:44.980822 sh[2055]: Error response from daemon: No such container: flannel-docker-opts Apr 22 15:06:45.040191 containerd[1391]: time="2025-04-22T15:06:45.040058910Z" level=info msg="connecting to shim 23765ba6e8a1e775c37f78122f148f61a09bdbf44282940705e1b2c529ee9efc" address="unix:///run/containerd/s/c04778c3b8e9e3d4c9cc5af1adc7f83f885986bb8978b922900b2ebf2cd5275c" namespace=moby protocol=ttrpc version=3 Apr 22 15:06:45.061757 systemd[1]: Started docker-23765ba6e8a1e775c37f78122f148f61a09bdbf44282940705e1b2c529ee9efc.scope - libcontainer container 23765ba6e8a1e775c37f78122f148f61a09bdbf44282940705e1b2c529ee9efc. Apr 22 15:06:45.076830 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 22 15:06:45.091998 systemd[1]: docker-23765ba6e8a1e775c37f78122f148f61a09bdbf44282940705e1b2c529ee9efc.scope: Deactivated successfully. Apr 22 15:06:45.104732 containerd[1391]: time="2025-04-22T15:06:45.104645454Z" level=info msg="shim disconnected" id=23765ba6e8a1e775c37f78122f148f61a09bdbf44282940705e1b2c529ee9efc namespace=moby Apr 22 15:06:45.104732 containerd[1391]: time="2025-04-22T15:06:45.104681829Z" level=warning msg="cleaning up after shim disconnected" id=23765ba6e8a1e775c37f78122f148f61a09bdbf44282940705e1b2c529ee9efc namespace=moby Apr 22 15:06:45.104732 containerd[1391]: time="2025-04-22T15:06:45.104727379Z" level=info msg="cleaning up dead shim" namespace=moby Apr 22 15:06:45.134553 dockerd[1489]: time="2025-04-22T15:06:45.134308232Z" level=info msg="Processing signal 'terminated'" Apr 22 15:06:45.134375 systemd[1]: Stopping docker.service - Docker Application Container Engine... Apr 22 15:06:45.141675 flannel-wrapper[1868]: I0422 15:06:45.141017 1 main.go:376] shutdownHandler sent cancel signal... Apr 22 15:06:45.141675 flannel-wrapper[1868]: I0422 15:06:45.141231 1 watch.go:174] context canceled, close receiver chan Apr 22 15:06:45.141675 flannel-wrapper[1868]: I0422 15:06:45.141285 1 main.go:432] Stopped monitoring lease Apr 22 15:06:45.141675 flannel-wrapper[1868]: I0422 15:06:45.141313 1 main.go:345] Waiting for all goroutines to exit Apr 22 15:06:45.142938 flannel-wrapper[1868]: I0422 15:06:45.141533 1 watch.go:40] context canceled, close receiver chan Apr 22 15:06:45.142938 flannel-wrapper[1868]: I0422 15:06:45.141555 1 vxlan_network.go:74] evts chan closed Apr 22 15:06:45.142938 flannel-wrapper[1868]: I0422 15:06:45.141563 1 main.go:348] Exiting cleanly... Apr 22 15:06:45.143145 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:45.141Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5","error":"EOF"} Apr 22 15:06:45.143145 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:45.141Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5","error":"EOF"} Apr 22 15:06:45.143145 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:45.141Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} Apr 22 15:06:45.143145 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:45.142Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"eb01c42710f64c0eb5ade329e547ccaa","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.37:2380"],"advertise-client-urls":["http://10.0.0.37:2379"]} Apr 22 15:06:45.143853 systemd[1]: docker-5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62.scope: Deactivated successfully. Apr 22 15:06:45.144666 etcd-wrapper[1698]: WARNING: 2025/04/22 15:06:45 [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... Apr 22 15:06:45.144666 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:45.143Z","caller":"etcdserver/server.go:1398","msg":"leadership transfer starting","local-member-id":"17de436639338112","current-leader-member-id":"17de436639338112","transferee-member-id":"c55982034cf1fff5"} Apr 22 15:06:45.144666 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:45.143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [term 3] starts to transfer leadership to c55982034cf1fff5"} Apr 22 15:06:45.144666 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:45.143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 sends MsgTimeoutNow to c55982034cf1fff5 immediately as c55982034cf1fff5 already has up-to-date log"} Apr 22 15:06:45.147440 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:45.147Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"c55982034cf1fff5","error":"failed to dial c55982034cf1fff5 on stream Message (peer c55982034cf1fff5 failed to find local node 17de436639338112)"} Apr 22 15:06:45.156917 containerd[1391]: time="2025-04-22T15:06:45.156877507Z" level=info msg="shim disconnected" id=5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62 namespace=moby Apr 22 15:06:45.156917 containerd[1391]: time="2025-04-22T15:06:45.156913162Z" level=warning msg="cleaning up after shim disconnected" id=5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62 namespace=moby Apr 22 15:06:45.156917 containerd[1391]: time="2025-04-22T15:06:45.156921294Z" level=info msg="cleaning up dead shim" namespace=moby Apr 22 15:06:45.157214 dockerd[1489]: time="2025-04-22T15:06:45.157153969Z" level=info msg="ignoring event" container=5e50c9db6aa1d257c698da2b067b7279abfca67a0c61c38fe63fe01de93eea62 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Apr 22 15:06:45.354648 systemd[1]: var-lib-docker-overlay2-f4c4285e74e1e1bcd6b29089473fbe888cae997fe3dcf830a5225b8b7078e291-merged.mount: Deactivated successfully. Apr 22 15:06:45.408010 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:45.407Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:46.649729 systemd-networkd[1326]: flannel.1: Gained IPv6LL Apr 22 15:06:47.107872 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:47.107Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"17de436639338112 stepped down to follower since quorum is not active"} Apr 22 15:06:47.107872 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:47.107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became follower at term 3"} Apr 22 15:06:47.107872 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:47.107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 17de436639338112 lost leader 17de436639338112 at term 3"} Apr 22 15:06:47.781003 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:47.780Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:48.307694 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:48.307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 is starting a new election at term 3"} Apr 22 15:06:48.307694 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:48.307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became pre-candidate at term 3"} Apr 22 15:06:48.307694 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:48.307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 received MsgPreVoteResp from 17de436639338112 at term 3"} Apr 22 15:06:48.307694 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:48.307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to 1f1c4ab1462d0f0f at term 3"} Apr 22 15:06:48.307694 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:48.307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to c55982034cf1fff5 at term 3"} Apr 22 15:06:49.449998 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:49.449Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:49.507789 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:49.507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 is starting a new election at term 3"} Apr 22 15:06:49.507789 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:49.507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became pre-candidate at term 3"} Apr 22 15:06:49.507789 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:49.507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 received MsgPreVoteResp from 17de436639338112 at term 3"} Apr 22 15:06:49.507789 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:49.507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to 1f1c4ab1462d0f0f at term 3"} Apr 22 15:06:49.507789 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:49.507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to c55982034cf1fff5 at term 3"} Apr 22 15:06:50.707844 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:50.707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 is starting a new election at term 3"} Apr 22 15:06:50.707844 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:50.707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became pre-candidate at term 3"} Apr 22 15:06:50.707844 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:50.707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 received MsgPreVoteResp from 17de436639338112 at term 3"} Apr 22 15:06:50.707844 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:50.707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to 1f1c4ab1462d0f0f at term 3"} Apr 22 15:06:50.707844 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:50.707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to c55982034cf1fff5 at term 3"} Apr 22 15:06:51.907256 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:51.906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 is starting a new election at term 3"} Apr 22 15:06:51.907256 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:51.906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became pre-candidate at term 3"} Apr 22 15:06:51.907256 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:51.906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 received MsgPreVoteResp from 17de436639338112 at term 3"} Apr 22 15:06:51.907256 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:51.906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to 1f1c4ab1462d0f0f at term 3"} Apr 22 15:06:51.907256 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:51.906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [logterm: 3, index: 37] sent MsgPreVote request to c55982034cf1fff5 at term 3"} Apr 22 15:06:52.144443 etcd-wrapper[1698]: {"level":"warn","ts":"2025-04-22T15:06:52.144Z","caller":"etcdserver/server.go:1477","msg":"leadership transfer failed","local-member-id":"17de436639338112","error":"etcdserver: request timed out, leader transfer took too long"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.144557 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.144816 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.144816 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.144816 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.144816 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.144Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:06:52.145598 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.145Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"10.0.0.37:2380"} Apr 22 15:06:52.146799 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.146Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"10.0.0.37:2380"} Apr 22 15:06:52.146799 etcd-wrapper[1698]: {"level":"info","ts":"2025-04-22T15:06:52.146Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"eb01c42710f64c0eb5ade329e547ccaa","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.37:2380"],"advertise-client-urls":["http://10.0.0.37:2379"]} Apr 22 15:06:52.148434 systemd[1]: docker-01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603.scope: Deactivated successfully. Apr 22 15:06:52.160330 dockerd[1489]: time="2025-04-22T15:06:52.160215379Z" level=info msg="ignoring event" container=01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Apr 22 15:06:52.160549 containerd[1391]: time="2025-04-22T15:06:52.160383863Z" level=info msg="shim disconnected" id=01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603 namespace=moby Apr 22 15:06:52.160549 containerd[1391]: time="2025-04-22T15:06:52.160422941Z" level=warning msg="cleaning up after shim disconnected" id=01517fb96067902c2ed7b058df38dfc3073d698c1f7927f88a0446443e5bc603 namespace=moby Apr 22 15:06:52.160549 containerd[1391]: time="2025-04-22T15:06:52.160453571Z" level=info msg="cleaning up dead shim" namespace=moby Apr 22 15:06:52.175130 systemd[1]: var-lib-docker-overlay2-2b5a6bb5bb470872b008aaf473d2727b386a2cbce938f1bd0693517bdb75de0b-merged.mount: Deactivated successfully. Apr 22 15:06:52.183520 dockerd[1489]: time="2025-04-22T15:06:52.183475140Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Apr 22 15:06:52.183963 dockerd[1489]: time="2025-04-22T15:06:52.183859394Z" level=info msg="Daemon shutdown complete" Apr 22 15:06:52.183963 dockerd[1489]: time="2025-04-22T15:06:52.183921774Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Apr 22 15:06:52.448687 systemd[1]: docker.service: Deactivated successfully. Apr 22 15:06:52.448995 systemd[1]: Stopped docker.service - Docker Application Container Engine. Apr 22 15:06:52.449051 systemd[1]: docker.service: Consumed 3.202s CPU time, 330.9M memory peak. Apr 22 15:06:52.449920 systemd[1]: docker.socket: Deactivated successfully. Apr 22 15:06:52.450655 docker[2193]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? Apr 22 15:06:52.450912 systemd[1]: Closed docker.socket - Docker Socket for the API. Apr 22 15:06:52.450946 systemd[1]: Stopping docker.socket - Docker Socket for the API... Apr 22 15:06:52.451120 docker[2224]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? Apr 22 15:06:52.452643 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 22 15:06:52.457785 systemd[1]: flanneld.service: Control process exited, code=exited, status=1/FAILURE Apr 22 15:06:52.458735 systemd[1]: etcd-member.service: Control process exited, code=exited, status=1/FAILURE Apr 22 15:06:52.459511 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 22 15:06:52.462381 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 22 15:06:52.466160 (dockerd)[2239]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS Apr 22 15:06:52.490006 dockerd[2239]: time="2025-04-22T15:06:52.489953261Z" level=info msg="Starting up" Apr 22 15:06:52.490549 dockerd[2239]: time="2025-04-22T15:06:52.490516528Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Apr 22 15:06:52.512112 dockerd[2239]: time="2025-04-22T15:06:52.512067669Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Apr 22 15:06:52.520248 dockerd[2239]: time="2025-04-22T15:06:52.520220111Z" level=info msg="Loading containers: start." Apr 22 15:06:52.978765 dockerd[2239]: time="2025-04-22T15:06:52.978724593Z" level=info msg="Loading containers: done." Apr 22 15:06:52.988112 dockerd[2239]: time="2025-04-22T15:06:52.988067951Z" 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 Apr 22 15:06:52.988233 dockerd[2239]: time="2025-04-22T15:06:52.988142824Z" level=info msg="Docker daemon" commit=c710b88579fcb5e0d53f96dcae976d79323b9166 containerd-snapshotter=false storage-driver=overlay2 version=27.4.1 Apr 22 15:06:52.988233 dockerd[2239]: time="2025-04-22T15:06:52.988191752Z" level=info msg="Daemon has completed initialization" Apr 22 15:06:53.005873 dockerd[2239]: time="2025-04-22T15:06:53.005783571Z" level=info msg="API listen on /run/docker.sock" Apr 22 15:06:53.006248 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 22 15:06:53.007230 sh[2041]: Restarted Docker to apply Flannel options Apr 22 15:06:53.007480 sh[2022]: + break Apr 22 15:06:53.007630 sh[2022]: + '[' 1 '!=' fail ']' Apr 22 15:06:53.009251 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Apr 22 15:06:53.012415 docker[2235]: flannel Apr 22 15:06:53.012659 systemd[1]: Startup finished in 605ms (kernel) + 3.803s (initrd) + 29.506s (userspace) = 33.915s. Apr 22 15:06:53.013306 docker[2236]: etcd-member Apr 22 15:06:53.013868 systemd[1]: flanneld.service: Failed with result 'exit-code'. Apr 22 15:06:53.015384 systemd[1]: etcd-member.service: Failed with result 'exit-code'. Apr 22 15:06:53.015757 systemd[1]: etcd-member.service: Consumed 211ms CPU time, 64.6M memory peak. Apr 22 15:06:53.423983 systemd[1]: Started sshd@5-10.0.0.37:22-10.0.0.1:55146.service - OpenSSH per-connection server daemon (10.0.0.1:55146). Apr 22 15:06:53.476464 sshd[2459]: Accepted publickey for core from 10.0.0.1 port 55146 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:53.477577 sshd-session[2459]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:53.481528 systemd-logind[1376]: New session 6 of user core. Apr 22 15:06:53.491719 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 22 15:06:53.541515 sshd[2461]: Connection closed by 10.0.0.1 port 55146 Apr 22 15:06:53.541896 sshd-session[2459]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:53.553831 systemd[1]: sshd@5-10.0.0.37:22-10.0.0.1:55146.service: Deactivated successfully. Apr 22 15:06:53.555214 systemd[1]: session-6.scope: Deactivated successfully. Apr 22 15:06:53.556461 systemd-logind[1376]: Session 6 logged out. Waiting for processes to exit. Apr 22 15:06:53.557526 systemd[1]: Started sshd@6-10.0.0.37:22-10.0.0.1:55158.service - OpenSSH per-connection server daemon (10.0.0.1:55158). Apr 22 15:06:53.558246 systemd-logind[1376]: Removed session 6. Apr 22 15:06:53.610328 sshd[2466]: Accepted publickey for core from 10.0.0.1 port 55158 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:53.611427 sshd-session[2466]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:53.615405 systemd-logind[1376]: New session 7 of user core. Apr 22 15:06:53.627718 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 22 15:06:53.674642 sshd[2469]: Connection closed by 10.0.0.1 port 55158 Apr 22 15:06:53.674903 sshd-session[2466]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:53.688785 systemd[1]: sshd@6-10.0.0.37:22-10.0.0.1:55158.service: Deactivated successfully. Apr 22 15:06:53.690152 systemd[1]: session-7.scope: Deactivated successfully. Apr 22 15:06:53.690735 systemd-logind[1376]: Session 7 logged out. Waiting for processes to exit. Apr 22 15:06:53.693398 systemd[1]: Started sshd@7-10.0.0.37:22-10.0.0.1:55172.service - OpenSSH per-connection server daemon (10.0.0.1:55172). Apr 22 15:06:53.694320 systemd-logind[1376]: Removed session 7. Apr 22 15:06:53.752539 sshd[2474]: Accepted publickey for core from 10.0.0.1 port 55172 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:53.753576 sshd-session[2474]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:53.757550 systemd-logind[1376]: New session 8 of user core. Apr 22 15:06:53.768753 systemd[1]: Started session-8.scope - Session 8 of User core. Apr 22 15:06:53.820011 sshd[2477]: Connection closed by 10.0.0.1 port 55172 Apr 22 15:06:53.820322 sshd-session[2474]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:53.838966 systemd[1]: sshd@7-10.0.0.37:22-10.0.0.1:55172.service: Deactivated successfully. Apr 22 15:06:53.841872 systemd[1]: session-8.scope: Deactivated successfully. Apr 22 15:06:53.842551 systemd-logind[1376]: Session 8 logged out. Waiting for processes to exit. Apr 22 15:06:53.844382 systemd[1]: Started sshd@8-10.0.0.37:22-10.0.0.1:55176.service - OpenSSH per-connection server daemon (10.0.0.1:55176). Apr 22 15:06:53.845135 systemd-logind[1376]: Removed session 8. Apr 22 15:06:53.905922 sshd[2482]: Accepted publickey for core from 10.0.0.1 port 55176 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:53.907203 sshd-session[2482]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:53.911178 systemd-logind[1376]: New session 9 of user core. Apr 22 15:06:53.922737 systemd[1]: Started session-9.scope - Session 9 of User core. Apr 22 15:06:53.998482 sudo[2486]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 22 15:06:53.998807 sudo[2486]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 22 15:06:54.015489 sudo[2486]: pam_unix(sudo:session): session closed for user root Apr 22 15:06:54.016850 sshd[2485]: Connection closed by 10.0.0.1 port 55176 Apr 22 15:06:54.017213 sshd-session[2482]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:54.029861 systemd[1]: sshd@8-10.0.0.37:22-10.0.0.1:55176.service: Deactivated successfully. Apr 22 15:06:54.031495 systemd[1]: session-9.scope: Deactivated successfully. Apr 22 15:06:54.032813 systemd-logind[1376]: Session 9 logged out. Waiting for processes to exit. Apr 22 15:06:54.034081 systemd[1]: Started sshd@9-10.0.0.37:22-10.0.0.1:55192.service - OpenSSH per-connection server daemon (10.0.0.1:55192). Apr 22 15:06:54.034806 systemd-logind[1376]: Removed session 9. Apr 22 15:06:54.093151 sshd[2491]: Accepted publickey for core from 10.0.0.1 port 55192 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:06:54.094262 sshd-session[2491]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:06:54.098389 systemd-logind[1376]: New session 10 of user core. Apr 22 15:06:54.109750 systemd[1]: Started session-10.scope - Session 10 of User core. Apr 22 15:06:54.160336 sudo[2496]: 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 Apr 22 15:06:54.160627 sudo[2496]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 22 15:06:54.163662 sudo[2496]: pam_unix(sudo:session): session closed for user root Apr 22 15:06:54.168007 sudo[2495]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Apr 22 15:06:54.168254 sudo[2495]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 22 15:06:54.176440 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 22 15:06:54.209157 augenrules[2518]: No rules Apr 22 15:06:54.210280 systemd[1]: audit-rules.service: Deactivated successfully. Apr 22 15:06:54.210534 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 22 15:06:54.211351 sudo[2495]: pam_unix(sudo:session): session closed for user root Apr 22 15:06:54.212651 sshd[2494]: Connection closed by 10.0.0.1 port 55192 Apr 22 15:06:54.212707 sshd-session[2491]: pam_unix(sshd:session): session closed for user core Apr 22 15:06:54.215797 systemd[1]: sshd@9-10.0.0.37:22-10.0.0.1:55192.service: Deactivated successfully. Apr 22 15:06:54.218028 systemd[1]: session-10.scope: Deactivated successfully. Apr 22 15:06:54.218640 systemd-logind[1376]: Session 10 logged out. Waiting for processes to exit. Apr 22 15:06:54.219376 systemd-logind[1376]: Removed session 10. Apr 22 15:07:03.047987 systemd[1]: flanneld.service: Scheduled restart job, restart counter is at 1. Apr 22 15:07:03.048632 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. Apr 22 15:07:03.050135 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 22 15:07:03.051034 systemd[1]: Stopping flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Apr 22 15:07:03.075064 docker[2527]: flannel-docker-opts Apr 22 15:07:03.076505 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 22 15:07:03.076750 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 22 15:07:03.095219 docker[2540]: flannel-docker-opts Apr 22 15:07:03.097060 systemd[1]: flannel-docker-opts.service: Deactivated successfully. Apr 22 15:07:03.097324 systemd[1]: Stopped flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Apr 22 15:07:03.097716 systemd[1]: Stopped flanneld.service - flannel - Network fabric for containers (System Application Container). Apr 22 15:07:03.098933 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Apr 22 15:07:03.109858 (-wrapper)[2550]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Apr 22 15:07:03.125141 etcd-wrapper[2554]: Error response from daemon: No such container: etcd-member Apr 22 15:07:03.136427 etcd-wrapper[2563]: Error response from daemon: No such container: etcd-member Apr 22 15:07:03.164246 systemd[1]: var-lib-docker-overlay2-440ddfc6b7335502edba5d8992698323c8ab121ba18aaa5bf94a419e2815d636\x2dinit-merged.mount: Deactivated successfully. Apr 22 15:07:03.211157 containerd[1391]: time="2025-04-22T15:07:03.211070419Z" level=info msg="connecting to shim 58e450bbd5509ecd1ad1ef6a93a3c6591b135e542ffe1ec7633e1cc5456b11b2" address="unix:///run/containerd/s/8cc583ab1d6ad5a009e010f025c9bec6ef075524d33720ffb170df7827ba67a6" namespace=moby protocol=ttrpc version=3 Apr 22 15:07:03.234732 systemd[1]: Started docker-58e450bbd5509ecd1ad1ef6a93a3c6591b135e542ffe1ec7633e1cc5456b11b2.scope - libcontainer container 58e450bbd5509ecd1ad1ef6a93a3c6591b135e542ffe1ec7633e1cc5456b11b2. Apr 22 15:07:03.244219 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 22 15:07:03.270769 etcd-wrapper[2584]: {"level":"info","ts":1745334423.2705536,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Apr 22 15:07:03.271083 etcd-wrapper[2584]: {"level":"info","ts":1745334423.270645,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"eb01c42710f64c0eb5ade329e547ccaa"} Apr 22 15:07:03.271083 etcd-wrapper[2584]: {"level":"warn","ts":1745334423.270669,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Apr 22 15:07:03.271083 etcd-wrapper[2584]: {"level":"warn","ts":1745334423.2706752,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Apr 22 15:07:03.271083 etcd-wrapper[2584]: {"level":"warn","ts":1745334423.27068,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Apr 22 15:07:03.271083 etcd-wrapper[2584]: {"level":"warn","ts":1745334423.2706842,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Apr 22 15:07:03.271083 etcd-wrapper[2584]: {"level":"warn","ts":1745334423.2706892,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Apr 22 15:07:03.271364 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.270Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.37:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.37:2380","--advertise-client-urls=http://10.0.0.37:2379","--discovery=http://10.0.0.1:42587/v2/keys/discovery/7413413644825116267","--enable-v2=true"]} Apr 22 15:07:03.271364 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.270Z","caller":"etcdmain/etcd.go:115","msg":"server has been already initialized","data-dir":"/var/lib/etcd","dir-type":"member"} Apr 22 15:07:03.271364 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.270Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.37:2380"]} Apr 22 15:07:03.271364 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.271Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Apr 22 15:07:03.271493 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.271Z","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":"eb01c42710f64c0eb5ade329e547ccaa","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.37:2380"],"listen-peer-urls":["http://10.0.0.37:2380"],"advertise-client-urls":["http://10.0.0.37: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:42587/v2/keys/discovery/7413413644825116267","discovery-proxy":"","downgrade-check-interval":"5s"} Apr 22 15:07:03.271836 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.271Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"170.401µs"} Apr 22 15:07:03.271998 etcd-wrapper[2584]: {"level":"warn","ts":"2025-04-22T15:07:03.271Z","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"} Apr 22 15:07:03.272174 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"etcdserver/server.go:526","msg":"No snapshot found. Recovering WAL from scratch!"} Apr 22 15:07:03.272913 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"etcdserver/raft.go:483","msg":"restarting local member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","commit-index":34} Apr 22 15:07:03.272913 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=()"} Apr 22 15:07:03.272913 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became follower at term 3"} Apr 22 15:07:03.272913 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 17de436639338112 [peers: [], term: 3, commit: 34, applied: 0, lastindex: 37, lastterm: 3]"} Apr 22 15:07:03.272913 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Apr 22 15:07:03.273091 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","recovered-remote-peer-id":"c55982034cf1fff5","recovered-remote-peer-urls":["http://10.0.0.39:2380"]} Apr 22 15:07:03.273091 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","recovered-remote-peer-id":"17de436639338112","recovered-remote-peer-urls":["http://10.0.0.37:2380"]} Apr 22 15:07:03.273091 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","recovered-remote-peer-id":"1f1c4ab1462d0f0f","recovered-remote-peer-urls":["http://10.0.0.38:2380"]} Apr 22 15:07:03.273091 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.272Z","caller":"membership/cluster.go:285","msg":"set cluster version from store","cluster-version":"3.5"} Apr 22 15:07:03.273630 etcd-wrapper[2584]: {"level":"warn","ts":"2025-04-22T15:07:03.273Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Apr 22 15:07:03.274458 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.274Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Apr 22 15:07:03.274868 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.274Z","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"} Apr 22 15:07:03.275363 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.275Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.275363 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.275Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.275856 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.275Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.276419 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.276Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.277214 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.276Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.277214 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.277Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.277214 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.277Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.277214 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.277Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f","remote-peer-urls":["http://10.0.0.38:2380"]} Apr 22 15:07:03.277214 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.277Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.277214 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.277Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.277538 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.277Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.278418 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.279249 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.279249 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.279249 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.279249 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5","remote-peer-urls":["http://10.0.0.39:2380"]} Apr 22 15:07:03.279249 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"etcdserver/server.go:834","msg":"starting etcd server","local-member-id":"17de436639338112","local-server-version":"3.5.0","cluster-id":"73366b117b0a884d","cluster-version":"3.5"} Apr 22 15:07:03.279468 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.278Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.280195 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.279Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Apr 22 15:07:03.280195 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.279Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.280195 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.279Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.280448 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034)"} Apr 22 15:07:03.280500 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","added-peer-id":"17de436639338112","added-peer-peer-urls":["http://10.0.0.37:2380"]} Apr 22 15:07:03.280709 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.281030 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.281030 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295)"} Apr 22 15:07:03.281030 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","added-peer-id":"1f1c4ab1462d0f0f","added-peer-peer-urls":["http://10.0.0.38:2380"]} Apr 22 15:07:03.281030 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 switched to configuration voters=(1719886214027510034 2241748839770689295 14220540249086492661)"} Apr 22 15:07:03.281030 etcd-wrapper[2584]: {"level":"warn","ts":"2025-04-22T15:07:03.280Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Apr 22 15:07:03.281030 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","added-peer-id":"c55982034cf1fff5","added-peer-peer-urls":["http://10.0.0.39:2380"]} Apr 22 15:07:03.281215 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.37:2380"} Apr 22 15:07:03.281670 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.280Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"17de436639338112","initial-advertise-peer-urls":["http://10.0.0.37:2380"],"listen-peer-urls":["http://10.0.0.37:2380"],"advertise-client-urls":["http://10.0.0.37:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Apr 22 15:07:03.281670 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"membership/cluster.go:523","msg":"updated cluster version","cluster-id":"73366b117b0a884d","local-member-id":"17de436639338112","from":"3.5","to":"3.5"} Apr 22 15:07:03.281670 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.37:2380"} Apr 22 15:07:03.281967 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"c55982034cf1fff5","stream-type":"stream MsgApp v2"} Apr 22 15:07:03.281967 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.281967 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"c55982034cf1fff5","stream-type":"stream Message"} Apr 22 15:07:03.281967 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.281967 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.281Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"c55982034cf1fff5"} Apr 22 15:07:03.330948 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.330Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"17de436639338112","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Apr 22 15:07:03.341952 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.341Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"1f1c4ab1462d0f0f","stream-type":"stream Message"} Apr 22 15:07:03.341952 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.341Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.341952 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.341Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"17de436639338112","to":"1f1c4ab1462d0f0f","stream-type":"stream MsgApp v2"} Apr 22 15:07:03.341952 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.341Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"17de436639338112","remote-peer-id":"1f1c4ab1462d0f0f"} Apr 22 15:07:03.370529 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.370Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 [term: 3] received a MsgHeartbeat message with higher term from c55982034cf1fff5 [term: 4]"} Apr 22 15:07:03.370529 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.370Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"17de436639338112 became follower at term 4"} Apr 22 15:07:03.370529 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.370Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 17de436639338112 elected leader c55982034cf1fff5 at term 4"} Apr 22 15:07:03.372392 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"found conflict at index 35 [existing term: 3, conflicting term: 4]"} Apr 22 15:07:03.372392 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"replace the unstable entries from index 35"} Apr 22 15:07:03.374567 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.374Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Apr 22 15:07:03.374567 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.374Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"17de436639338112","local-member-attributes":"{Name:eb01c42710f64c0eb5ade329e547ccaa ClientURLs:[http://10.0.0.37:2379]}","request-path":"/0/members/17de436639338112/attributes","cluster-id":"73366b117b0a884d","publish-timeout":"7s"} Apr 22 15:07:03.374567 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.374Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Apr 22 15:07:03.374567 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.374Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Apr 22 15:07:03.374800 systemd[1]: Started etcd-member.service - etcd (System Application Container). Apr 22 15:07:03.375870 etcd-wrapper[2584]: {"level":"info","ts":"2025-04-22T15:07:03.375Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Apr 22 15:07:03.376659 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Apr 22 15:07:03.405482 etcdctl[2647]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Apr 22 15:07:03.432534 flannel-wrapper[2657]: Error response from daemon: No such container: flannel Apr 22 15:07:03.443464 flannel-wrapper[2666]: Error response from daemon: No such container: flannel Apr 22 15:07:03.496636 containerd[1391]: time="2025-04-22T15:07:03.496566806Z" level=info msg="connecting to shim 1bc53533476b7d18937bcc6fe891ed4e187baa4b2de6ffcc6403ed8439f09b94" address="unix:///run/containerd/s/56413c27ac2bc1363bf0a0899b78fff73af530d6199dd5039542663638a8132c" namespace=moby protocol=ttrpc version=3 Apr 22 15:07:03.515738 systemd[1]: Started docker-1bc53533476b7d18937bcc6fe891ed4e187baa4b2de6ffcc6403ed8439f09b94.scope - libcontainer container 1bc53533476b7d18937bcc6fe891ed4e187baa4b2de6ffcc6403ed8439f09b94. Apr 22 15:07:03.529699 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 22 15:07:03.550194 flannel-wrapper[2686]: I0422 15:07:03.549950 1 main.go:520] Determining IP address of default interface Apr 22 15:07:03.550929 flannel-wrapper[2686]: I0422 15:07:03.550175 1 main.go:533] Using interface with name eth0 and address 10.0.0.37 Apr 22 15:07:03.550929 flannel-wrapper[2686]: I0422 15:07:03.550191 1 main.go:550] Defaulting external address to interface address (10.0.0.37) Apr 22 15:07:03.550929 flannel-wrapper[2686]: I0422 15:07:03.550282 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: 10.254.26.0/24 Apr 22 15:07:03.550929 flannel-wrapper[2686]: I0422 15:07:03.550290 1 main.go:257] Installing signal handlers Apr 22 15:07:03.552750 flannel-wrapper[2686]: I0422 15:07:03.552396 1 main.go:392] Found network config - Backend type: vxlan Apr 22 15:07:03.552750 flannel-wrapper[2686]: I0422 15:07:03.552429 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Apr 22 15:07:03.555487 flannel-wrapper[2686]: I0422 15:07:03.555312 1 local_manager.go:147] Found lease (10.254.26.0/24) for current IP (10.0.0.37), reusing Apr 22 15:07:03.556857 flannel-wrapper[2686]: I0422 15:07:03.556706 1 main.go:307] Setting up masking rules Apr 22 15:07:03.567347 flannel-wrapper[2686]: I0422 15:07:03.566622 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Apr 22 15:07:03.567347 flannel-wrapper[2686]: I0422 15:07:03.566742 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Apr 22 15:07:03.567347 flannel-wrapper[2686]: I0422 15:07:03.566753 1 main.go:327] Running backend. Apr 22 15:07:03.567419 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Apr 22 15:07:03.567893 flannel-wrapper[2686]: I0422 15:07:03.567098 1 vxlan_network.go:59] watching for new subnet leases Apr 22 15:07:03.569359 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Apr 22 15:07:03.570663 flannel-wrapper[2686]: I0422 15:07:03.570482 1 main.go:439] Waiting for 22h59m59.985007594s to renew lease Apr 22 15:07:03.593246 sh[2776]: + for try in 1 2 3 4 5 6 Apr 22 15:07:03.593246 sh[2776]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Apr 22 15:07:03.607751 sh[2785]: Error response from daemon: No such container: flannel-docker-opts Apr 22 15:07:03.618964 sh[2794]: Error response from daemon: No such container: flannel-docker-opts Apr 22 15:07:03.669986 containerd[1391]: time="2025-04-22T15:07:03.669932794Z" level=info msg="connecting to shim b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d" address="unix:///run/containerd/s/9a4ff72ea8c4dd5dcd9ad10f3cddaf81c4b7d87161f75c1f2c15ce32c55fec85" namespace=moby protocol=ttrpc version=3 Apr 22 15:07:03.689810 systemd[1]: Started docker-b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d.scope - libcontainer container b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d. Apr 22 15:07:03.703156 systemd-resolved[1261]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 22 15:07:03.716882 systemd[1]: docker-b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d.scope: Deactivated successfully. Apr 22 15:07:03.728229 dockerd[2239]: time="2025-04-22T15:07:03.728183838Z" level=info msg="ignoring event" container=b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Apr 22 15:07:03.728531 containerd[1391]: time="2025-04-22T15:07:03.728299453Z" level=info msg="shim disconnected" id=b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d namespace=moby Apr 22 15:07:03.728531 containerd[1391]: time="2025-04-22T15:07:03.728336671Z" level=warning msg="cleaning up after shim disconnected" id=b45ea2a22b5e642f1282a9f6e08ca1def9c4313a46c65a12e2705658e254e16d namespace=moby Apr 22 15:07:03.728531 containerd[1391]: time="2025-04-22T15:07:03.728344474Z" level=info msg="cleaning up dead shim" namespace=moby Apr 22 15:07:03.747227 sh[2776]: + break Apr 22 15:07:03.747227 sh[2776]: + '[' 1 '!=' fail ']' Apr 22 15:07:03.749657 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Apr 22 15:07:10.104099 update_engine[1378]: I20250422 15:07:10.104022 1378 update_attempter.cc:509] Updating boot flags... Apr 22 15:07:10.131627 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2910) Apr 22 15:07:10.169639 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2909) Apr 22 15:07:10.196624 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2909) Apr 22 15:07:14.388821 systemd[1]: Started sshd@10-10.0.0.37:22-10.0.0.1:40828.service - OpenSSH per-connection server daemon (10.0.0.1:40828). Apr 22 15:07:14.440177 sshd[2925]: Accepted publickey for core from 10.0.0.1 port 40828 ssh2: RSA SHA256:vSMEaMy/bsMRI0wkzsr2vqgekxsKtnIZxYOZanmPdeI Apr 22 15:07:14.441206 sshd-session[2925]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 22 15:07:14.445085 systemd-logind[1376]: New session 11 of user core. Apr 22 15:07:14.452808 systemd[1]: Started session-11.scope - Session 11 of User core. Apr 22 15:07:14.513442 sshd[2927]: Connection closed by 10.0.0.1 port 40828 Apr 22 15:07:14.513737 sshd-session[2925]: pam_unix(sshd:session): session closed for user core Apr 22 15:07:14.516471 systemd[1]: sshd@10-10.0.0.37:22-10.0.0.1:40828.service: Deactivated successfully. Apr 22 15:07:14.518079 systemd[1]: session-11.scope: Deactivated successfully. Apr 22 15:07:14.518686 systemd-logind[1376]: Session 11 logged out. Waiting for processes to exit. Apr 22 15:07:14.519479 systemd-logind[1376]: Removed session 11.