Feb 13 19:33:15.946819 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Feb 13 19:33:15.946839 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Thu Feb 13 18:13:29 -00 2025 Feb 13 19:33:15.946850 kernel: KASLR enabled Feb 13 19:33:15.946856 kernel: efi: EFI v2.7 by EDK II Feb 13 19:33:15.946862 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba86018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Feb 13 19:33:15.946867 kernel: random: crng init done Feb 13 19:33:15.946875 kernel: ACPI: Early table checksum verification disabled Feb 13 19:33:15.946881 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Feb 13 19:33:15.946887 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Feb 13 19:33:15.946895 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946901 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946908 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946914 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946920 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946928 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946936 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946942 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946949 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 19:33:15.946955 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Feb 13 19:33:15.946962 kernel: NUMA: Failed to initialise from firmware Feb 13 19:33:15.946969 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Feb 13 19:33:15.946975 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Feb 13 19:33:15.946982 kernel: Zone ranges: Feb 13 19:33:15.946989 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Feb 13 19:33:15.946996 kernel: DMA32 empty Feb 13 19:33:15.947004 kernel: Normal empty Feb 13 19:33:15.947011 kernel: Movable zone start for each node Feb 13 19:33:15.947017 kernel: Early memory node ranges Feb 13 19:33:15.947024 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Feb 13 19:33:15.947031 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Feb 13 19:33:15.947038 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Feb 13 19:33:15.947044 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Feb 13 19:33:15.947051 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Feb 13 19:33:15.947058 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Feb 13 19:33:15.947064 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Feb 13 19:33:15.947071 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Feb 13 19:33:15.947078 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Feb 13 19:33:15.947085 kernel: psci: probing for conduit method from ACPI. Feb 13 19:33:15.947092 kernel: psci: PSCIv1.1 detected in firmware. Feb 13 19:33:15.947099 kernel: psci: Using standard PSCI v0.2 function IDs Feb 13 19:33:15.947108 kernel: psci: Trusted OS migration not required Feb 13 19:33:15.947115 kernel: psci: SMC Calling Convention v1.1 Feb 13 19:33:15.947122 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Feb 13 19:33:15.947130 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Feb 13 19:33:15.947137 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Feb 13 19:33:15.947144 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 13 19:33:15.947151 kernel: Detected PIPT I-cache on CPU0 Feb 13 19:33:15.947158 kernel: CPU features: detected: GIC system register CPU interface Feb 13 19:33:15.947165 kernel: CPU features: detected: Hardware dirty bit management Feb 13 19:33:15.947172 kernel: CPU features: detected: Spectre-v4 Feb 13 19:33:15.947179 kernel: CPU features: detected: Spectre-BHB Feb 13 19:33:15.947186 kernel: CPU features: kernel page table isolation forced ON by KASLR Feb 13 19:33:15.947193 kernel: CPU features: detected: Kernel page table isolation (KPTI) Feb 13 19:33:15.947201 kernel: CPU features: detected: ARM erratum 1418040 Feb 13 19:33:15.947208 kernel: CPU features: detected: SSBS not fully self-synchronizing Feb 13 19:33:15.947215 kernel: alternatives: applying boot alternatives Feb 13 19:33:15.947223 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=c15c751c06cfb933aa98417326b93d899c08a83ce060a940cd01082629c201a7 Feb 13 19:33:15.947230 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Feb 13 19:33:15.947244 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Feb 13 19:33:15.947251 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Feb 13 19:33:15.947258 kernel: Fallback order for Node 0: 0 Feb 13 19:33:15.947265 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Feb 13 19:33:15.947272 kernel: Policy zone: DMA Feb 13 19:33:15.947278 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 13 19:33:15.947287 kernel: software IO TLB: area num 4. Feb 13 19:33:15.947294 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Feb 13 19:33:15.947302 kernel: Memory: 2386532K/2572288K available (10240K kernel code, 2186K rwdata, 8096K rodata, 39360K init, 897K bss, 185756K reserved, 0K cma-reserved) Feb 13 19:33:15.947310 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 13 19:33:15.947317 kernel: rcu: Preemptible hierarchical RCU implementation. Feb 13 19:33:15.947325 kernel: rcu: RCU event tracing is enabled. Feb 13 19:33:15.947332 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Feb 13 19:33:15.947339 kernel: Trampoline variant of Tasks RCU enabled. Feb 13 19:33:15.947346 kernel: Tracing variant of Tasks RCU enabled. Feb 13 19:33:15.947353 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Feb 13 19:33:15.947360 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Feb 13 19:33:15.947367 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Feb 13 19:33:15.947375 kernel: GICv3: 256 SPIs implemented Feb 13 19:33:15.947382 kernel: GICv3: 0 Extended SPIs implemented Feb 13 19:33:15.947389 kernel: Root IRQ handler: gic_handle_irq Feb 13 19:33:15.947396 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Feb 13 19:33:15.947403 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Feb 13 19:33:15.947410 kernel: ITS [mem 0x08080000-0x0809ffff] Feb 13 19:33:15.947417 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Feb 13 19:33:15.947424 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Feb 13 19:33:15.947431 kernel: GICv3: using LPI property table @0x00000000400f0000 Feb 13 19:33:15.947438 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Feb 13 19:33:15.947445 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 13 19:33:15.947453 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 13 19:33:15.947460 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Feb 13 19:33:15.947467 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Feb 13 19:33:15.947475 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Feb 13 19:33:15.947481 kernel: arm-pv: using stolen time PV Feb 13 19:33:15.947511 kernel: Console: colour dummy device 80x25 Feb 13 19:33:15.947519 kernel: ACPI: Core revision 20230628 Feb 13 19:33:15.947526 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Feb 13 19:33:15.947534 kernel: pid_max: default: 32768 minimum: 301 Feb 13 19:33:15.947541 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Feb 13 19:33:15.947550 kernel: landlock: Up and running. Feb 13 19:33:15.947557 kernel: SELinux: Initializing. Feb 13 19:33:15.947564 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 13 19:33:15.947572 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 13 19:33:15.947579 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 13 19:33:15.947586 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 13 19:33:15.947593 kernel: rcu: Hierarchical SRCU implementation. Feb 13 19:33:15.947600 kernel: rcu: Max phase no-delay instances is 400. Feb 13 19:33:15.947607 kernel: Platform MSI: ITS@0x8080000 domain created Feb 13 19:33:15.947616 kernel: PCI/MSI: ITS@0x8080000 domain created Feb 13 19:33:15.947623 kernel: Remapping and enabling EFI services. Feb 13 19:33:15.947630 kernel: smp: Bringing up secondary CPUs ... Feb 13 19:33:15.947637 kernel: Detected PIPT I-cache on CPU1 Feb 13 19:33:15.947644 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Feb 13 19:33:15.947651 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Feb 13 19:33:15.947658 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 13 19:33:15.947665 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Feb 13 19:33:15.947673 kernel: Detected PIPT I-cache on CPU2 Feb 13 19:33:15.947680 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Feb 13 19:33:15.947688 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Feb 13 19:33:15.947695 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 13 19:33:15.947707 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Feb 13 19:33:15.947715 kernel: Detected PIPT I-cache on CPU3 Feb 13 19:33:15.947723 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Feb 13 19:33:15.947730 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Feb 13 19:33:15.947738 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 13 19:33:15.947745 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Feb 13 19:33:15.947752 kernel: smp: Brought up 1 node, 4 CPUs Feb 13 19:33:15.947761 kernel: SMP: Total of 4 processors activated. Feb 13 19:33:15.947769 kernel: CPU features: detected: 32-bit EL0 Support Feb 13 19:33:15.947776 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Feb 13 19:33:15.947784 kernel: CPU features: detected: Common not Private translations Feb 13 19:33:15.947791 kernel: CPU features: detected: CRC32 instructions Feb 13 19:33:15.947799 kernel: CPU features: detected: Enhanced Virtualization Traps Feb 13 19:33:15.947806 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Feb 13 19:33:15.947814 kernel: CPU features: detected: LSE atomic instructions Feb 13 19:33:15.947822 kernel: CPU features: detected: Privileged Access Never Feb 13 19:33:15.947830 kernel: CPU features: detected: RAS Extension Support Feb 13 19:33:15.947837 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Feb 13 19:33:15.947845 kernel: CPU: All CPU(s) started at EL1 Feb 13 19:33:15.947852 kernel: alternatives: applying system-wide alternatives Feb 13 19:33:15.947860 kernel: devtmpfs: initialized Feb 13 19:33:15.947867 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Feb 13 19:33:15.947875 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 13 19:33:15.947882 kernel: pinctrl core: initialized pinctrl subsystem Feb 13 19:33:15.947891 kernel: SMBIOS 3.0.0 present. Feb 13 19:33:15.947899 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Feb 13 19:33:15.947906 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 13 19:33:15.947914 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Feb 13 19:33:15.947952 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Feb 13 19:33:15.947960 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Feb 13 19:33:15.947968 kernel: audit: initializing netlink subsys (disabled) Feb 13 19:33:15.947975 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Feb 13 19:33:15.947983 kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 13 19:33:15.947992 kernel: cpuidle: using governor menu Feb 13 19:33:15.948000 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Feb 13 19:33:15.948007 kernel: ASID allocator initialised with 32768 entries Feb 13 19:33:15.948015 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Feb 13 19:33:15.948022 kernel: Serial: AMBA PL011 UART driver Feb 13 19:33:15.948029 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Feb 13 19:33:15.948037 kernel: Modules: 0 pages in range for non-PLT usage Feb 13 19:33:15.948044 kernel: Modules: 509040 pages in range for PLT usage Feb 13 19:33:15.948052 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Feb 13 19:33:15.948060 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Feb 13 19:33:15.948068 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Feb 13 19:33:15.948076 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Feb 13 19:33:15.948083 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Feb 13 19:33:15.948090 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Feb 13 19:33:15.948097 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Feb 13 19:33:15.948105 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Feb 13 19:33:15.948112 kernel: ACPI: Added _OSI(Module Device) Feb 13 19:33:15.948119 kernel: ACPI: Added _OSI(Processor Device) Feb 13 19:33:15.948128 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Feb 13 19:33:15.948135 kernel: ACPI: Added _OSI(Processor Aggregator Device) Feb 13 19:33:15.948143 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Feb 13 19:33:15.948150 kernel: ACPI: Interpreter enabled Feb 13 19:33:15.948157 kernel: ACPI: Using GIC for interrupt routing Feb 13 19:33:15.948165 kernel: ACPI: MCFG table detected, 1 entries Feb 13 19:33:15.948172 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Feb 13 19:33:15.948180 kernel: printk: console [ttyAMA0] enabled Feb 13 19:33:15.948187 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Feb 13 19:33:15.948323 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Feb 13 19:33:15.948399 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Feb 13 19:33:15.948467 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Feb 13 19:33:15.948565 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Feb 13 19:33:15.948633 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Feb 13 19:33:15.948643 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Feb 13 19:33:15.948650 kernel: PCI host bridge to bus 0000:00 Feb 13 19:33:15.948724 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Feb 13 19:33:15.948783 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Feb 13 19:33:15.948842 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Feb 13 19:33:15.948900 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 13 19:33:15.948984 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Feb 13 19:33:15.949061 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Feb 13 19:33:15.949159 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Feb 13 19:33:15.949227 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Feb 13 19:33:15.949308 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Feb 13 19:33:15.949377 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Feb 13 19:33:15.949445 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Feb 13 19:33:15.949564 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Feb 13 19:33:15.949626 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Feb 13 19:33:15.949688 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Feb 13 19:33:15.949749 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Feb 13 19:33:15.949758 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Feb 13 19:33:15.949766 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Feb 13 19:33:15.949774 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Feb 13 19:33:15.949781 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Feb 13 19:33:15.949789 kernel: iommu: Default domain type: Translated Feb 13 19:33:15.949796 kernel: iommu: DMA domain TLB invalidation policy: strict mode Feb 13 19:33:15.949805 kernel: efivars: Registered efivars operations Feb 13 19:33:15.949813 kernel: vgaarb: loaded Feb 13 19:33:15.949820 kernel: clocksource: Switched to clocksource arch_sys_counter Feb 13 19:33:15.949827 kernel: VFS: Disk quotas dquot_6.6.0 Feb 13 19:33:15.949835 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 13 19:33:15.949843 kernel: pnp: PnP ACPI init Feb 13 19:33:15.949920 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Feb 13 19:33:15.949931 kernel: pnp: PnP ACPI: found 1 devices Feb 13 19:33:15.949938 kernel: NET: Registered PF_INET protocol family Feb 13 19:33:15.949948 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Feb 13 19:33:15.949955 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Feb 13 19:33:15.949963 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 13 19:33:15.949971 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Feb 13 19:33:15.949978 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Feb 13 19:33:15.949986 kernel: TCP: Hash tables configured (established 32768 bind 32768) Feb 13 19:33:15.949993 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Feb 13 19:33:15.950001 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Feb 13 19:33:15.950008 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 13 19:33:15.950018 kernel: PCI: CLS 0 bytes, default 64 Feb 13 19:33:15.950025 kernel: kvm [1]: HYP mode not available Feb 13 19:33:15.950032 kernel: Initialise system trusted keyrings Feb 13 19:33:15.950040 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Feb 13 19:33:15.950047 kernel: Key type asymmetric registered Feb 13 19:33:15.950054 kernel: Asymmetric key parser 'x509' registered Feb 13 19:33:15.950061 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Feb 13 19:33:15.950069 kernel: io scheduler mq-deadline registered Feb 13 19:33:15.950076 kernel: io scheduler kyber registered Feb 13 19:33:15.950085 kernel: io scheduler bfq registered Feb 13 19:33:15.950093 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Feb 13 19:33:15.950100 kernel: ACPI: button: Power Button [PWRB] Feb 13 19:33:15.950108 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Feb 13 19:33:15.950174 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Feb 13 19:33:15.950184 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Feb 13 19:33:15.950192 kernel: thunder_xcv, ver 1.0 Feb 13 19:33:15.950199 kernel: thunder_bgx, ver 1.0 Feb 13 19:33:15.950207 kernel: nicpf, ver 1.0 Feb 13 19:33:15.950216 kernel: nicvf, ver 1.0 Feb 13 19:33:15.950296 kernel: rtc-efi rtc-efi.0: registered as rtc0 Feb 13 19:33:15.950361 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-02-13T19:33:15 UTC (1739475195) Feb 13 19:33:15.950371 kernel: hid: raw HID events driver (C) Jiri Kosina Feb 13 19:33:15.950378 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Feb 13 19:33:15.950386 kernel: watchdog: Delayed init of the lockup detector failed: -19 Feb 13 19:33:15.950394 kernel: watchdog: Hard watchdog permanently disabled Feb 13 19:33:15.950401 kernel: NET: Registered PF_INET6 protocol family Feb 13 19:33:15.950411 kernel: Segment Routing with IPv6 Feb 13 19:33:15.950418 kernel: In-situ OAM (IOAM) with IPv6 Feb 13 19:33:15.950426 kernel: NET: Registered PF_PACKET protocol family Feb 13 19:33:15.950433 kernel: Key type dns_resolver registered Feb 13 19:33:15.950440 kernel: registered taskstats version 1 Feb 13 19:33:15.950448 kernel: Loading compiled-in X.509 certificates Feb 13 19:33:15.950455 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: 8bd805622262697b24b0fa7c407ae82c4289ceec' Feb 13 19:33:15.950462 kernel: Key type .fscrypt registered Feb 13 19:33:15.950470 kernel: Key type fscrypt-provisioning registered Feb 13 19:33:15.950479 kernel: ima: No TPM chip found, activating TPM-bypass! Feb 13 19:33:15.950494 kernel: ima: Allocated hash algorithm: sha1 Feb 13 19:33:15.950503 kernel: ima: No architecture policies found Feb 13 19:33:15.950511 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Feb 13 19:33:15.950518 kernel: clk: Disabling unused clocks Feb 13 19:33:15.950526 kernel: Freeing unused kernel memory: 39360K Feb 13 19:33:15.950533 kernel: Run /init as init process Feb 13 19:33:15.950540 kernel: with arguments: Feb 13 19:33:15.950548 kernel: /init Feb 13 19:33:15.950557 kernel: with environment: Feb 13 19:33:15.950564 kernel: HOME=/ Feb 13 19:33:15.950572 kernel: TERM=linux Feb 13 19:33:15.950579 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Feb 13 19:33:15.950589 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Feb 13 19:33:15.950598 systemd[1]: Detected virtualization kvm. Feb 13 19:33:15.950606 systemd[1]: Detected architecture arm64. Feb 13 19:33:15.950615 systemd[1]: Running in initrd. Feb 13 19:33:15.950623 systemd[1]: No hostname configured, using default hostname. Feb 13 19:33:15.950631 systemd[1]: Hostname set to . Feb 13 19:33:15.950639 systemd[1]: Initializing machine ID from VM UUID. Feb 13 19:33:15.950647 systemd[1]: Queued start job for default target initrd.target. Feb 13 19:33:15.950655 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Feb 13 19:33:15.950663 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Feb 13 19:33:15.950672 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Feb 13 19:33:15.950682 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Feb 13 19:33:15.950690 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Feb 13 19:33:15.950698 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Feb 13 19:33:15.950707 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Feb 13 19:33:15.950715 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Feb 13 19:33:15.950723 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Feb 13 19:33:15.950731 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Feb 13 19:33:15.950741 systemd[1]: Reached target paths.target - Path Units. Feb 13 19:33:15.950749 systemd[1]: Reached target slices.target - Slice Units. Feb 13 19:33:15.950757 systemd[1]: Reached target swap.target - Swaps. Feb 13 19:33:15.950765 systemd[1]: Reached target timers.target - Timer Units. Feb 13 19:33:15.950773 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Feb 13 19:33:15.950782 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Feb 13 19:33:15.950790 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Feb 13 19:33:15.950798 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Feb 13 19:33:15.950806 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Feb 13 19:33:15.950815 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Feb 13 19:33:15.950823 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Feb 13 19:33:15.950831 systemd[1]: Reached target sockets.target - Socket Units. Feb 13 19:33:15.950839 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Feb 13 19:33:15.950847 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Feb 13 19:33:15.950855 systemd[1]: Finished network-cleanup.service - Network Cleanup. Feb 13 19:33:15.950863 systemd[1]: Starting systemd-fsck-usr.service... Feb 13 19:33:15.950871 systemd[1]: Starting systemd-journald.service - Journal Service... Feb 13 19:33:15.950881 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Feb 13 19:33:15.950889 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 19:33:15.950897 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Feb 13 19:33:15.950905 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Feb 13 19:33:15.950913 systemd[1]: Finished systemd-fsck-usr.service. Feb 13 19:33:15.950922 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Feb 13 19:33:15.950932 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 19:33:15.950955 systemd-journald[238]: Collecting audit messages is disabled. Feb 13 19:33:15.950974 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Feb 13 19:33:15.950984 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Feb 13 19:33:15.950993 systemd-journald[238]: Journal started Feb 13 19:33:15.951011 systemd-journald[238]: Runtime Journal (/run/log/journal/97221e27ce974a7fad457640cc37b177) is 5.9M, max 47.3M, 41.4M free. Feb 13 19:33:15.943014 systemd-modules-load[239]: Inserted module 'overlay' Feb 13 19:33:15.958505 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Feb 13 19:33:15.958537 systemd[1]: Started systemd-journald.service - Journal Service. Feb 13 19:33:15.960205 systemd-modules-load[239]: Inserted module 'br_netfilter' Feb 13 19:33:15.961216 kernel: Bridge firewalling registered Feb 13 19:33:15.961146 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Feb 13 19:33:15.963646 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Feb 13 19:33:15.966329 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Feb 13 19:33:15.969532 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Feb 13 19:33:15.973786 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Feb 13 19:33:15.976279 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 13 19:33:15.980672 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 19:33:15.982845 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Feb 13 19:33:15.985342 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 13 19:33:15.988689 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Feb 13 19:33:15.997891 dracut-cmdline[275]: dracut-dracut-053 Feb 13 19:33:16.000244 dracut-cmdline[275]: 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=c15c751c06cfb933aa98417326b93d899c08a83ce060a940cd01082629c201a7 Feb 13 19:33:16.016697 systemd-resolved[277]: Positive Trust Anchors: Feb 13 19:33:16.016720 systemd-resolved[277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 13 19:33:16.016753 systemd-resolved[277]: 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 Feb 13 19:33:16.022442 systemd-resolved[277]: Defaulting to hostname 'linux'. Feb 13 19:33:16.023688 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Feb 13 19:33:16.027687 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Feb 13 19:33:16.075533 kernel: SCSI subsystem initialized Feb 13 19:33:16.080510 kernel: Loading iSCSI transport class v2.0-870. Feb 13 19:33:16.088532 kernel: iscsi: registered transport (tcp) Feb 13 19:33:16.103510 kernel: iscsi: registered transport (qla4xxx) Feb 13 19:33:16.103541 kernel: QLogic iSCSI HBA Driver Feb 13 19:33:16.151400 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Feb 13 19:33:16.162623 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Feb 13 19:33:16.180785 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Feb 13 19:33:16.180833 kernel: device-mapper: uevent: version 1.0.3 Feb 13 19:33:16.182374 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Feb 13 19:33:16.229531 kernel: raid6: neonx8 gen() 15747 MB/s Feb 13 19:33:16.246522 kernel: raid6: neonx4 gen() 15610 MB/s Feb 13 19:33:16.263514 kernel: raid6: neonx2 gen() 13233 MB/s Feb 13 19:33:16.280541 kernel: raid6: neonx1 gen() 10437 MB/s Feb 13 19:33:16.297537 kernel: raid6: int64x8 gen() 6933 MB/s Feb 13 19:33:16.314513 kernel: raid6: int64x4 gen() 7322 MB/s Feb 13 19:33:16.331525 kernel: raid6: int64x2 gen() 6101 MB/s Feb 13 19:33:16.348652 kernel: raid6: int64x1 gen() 5037 MB/s Feb 13 19:33:16.348676 kernel: raid6: using algorithm neonx8 gen() 15747 MB/s Feb 13 19:33:16.366594 kernel: raid6: .... xor() 11917 MB/s, rmw enabled Feb 13 19:33:16.366628 kernel: raid6: using neon recovery algorithm Feb 13 19:33:16.371937 kernel: xor: measuring software checksum speed Feb 13 19:33:16.371958 kernel: 8regs : 19759 MB/sec Feb 13 19:33:16.372602 kernel: 32regs : 19664 MB/sec Feb 13 19:33:16.373813 kernel: arm64_neon : 26804 MB/sec Feb 13 19:33:16.373825 kernel: xor: using function: arm64_neon (26804 MB/sec) Feb 13 19:33:16.423526 kernel: Btrfs loaded, zoned=no, fsverity=no Feb 13 19:33:16.433972 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Feb 13 19:33:16.446671 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 13 19:33:16.458207 systemd-udevd[460]: Using default interface naming scheme 'v255'. Feb 13 19:33:16.461311 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 13 19:33:16.473682 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Feb 13 19:33:16.485008 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Feb 13 19:33:16.512851 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Feb 13 19:33:16.525643 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Feb 13 19:33:16.565623 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Feb 13 19:33:16.572717 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Feb 13 19:33:16.587528 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Feb 13 19:33:16.589539 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Feb 13 19:33:16.591428 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Feb 13 19:33:16.594066 systemd[1]: Reached target remote-fs.target - Remote File Systems. Feb 13 19:33:16.605651 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Feb 13 19:33:16.615351 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Feb 13 19:33:16.617569 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Feb 13 19:33:16.617693 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 19:33:16.621672 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Feb 13 19:33:16.623989 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Feb 13 19:33:16.624096 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 19:33:16.627838 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Feb 13 19:33:16.628929 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 13 19:33:16.629073 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 19:33:16.632829 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 19:33:16.640270 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (511) Feb 13 19:33:16.642294 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 19:33:16.645032 kernel: BTRFS: device fsid 4bb2b262-8ef2-48e3-80f4-24f9d7a85bf6 devid 1 transid 40 /dev/vda3 scanned by (udev-worker) (507) Feb 13 19:33:16.654258 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Feb 13 19:33:16.656767 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 19:33:16.664302 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Feb 13 19:33:16.671374 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Feb 13 19:33:16.675265 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Feb 13 19:33:16.676446 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Feb 13 19:33:16.690642 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Feb 13 19:33:16.692442 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Feb 13 19:33:16.702778 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 19:33:16.719631 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 19:33:17.724517 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 19:33:17.724696 disk-uuid[553]: The operation has completed successfully. Feb 13 19:33:17.747555 systemd[1]: disk-uuid.service: Deactivated successfully. Feb 13 19:33:17.747654 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Feb 13 19:33:17.768706 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Feb 13 19:33:17.771580 sh[571]: Success Feb 13 19:33:17.785511 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Feb 13 19:33:17.830075 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Feb 13 19:33:17.832093 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Feb 13 19:33:17.833076 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Feb 13 19:33:17.847955 kernel: BTRFS info (device dm-0): first mount of filesystem 4bb2b262-8ef2-48e3-80f4-24f9d7a85bf6 Feb 13 19:33:17.848005 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Feb 13 19:33:17.848016 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Feb 13 19:33:17.849894 kernel: BTRFS info (device dm-0): disabling log replay at mount time Feb 13 19:33:17.849910 kernel: BTRFS info (device dm-0): using free space tree Feb 13 19:33:17.855051 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Feb 13 19:33:17.856668 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Feb 13 19:33:17.865662 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Feb 13 19:33:17.867573 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Feb 13 19:33:17.879940 kernel: BTRFS info (device vda6): first mount of filesystem 896fb6d3-4143-43a6-a44b-ca1ce10817e1 Feb 13 19:33:17.879979 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Feb 13 19:33:17.879991 kernel: BTRFS info (device vda6): using free space tree Feb 13 19:33:17.887517 kernel: BTRFS info (device vda6): auto enabling async discard Feb 13 19:33:17.895477 systemd[1]: mnt-oem.mount: Deactivated successfully. Feb 13 19:33:17.897464 kernel: BTRFS info (device vda6): last unmount of filesystem 896fb6d3-4143-43a6-a44b-ca1ce10817e1 Feb 13 19:33:17.909613 systemd[1]: Finished ignition-setup.service - Ignition (setup). Feb 13 19:33:17.922719 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Feb 13 19:33:17.985039 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Feb 13 19:33:18.001738 systemd[1]: Starting systemd-networkd.service - Network Configuration... Feb 13 19:33:18.037377 systemd-networkd[756]: lo: Link UP Feb 13 19:33:18.037389 systemd-networkd[756]: lo: Gained carrier Feb 13 19:33:18.038416 systemd-networkd[756]: Enumeration completed Feb 13 19:33:18.039146 systemd-networkd[756]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 19:33:18.039149 systemd-networkd[756]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Feb 13 19:33:18.039819 systemd[1]: Started systemd-networkd.service - Network Configuration. Feb 13 19:33:18.041118 systemd[1]: Reached target network.target - Network. Feb 13 19:33:18.041642 systemd-networkd[756]: eth0: Link UP Feb 13 19:33:18.041646 systemd-networkd[756]: eth0: Gained carrier Feb 13 19:33:18.041653 systemd-networkd[756]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 19:33:18.068166 ignition[673]: Ignition 2.19.0 Feb 13 19:33:18.068175 ignition[673]: Stage: fetch-offline Feb 13 19:33:18.068220 ignition[673]: no configs at "/usr/lib/ignition/base.d" Feb 13 19:33:18.069867 systemd-networkd[756]: eth0: DHCPv4 address 10.0.0.46/16, gateway 10.0.0.1 acquired from 10.0.0.1 Feb 13 19:33:18.068237 ignition[673]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 13 19:33:18.068457 ignition[673]: parsed url from cmdline: "" Feb 13 19:33:18.068460 ignition[673]: no config URL provided Feb 13 19:33:18.068465 ignition[673]: reading system config file "/usr/lib/ignition/user.ign" Feb 13 19:33:18.068472 ignition[673]: no config at "/usr/lib/ignition/user.ign" Feb 13 19:33:18.068515 ignition[673]: op(1): [started] loading QEMU firmware config module Feb 13 19:33:18.068520 ignition[673]: op(1): executing: "modprobe" "qemu_fw_cfg" Feb 13 19:33:18.083660 ignition[673]: op(1): [finished] loading QEMU firmware config module Feb 13 19:33:18.089257 ignition[673]: parsing config with SHA512: 4f84a11f27bb41608d6469e05f8bc71b5466dc539b0c764e317376bf5277cc00ea941d618439cf79c1b42dfb2af16c7ca023da8054368196459690feb1de3b40 Feb 13 19:33:18.098311 unknown[673]: fetched base config from "system" Feb 13 19:33:18.098321 unknown[673]: fetched user config from "qemu" Feb 13 19:33:18.098564 ignition[673]: fetch-offline: fetch-offline passed Feb 13 19:33:18.100729 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Feb 13 19:33:18.098645 ignition[673]: Ignition finished successfully Feb 13 19:33:18.102380 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Feb 13 19:33:18.116728 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Feb 13 19:33:18.127714 ignition[767]: Ignition 2.19.0 Feb 13 19:33:18.127724 ignition[767]: Stage: kargs Feb 13 19:33:18.127888 ignition[767]: no configs at "/usr/lib/ignition/base.d" Feb 13 19:33:18.127897 ignition[767]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 13 19:33:18.128556 ignition[767]: kargs: kargs passed Feb 13 19:33:18.130818 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Feb 13 19:33:18.128599 ignition[767]: Ignition finished successfully Feb 13 19:33:18.141696 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Feb 13 19:33:18.152348 ignition[775]: Ignition 2.19.0 Feb 13 19:33:18.152357 ignition[775]: Stage: disks Feb 13 19:33:18.152549 ignition[775]: no configs at "/usr/lib/ignition/base.d" Feb 13 19:33:18.155046 systemd[1]: Finished ignition-disks.service - Ignition (disks). Feb 13 19:33:18.152558 ignition[775]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 13 19:33:18.156725 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Feb 13 19:33:18.153212 ignition[775]: disks: disks passed Feb 13 19:33:18.158589 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Feb 13 19:33:18.153267 ignition[775]: Ignition finished successfully Feb 13 19:33:18.160737 systemd[1]: Reached target local-fs.target - Local File Systems. Feb 13 19:33:18.162754 systemd[1]: Reached target sysinit.target - System Initialization. Feb 13 19:33:18.164294 systemd[1]: Reached target basic.target - Basic System. Feb 13 19:33:18.175650 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Feb 13 19:33:18.185093 systemd-fsck[786]: ROOT: clean, 14/553520 files, 52654/553472 blocks Feb 13 19:33:18.188845 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Feb 13 19:33:18.191042 systemd[1]: Mounting sysroot.mount - /sysroot... Feb 13 19:33:18.239509 kernel: EXT4-fs (vda9): mounted filesystem 9957d679-c6c4-49f4-b1b2-c3c1f3ba5699 r/w with ordered data mode. Quota mode: none. Feb 13 19:33:18.240150 systemd[1]: Mounted sysroot.mount - /sysroot. Feb 13 19:33:18.241513 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Feb 13 19:33:18.255612 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Feb 13 19:33:18.258088 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Feb 13 19:33:18.258884 systemd-resolved[277]: Detected conflict on linux IN A 10.0.0.46 Feb 13 19:33:18.258893 systemd-resolved[277]: Hostname conflict, changing published hostname from 'linux' to 'linux11'. Feb 13 19:33:18.268587 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (794) Feb 13 19:33:18.268619 kernel: BTRFS info (device vda6): first mount of filesystem 896fb6d3-4143-43a6-a44b-ca1ce10817e1 Feb 13 19:33:18.268631 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Feb 13 19:33:18.268641 kernel: BTRFS info (device vda6): using free space tree Feb 13 19:33:18.261341 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Feb 13 19:33:18.272748 kernel: BTRFS info (device vda6): auto enabling async discard Feb 13 19:33:18.261386 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Feb 13 19:33:18.261413 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Feb 13 19:33:18.266390 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Feb 13 19:33:18.271249 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Feb 13 19:33:18.275034 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Feb 13 19:33:18.312687 initrd-setup-root[819]: cut: /sysroot/etc/passwd: No such file or directory Feb 13 19:33:18.316871 initrd-setup-root[826]: cut: /sysroot/etc/group: No such file or directory Feb 13 19:33:18.320122 initrd-setup-root[833]: cut: /sysroot/etc/shadow: No such file or directory Feb 13 19:33:18.324151 initrd-setup-root[840]: cut: /sysroot/etc/gshadow: No such file or directory Feb 13 19:33:18.395826 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Feb 13 19:33:18.412602 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Feb 13 19:33:18.414542 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Feb 13 19:33:18.420506 kernel: BTRFS info (device vda6): last unmount of filesystem 896fb6d3-4143-43a6-a44b-ca1ce10817e1 Feb 13 19:33:18.437937 ignition[909]: INFO : Ignition 2.19.0 Feb 13 19:33:18.437937 ignition[909]: INFO : Stage: mount Feb 13 19:33:18.440301 ignition[909]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 13 19:33:18.440301 ignition[909]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 13 19:33:18.440301 ignition[909]: INFO : mount: mount passed Feb 13 19:33:18.440301 ignition[909]: INFO : Ignition finished successfully Feb 13 19:33:18.438200 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Feb 13 19:33:18.439937 systemd[1]: Finished ignition-mount.service - Ignition (mount). Feb 13 19:33:18.450697 systemd[1]: Starting ignition-files.service - Ignition (files)... Feb 13 19:33:18.846403 systemd[1]: sysroot-oem.mount: Deactivated successfully. Feb 13 19:33:18.855686 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Feb 13 19:33:18.866500 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (922) Feb 13 19:33:18.866533 kernel: BTRFS info (device vda6): first mount of filesystem 896fb6d3-4143-43a6-a44b-ca1ce10817e1 Feb 13 19:33:18.868530 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Feb 13 19:33:18.868551 kernel: BTRFS info (device vda6): using free space tree Feb 13 19:33:18.871508 kernel: BTRFS info (device vda6): auto enabling async discard Feb 13 19:33:18.872575 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Feb 13 19:33:18.889959 ignition[940]: INFO : Ignition 2.19.0 Feb 13 19:33:18.889959 ignition[940]: INFO : Stage: files Feb 13 19:33:18.891739 ignition[940]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 13 19:33:18.891739 ignition[940]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 13 19:33:18.891739 ignition[940]: DEBUG : files: compiled without relabeling support, skipping Feb 13 19:33:18.895349 ignition[940]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Feb 13 19:33:18.895349 ignition[940]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Feb 13 19:33:18.898239 ignition[940]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Feb 13 19:33:18.899711 ignition[940]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Feb 13 19:33:18.899711 ignition[940]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Feb 13 19:33:18.898816 unknown[940]: wrote ssh authorized keys file for user: core Feb 13 19:33:18.905947 ignition[940]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(4): [started] processing unit "etcd-member.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(6): [started] processing unit "flannel-docker-opts.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(6): op(7): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(6): op(7): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(6): [finished] processing unit "flannel-docker-opts.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(8): [started] processing unit "docker.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(8): [finished] processing unit "docker.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(9): [started] processing unit "flanneld.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(9): op(a): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(9): op(a): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(9): [finished] processing unit "flanneld.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(b): [started] processing unit "coreos-metadata.service" Feb 13 19:33:18.905947 ignition[940]: INFO : files: op(b): op(c): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Feb 13 19:33:18.938687 ignition[940]: INFO : files: op(b): op(c): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Feb 13 19:33:18.938687 ignition[940]: INFO : files: op(b): [finished] processing unit "coreos-metadata.service" Feb 13 19:33:18.938687 ignition[940]: INFO : files: op(d): [started] setting preset to disabled for "coreos-metadata.service" Feb 13 19:33:18.965364 ignition[940]: INFO : files: op(d): op(e): [started] removing enablement symlink(s) for "coreos-metadata.service" Feb 13 19:33:18.969406 ignition[940]: INFO : files: op(d): op(e): [finished] removing enablement symlink(s) for "coreos-metadata.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(d): [finished] setting preset to disabled for "coreos-metadata.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(f): [started] setting preset to enabled for "docker.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(f): [finished] setting preset to enabled for "docker.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(10): [started] setting preset to enabled for "etcd-member.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(10): [finished] setting preset to enabled for "etcd-member.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(11): [started] setting preset to enabled for "flanneld.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: op(11): [finished] setting preset to enabled for "flanneld.service" Feb 13 19:33:18.971169 ignition[940]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" Feb 13 19:33:18.971169 ignition[940]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" Feb 13 19:33:18.971169 ignition[940]: INFO : files: files passed Feb 13 19:33:18.971169 ignition[940]: INFO : Ignition finished successfully Feb 13 19:33:18.972886 systemd[1]: Finished ignition-files.service - Ignition (files). Feb 13 19:33:18.985651 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Feb 13 19:33:18.988182 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Feb 13 19:33:18.990001 systemd[1]: ignition-quench.service: Deactivated successfully. Feb 13 19:33:18.990079 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Feb 13 19:33:18.996169 initrd-setup-root-after-ignition[967]: grep: /sysroot/oem/oem-release: No such file or directory Feb 13 19:33:18.997650 initrd-setup-root-after-ignition[969]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Feb 13 19:33:18.997650 initrd-setup-root-after-ignition[969]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Feb 13 19:33:19.000968 initrd-setup-root-after-ignition[973]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Feb 13 19:33:19.000234 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Feb 13 19:33:19.003934 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Feb 13 19:33:19.015671 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Feb 13 19:33:19.034654 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Feb 13 19:33:19.035574 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Feb 13 19:33:19.037097 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Feb 13 19:33:19.039100 systemd[1]: Reached target initrd.target - Initrd Default Target. Feb 13 19:33:19.041066 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Feb 13 19:33:19.041860 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Feb 13 19:33:19.058561 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Feb 13 19:33:19.061089 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Feb 13 19:33:19.072718 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Feb 13 19:33:19.074062 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Feb 13 19:33:19.076185 systemd[1]: Stopped target timers.target - Timer Units. Feb 13 19:33:19.078038 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Feb 13 19:33:19.078160 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Feb 13 19:33:19.080791 systemd[1]: Stopped target initrd.target - Initrd Default Target. Feb 13 19:33:19.082997 systemd[1]: Stopped target basic.target - Basic System. Feb 13 19:33:19.084788 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Feb 13 19:33:19.086608 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Feb 13 19:33:19.088717 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Feb 13 19:33:19.090793 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Feb 13 19:33:19.092695 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Feb 13 19:33:19.094807 systemd[1]: Stopped target sysinit.target - System Initialization. Feb 13 19:33:19.096870 systemd[1]: Stopped target local-fs.target - Local File Systems. Feb 13 19:33:19.098725 systemd[1]: Stopped target swap.target - Swaps. Feb 13 19:33:19.100330 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Feb 13 19:33:19.100463 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Feb 13 19:33:19.102907 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Feb 13 19:33:19.104967 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Feb 13 19:33:19.106958 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Feb 13 19:33:19.110537 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Feb 13 19:33:19.111857 systemd[1]: dracut-initqueue.service: Deactivated successfully. Feb 13 19:33:19.111975 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Feb 13 19:33:19.115057 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Feb 13 19:33:19.115179 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Feb 13 19:33:19.117346 systemd[1]: Stopped target paths.target - Path Units. Feb 13 19:33:19.119006 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Feb 13 19:33:19.123540 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Feb 13 19:33:19.124820 systemd[1]: Stopped target slices.target - Slice Units. Feb 13 19:33:19.126922 systemd[1]: Stopped target sockets.target - Socket Units. Feb 13 19:33:19.128467 systemd[1]: iscsid.socket: Deactivated successfully. Feb 13 19:33:19.128577 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Feb 13 19:33:19.130247 systemd[1]: iscsiuio.socket: Deactivated successfully. Feb 13 19:33:19.130330 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Feb 13 19:33:19.131982 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Feb 13 19:33:19.132086 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Feb 13 19:33:19.133908 systemd[1]: ignition-files.service: Deactivated successfully. Feb 13 19:33:19.134005 systemd[1]: Stopped ignition-files.service - Ignition (files). Feb 13 19:33:19.147647 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Feb 13 19:33:19.148574 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Feb 13 19:33:19.148705 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Feb 13 19:33:19.151410 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Feb 13 19:33:19.152432 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Feb 13 19:33:19.152570 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Feb 13 19:33:19.154788 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Feb 13 19:33:19.159634 ignition[993]: INFO : Ignition 2.19.0 Feb 13 19:33:19.159634 ignition[993]: INFO : Stage: umount Feb 13 19:33:19.159634 ignition[993]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 13 19:33:19.159634 ignition[993]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 13 19:33:19.159634 ignition[993]: INFO : umount: umount passed Feb 13 19:33:19.159634 ignition[993]: INFO : Ignition finished successfully Feb 13 19:33:19.154890 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Feb 13 19:33:19.160513 systemd[1]: initrd-cleanup.service: Deactivated successfully. Feb 13 19:33:19.160599 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Feb 13 19:33:19.162686 systemd[1]: ignition-mount.service: Deactivated successfully. Feb 13 19:33:19.164271 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Feb 13 19:33:19.167858 systemd[1]: Stopped target network.target - Network. Feb 13 19:33:19.170722 systemd[1]: ignition-disks.service: Deactivated successfully. Feb 13 19:33:19.170775 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Feb 13 19:33:19.175112 systemd[1]: ignition-kargs.service: Deactivated successfully. Feb 13 19:33:19.175160 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Feb 13 19:33:19.177016 systemd[1]: ignition-setup.service: Deactivated successfully. Feb 13 19:33:19.177060 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Feb 13 19:33:19.178824 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Feb 13 19:33:19.178870 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Feb 13 19:33:19.180710 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Feb 13 19:33:19.183667 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Feb 13 19:33:19.186136 systemd[1]: sysroot-boot.mount: Deactivated successfully. Feb 13 19:33:19.186729 systemd[1]: sysroot-boot.service: Deactivated successfully. Feb 13 19:33:19.186815 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Feb 13 19:33:19.188650 systemd[1]: initrd-setup-root.service: Deactivated successfully. Feb 13 19:33:19.188752 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Feb 13 19:33:19.194547 systemd-networkd[756]: eth0: DHCPv6 lease lost Feb 13 19:33:19.195195 systemd[1]: systemd-resolved.service: Deactivated successfully. Feb 13 19:33:19.195307 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Feb 13 19:33:19.197546 systemd[1]: systemd-networkd.service: Deactivated successfully. Feb 13 19:33:19.197648 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Feb 13 19:33:19.200299 systemd[1]: systemd-networkd.socket: Deactivated successfully. Feb 13 19:33:19.200344 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Feb 13 19:33:19.208598 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Feb 13 19:33:19.210238 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Feb 13 19:33:19.210298 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Feb 13 19:33:19.212562 systemd[1]: systemd-sysctl.service: Deactivated successfully. Feb 13 19:33:19.212607 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Feb 13 19:33:19.214642 systemd[1]: systemd-modules-load.service: Deactivated successfully. Feb 13 19:33:19.214687 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Feb 13 19:33:19.216770 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Feb 13 19:33:19.216817 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 13 19:33:19.219039 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 13 19:33:19.230291 systemd[1]: network-cleanup.service: Deactivated successfully. Feb 13 19:33:19.231534 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Feb 13 19:33:19.243111 systemd[1]: systemd-udevd.service: Deactivated successfully. Feb 13 19:33:19.243274 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 13 19:33:19.245747 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Feb 13 19:33:19.245786 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Feb 13 19:33:19.247661 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Feb 13 19:33:19.247697 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Feb 13 19:33:19.249626 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Feb 13 19:33:19.249672 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Feb 13 19:33:19.252702 systemd[1]: dracut-cmdline.service: Deactivated successfully. Feb 13 19:33:19.252745 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Feb 13 19:33:19.255846 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Feb 13 19:33:19.255887 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 19:33:19.265625 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Feb 13 19:33:19.266696 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Feb 13 19:33:19.266754 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 13 19:33:19.268937 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 13 19:33:19.268980 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 19:33:19.273436 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Feb 13 19:33:19.273544 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Feb 13 19:33:19.275319 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Feb 13 19:33:19.277791 systemd[1]: Starting initrd-switch-root.service - Switch Root... Feb 13 19:33:19.287759 systemd[1]: Switching root. Feb 13 19:33:19.316731 systemd-journald[238]: Journal stopped Feb 13 19:33:19.955957 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Feb 13 19:33:19.956018 kernel: SELinux: policy capability network_peer_controls=1 Feb 13 19:33:19.956030 kernel: SELinux: policy capability open_perms=1 Feb 13 19:33:19.956048 kernel: SELinux: policy capability extended_socket_class=1 Feb 13 19:33:19.956058 kernel: SELinux: policy capability always_check_network=0 Feb 13 19:33:19.956068 kernel: SELinux: policy capability cgroup_seclabel=1 Feb 13 19:33:19.956078 kernel: SELinux: policy capability nnp_nosuid_transition=1 Feb 13 19:33:19.956087 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Feb 13 19:33:19.956097 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Feb 13 19:33:19.956106 kernel: audit: type=1403 audit(1739475199.385:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Feb 13 19:33:19.956117 systemd[1]: Successfully loaded SELinux policy in 31.185ms. Feb 13 19:33:19.956139 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.276ms. Feb 13 19:33:19.956151 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Feb 13 19:33:19.956162 systemd[1]: Detected virtualization kvm. Feb 13 19:33:19.956175 systemd[1]: Detected architecture arm64. Feb 13 19:33:19.956185 systemd[1]: Detected first boot. Feb 13 19:33:19.956196 systemd[1]: Initializing machine ID from VM UUID. Feb 13 19:33:19.956206 zram_generator::config[1037]: No configuration found. Feb 13 19:33:19.956232 systemd[1]: Populated /etc with preset unit settings. Feb 13 19:33:19.956244 systemd[1]: initrd-switch-root.service: Deactivated successfully. Feb 13 19:33:19.956256 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Feb 13 19:33:19.956267 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Feb 13 19:33:19.956277 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Feb 13 19:33:19.956288 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Feb 13 19:33:19.956299 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Feb 13 19:33:19.956309 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Feb 13 19:33:19.956319 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Feb 13 19:33:19.956330 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Feb 13 19:33:19.956343 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Feb 13 19:33:19.956353 systemd[1]: Created slice user.slice - User and Session Slice. Feb 13 19:33:19.956364 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Feb 13 19:33:19.956375 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Feb 13 19:33:19.956386 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Feb 13 19:33:19.956396 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Feb 13 19:33:19.956407 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Feb 13 19:33:19.956418 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Feb 13 19:33:19.956429 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Feb 13 19:33:19.956442 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Feb 13 19:33:19.956453 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Feb 13 19:33:19.956464 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Feb 13 19:33:19.956475 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Feb 13 19:33:19.956496 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Feb 13 19:33:19.956511 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Feb 13 19:33:19.956522 systemd[1]: Reached target remote-fs.target - Remote File Systems. Feb 13 19:33:19.956533 systemd[1]: Reached target slices.target - Slice Units. Feb 13 19:33:19.956545 systemd[1]: Reached target swap.target - Swaps. Feb 13 19:33:19.956556 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Feb 13 19:33:19.956567 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Feb 13 19:33:19.956578 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Feb 13 19:33:19.956589 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Feb 13 19:33:19.956600 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Feb 13 19:33:19.956612 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Feb 13 19:33:19.956622 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Feb 13 19:33:19.956633 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Feb 13 19:33:19.956645 systemd[1]: Mounting media.mount - External Media Directory... Feb 13 19:33:19.956656 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Feb 13 19:33:19.956667 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Feb 13 19:33:19.956678 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Feb 13 19:33:19.956689 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). Feb 13 19:33:19.956700 systemd[1]: Reached target machines.target - Containers. Feb 13 19:33:19.956710 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Feb 13 19:33:19.956721 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 19:33:19.956733 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Feb 13 19:33:19.956744 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Feb 13 19:33:19.956754 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 13 19:33:19.956765 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Feb 13 19:33:19.956775 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 13 19:33:19.956786 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Feb 13 19:33:19.956796 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 13 19:33:19.956807 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Feb 13 19:33:19.956817 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Feb 13 19:33:19.956829 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Feb 13 19:33:19.956840 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Feb 13 19:33:19.956850 systemd[1]: Stopped systemd-fsck-usr.service. Feb 13 19:33:19.956860 kernel: fuse: init (API version 7.39) Feb 13 19:33:19.956870 kernel: loop: module loaded Feb 13 19:33:19.956885 systemd[1]: Starting systemd-journald.service - Journal Service... Feb 13 19:33:19.956896 kernel: ACPI: bus type drm_connector registered Feb 13 19:33:19.956906 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Feb 13 19:33:19.956917 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Feb 13 19:33:19.956929 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Feb 13 19:33:19.956957 systemd-journald[1101]: Collecting audit messages is disabled. Feb 13 19:33:19.956979 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Feb 13 19:33:19.956992 systemd-journald[1101]: Journal started Feb 13 19:33:19.957013 systemd-journald[1101]: Runtime Journal (/run/log/journal/97221e27ce974a7fad457640cc37b177) is 5.9M, max 47.3M, 41.4M free. Feb 13 19:33:19.752674 systemd[1]: Queued start job for default target multi-user.target. Feb 13 19:33:19.773671 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Feb 13 19:33:19.774051 systemd[1]: systemd-journald.service: Deactivated successfully. Feb 13 19:33:19.961550 systemd[1]: verity-setup.service: Deactivated successfully. Feb 13 19:33:19.961648 systemd[1]: Stopped verity-setup.service. Feb 13 19:33:19.965535 systemd[1]: Started systemd-journald.service - Journal Service. Feb 13 19:33:19.967101 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Feb 13 19:33:19.968345 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Feb 13 19:33:19.969636 systemd[1]: Mounted media.mount - External Media Directory. Feb 13 19:33:19.970807 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Feb 13 19:33:19.972088 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Feb 13 19:33:19.973388 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Feb 13 19:33:19.975560 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Feb 13 19:33:19.976969 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Feb 13 19:33:19.978511 systemd[1]: modprobe@configfs.service: Deactivated successfully. Feb 13 19:33:19.978694 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Feb 13 19:33:19.980106 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 13 19:33:19.980262 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 13 19:33:19.981724 systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 13 19:33:19.981854 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Feb 13 19:33:19.983172 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 13 19:33:19.983343 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 13 19:33:19.984946 systemd[1]: modprobe@fuse.service: Deactivated successfully. Feb 13 19:33:19.985098 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Feb 13 19:33:19.986654 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 13 19:33:19.986788 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 13 19:33:19.988151 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Feb 13 19:33:19.989832 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Feb 13 19:33:19.991372 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Feb 13 19:33:20.004024 systemd[1]: Reached target network-pre.target - Preparation for Network. Feb 13 19:33:20.013599 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Feb 13 19:33:20.015880 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Feb 13 19:33:20.017100 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Feb 13 19:33:20.017144 systemd[1]: Reached target local-fs.target - Local File Systems. Feb 13 19:33:20.019293 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Feb 13 19:33:20.021627 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Feb 13 19:33:20.023830 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Feb 13 19:33:20.025076 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 19:33:20.026848 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Feb 13 19:33:20.028984 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Feb 13 19:33:20.030319 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 13 19:33:20.033711 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Feb 13 19:33:20.034941 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 13 19:33:20.035899 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Feb 13 19:33:20.039783 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Feb 13 19:33:20.042109 systemd-journald[1101]: Time spent on flushing to /var/log/journal/97221e27ce974a7fad457640cc37b177 is 12.002ms for 842 entries. Feb 13 19:33:20.042109 systemd-journald[1101]: System Journal (/var/log/journal/97221e27ce974a7fad457640cc37b177) is 8.0M, max 195.6M, 187.6M free. Feb 13 19:33:20.061025 systemd-journald[1101]: Received client request to flush runtime journal. Feb 13 19:33:20.061068 kernel: loop0: detected capacity change from 0 to 114328 Feb 13 19:33:20.047692 systemd[1]: Starting systemd-sysusers.service - Create System Users... Feb 13 19:33:20.052426 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Feb 13 19:33:20.053906 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Feb 13 19:33:20.055339 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Feb 13 19:33:20.057026 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Feb 13 19:33:20.062865 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Feb 13 19:33:20.066594 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Feb 13 19:33:20.069910 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Feb 13 19:33:20.073442 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Feb 13 19:33:20.077516 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 13 19:33:20.085687 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Feb 13 19:33:20.088849 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Feb 13 19:33:20.094578 systemd[1]: Finished systemd-sysusers.service - Create System Users. Feb 13 19:33:20.098912 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Feb 13 19:33:20.103519 kernel: loop1: detected capacity change from 0 to 114432 Feb 13 19:33:20.104716 udevadm[1166]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Feb 13 19:33:20.116359 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Feb 13 19:33:20.118630 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Feb 13 19:33:20.132144 systemd-tmpfiles[1168]: ACLs are not supported, ignoring. Feb 13 19:33:20.132165 systemd-tmpfiles[1168]: ACLs are not supported, ignoring. Feb 13 19:33:20.138417 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 13 19:33:20.144511 kernel: loop2: detected capacity change from 0 to 114328 Feb 13 19:33:20.149511 kernel: loop3: detected capacity change from 0 to 114432 Feb 13 19:33:20.152502 (sd-merge)[1174]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Feb 13 19:33:20.153678 (sd-merge)[1174]: Merged extensions into '/usr'. Feb 13 19:33:20.155760 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Feb 13 19:33:20.170716 systemd[1]: Starting ensure-sysext.service... Feb 13 19:33:20.174161 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Feb 13 19:33:20.186540 systemd[1]: Reloading requested from client PID 1176 ('systemctl') (unit ensure-sysext.service)... Feb 13 19:33:20.186557 systemd[1]: Reloading... Feb 13 19:33:20.197238 systemd-tmpfiles[1177]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Feb 13 19:33:20.197911 systemd-tmpfiles[1177]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Feb 13 19:33:20.198710 systemd-tmpfiles[1177]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Feb 13 19:33:20.199052 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Feb 13 19:33:20.199166 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Feb 13 19:33:20.201870 systemd-tmpfiles[1177]: Detected autofs mount point /boot during canonicalization of boot. Feb 13 19:33:20.201983 systemd-tmpfiles[1177]: Skipping /boot Feb 13 19:33:20.209248 systemd-tmpfiles[1177]: Detected autofs mount point /boot during canonicalization of boot. Feb 13 19:33:20.209360 systemd-tmpfiles[1177]: Skipping /boot Feb 13 19:33:20.246515 zram_generator::config[1205]: No configuration found. Feb 13 19:33:20.344590 ldconfig[1143]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Feb 13 19:33:20.349465 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. Feb 13 19:33:20.386291 systemd[1]: Reloading finished in 199 ms. Feb 13 19:33:20.419384 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Feb 13 19:33:20.421459 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 13 19:33:20.427905 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Feb 13 19:33:20.430256 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Feb 13 19:33:20.433732 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Feb 13 19:33:20.440515 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Feb 13 19:33:20.443815 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Feb 13 19:33:20.449993 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 19:33:20.455229 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 13 19:33:20.458798 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 13 19:33:20.462171 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 13 19:33:20.463436 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 19:33:20.464141 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 13 19:33:20.465609 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 13 19:33:20.467417 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 13 19:33:20.467574 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 13 19:33:20.469324 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 13 19:33:20.469463 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 13 19:33:20.475859 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 13 19:33:20.476074 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 13 19:33:20.489740 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Feb 13 19:33:20.491460 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Feb 13 19:33:20.494012 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Feb 13 19:33:20.497087 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Feb 13 19:33:20.501951 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 19:33:20.504671 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 13 19:33:20.510006 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 13 19:33:20.513861 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 13 19:33:20.515050 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 19:33:20.515179 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). Feb 13 19:33:20.520436 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 13 19:33:20.522197 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 13 19:33:20.530485 augenrules[1276]: No rules Feb 13 19:33:20.531995 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Feb 13 19:33:20.533713 systemd[1]: Started systemd-userdbd.service - User Database Manager. Feb 13 19:33:20.535591 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 13 19:33:20.535761 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 13 19:33:20.537394 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Feb 13 19:33:20.539362 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 13 19:33:20.539531 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 13 19:33:20.544991 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 19:33:20.556693 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Feb 13 19:33:20.557908 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 19:33:20.557981 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 13 19:33:20.558016 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 13 19:33:20.559924 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 13 19:33:20.562244 systemd[1]: Starting systemd-update-done.service - Update is Completed... Feb 13 19:33:20.563318 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). Feb 13 19:33:20.563842 systemd[1]: Finished ensure-sysext.service. Feb 13 19:33:20.565041 systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 13 19:33:20.565227 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Feb 13 19:33:20.571743 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Feb 13 19:33:20.582551 systemd[1]: Finished systemd-update-done.service - Update is Completed. Feb 13 19:33:20.591993 systemd-udevd[1292]: Using default interface naming scheme 'v255'. Feb 13 19:33:20.599511 systemd-resolved[1247]: Positive Trust Anchors: Feb 13 19:33:20.599529 systemd-resolved[1247]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 13 19:33:20.599563 systemd-resolved[1247]: 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 Feb 13 19:33:20.606439 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 13 19:33:20.606942 systemd-resolved[1247]: Defaulting to hostname 'linux'. Feb 13 19:33:20.621873 systemd[1]: Starting systemd-networkd.service - Network Configuration... Feb 13 19:33:20.623616 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Feb 13 19:33:20.631720 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Feb 13 19:33:20.640871 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Feb 13 19:33:20.642330 systemd[1]: Reached target time-set.target - System Time Set. Feb 13 19:33:20.651601 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Feb 13 19:33:20.681371 systemd-networkd[1308]: lo: Link UP Feb 13 19:33:20.681379 systemd-networkd[1308]: lo: Gained carrier Feb 13 19:33:20.682127 systemd-networkd[1308]: Enumeration completed Feb 13 19:33:20.682233 systemd[1]: Started systemd-networkd.service - Network Configuration. Feb 13 19:33:20.684117 systemd[1]: Reached target network.target - Network. Feb 13 19:33:20.689551 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1309) Feb 13 19:33:20.692349 systemd-networkd[1308]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 19:33:20.692360 systemd-networkd[1308]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Feb 13 19:33:20.692850 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Feb 13 19:33:20.692995 systemd-networkd[1308]: eth0: Link UP Feb 13 19:33:20.692999 systemd-networkd[1308]: eth0: Gained carrier Feb 13 19:33:20.693014 systemd-networkd[1308]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 19:33:20.705047 systemd-networkd[1308]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 19:33:20.715597 systemd-networkd[1308]: eth0: DHCPv4 address 10.0.0.46/16, gateway 10.0.0.1 acquired from 10.0.0.1 Feb 13 19:33:20.716175 systemd-timesyncd[1296]: Network configuration changed, trying to establish connection. Feb 13 19:33:21.216187 systemd-timesyncd[1296]: Contacted time server 10.0.0.1:123 (10.0.0.1). Feb 13 19:33:21.216231 systemd-timesyncd[1296]: Initial clock synchronization to Thu 2025-02-13 19:33:21.216089 UTC. Feb 13 19:33:21.216604 systemd-resolved[1247]: Clock change detected. Flushing caches. Feb 13 19:33:21.217985 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Feb 13 19:33:21.227988 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Feb 13 19:33:21.240860 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Feb 13 19:33:21.259090 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 19:33:21.267592 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Feb 13 19:33:21.283991 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Feb 13 19:33:21.307798 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 19:33:21.312275 lvm[1336]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Feb 13 19:33:21.352386 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Feb 13 19:33:21.354058 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Feb 13 19:33:21.355245 systemd[1]: Reached target sysinit.target - System Initialization. Feb 13 19:33:21.356599 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Feb 13 19:33:21.357935 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Feb 13 19:33:21.359442 systemd[1]: Started logrotate.timer - Daily rotation of log files. Feb 13 19:33:21.360687 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Feb 13 19:33:21.362122 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Feb 13 19:33:21.363415 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Feb 13 19:33:21.363454 systemd[1]: Reached target paths.target - Path Units. Feb 13 19:33:21.364444 systemd[1]: Reached target timers.target - Timer Units. Feb 13 19:33:21.366731 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Feb 13 19:33:21.369259 systemd[1]: Starting docker.socket - Docker Socket for the API... Feb 13 19:33:21.381869 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Feb 13 19:33:21.384553 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Feb 13 19:33:21.386244 systemd[1]: Listening on docker.socket - Docker Socket for the API. Feb 13 19:33:21.387562 systemd[1]: Reached target sockets.target - Socket Units. Feb 13 19:33:21.388598 systemd[1]: Reached target basic.target - Basic System. Feb 13 19:33:21.389632 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Feb 13 19:33:21.389668 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Feb 13 19:33:21.390696 systemd[1]: Starting containerd.service - containerd container runtime... Feb 13 19:33:21.392831 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Feb 13 19:33:21.395914 lvm[1343]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Feb 13 19:33:21.396815 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Feb 13 19:33:21.399969 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Feb 13 19:33:21.401832 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). Feb 13 19:33:21.403039 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Feb 13 19:33:21.414039 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Feb 13 19:33:21.421016 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Feb 13 19:33:21.431574 jq[1346]: false Feb 13 19:33:21.436994 extend-filesystems[1347]: Found loop2 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found loop3 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda1 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda2 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda3 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found usr Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda4 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda6 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda7 Feb 13 19:33:21.438603 extend-filesystems[1347]: Found vda9 Feb 13 19:33:21.438603 extend-filesystems[1347]: Checking size of /dev/vda9 Feb 13 19:33:21.438762 systemd[1]: Starting systemd-logind.service - User Login Management... Feb 13 19:33:21.442351 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Feb 13 19:33:21.443243 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Feb 13 19:33:21.443964 systemd[1]: Starting update-engine.service - Update Engine... Feb 13 19:33:21.448487 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Feb 13 19:33:21.450475 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Feb 13 19:33:21.454122 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Feb 13 19:33:21.456949 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Feb 13 19:33:21.457388 systemd[1]: motdgen.service: Deactivated successfully. Feb 13 19:33:21.457544 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Feb 13 19:33:21.460238 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Feb 13 19:33:21.460405 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Feb 13 19:33:21.466934 jq[1364]: true Feb 13 19:33:21.465926 dbus-daemon[1345]: [system] SELinux support is enabled Feb 13 19:33:21.467399 systemd[1]: Started dbus.service - D-Bus System Message Bus. Feb 13 19:33:21.470417 extend-filesystems[1347]: Old size kept for /dev/vda9 Feb 13 19:33:21.472681 systemd[1]: extend-filesystems.service: Deactivated successfully. Feb 13 19:33:21.473393 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Feb 13 19:33:21.500677 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1306) Feb 13 19:33:21.510076 (ntainerd)[1366]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Feb 13 19:33:21.516718 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). Feb 13 19:33:21.524692 jq[1372]: true Feb 13 19:33:21.516821 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Feb 13 19:33:21.518244 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). Feb 13 19:33:21.518276 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Feb 13 19:33:21.543859 update_engine[1363]: I20250213 19:33:21.543329 1363 main.cc:92] Flatcar Update Engine starting Feb 13 19:33:21.544803 systemd-logind[1360]: Watching system buttons on /dev/input/event0 (Power Button) Feb 13 19:33:21.546629 systemd[1]: Started update-engine.service - Update Engine. Feb 13 19:33:21.546765 update_engine[1363]: I20250213 19:33:21.546725 1363 update_check_scheduler.cc:74] Next update check in 5m52s Feb 13 19:33:21.548116 systemd-logind[1360]: New seat seat0. Feb 13 19:33:21.561981 systemd[1]: Started locksmithd.service - Cluster reboot manager. Feb 13 19:33:21.568162 systemd[1]: Started systemd-logind.service - User Login Management. Feb 13 19:33:21.601766 bash[1394]: Updated "/home/core/.ssh/authorized_keys" Feb 13 19:33:21.604191 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Feb 13 19:33:21.607650 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Feb 13 19:33:21.621703 locksmithd[1395]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Feb 13 19:33:21.751141 containerd[1366]: time="2025-02-13T19:33:21.749373920Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Feb 13 19:33:21.775291 containerd[1366]: time="2025-02-13T19:33:21.775231480Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.776648 containerd[1366]: time="2025-02-13T19:33:21.776607600Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Feb 13 19:33:21.776648 containerd[1366]: time="2025-02-13T19:33:21.776640480Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Feb 13 19:33:21.776719 containerd[1366]: time="2025-02-13T19:33:21.776656800Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Feb 13 19:33:21.776862 containerd[1366]: time="2025-02-13T19:33:21.776843760Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Feb 13 19:33:21.776908 containerd[1366]: time="2025-02-13T19:33:21.776869640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.776939 containerd[1366]: time="2025-02-13T19:33:21.776923480Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Feb 13 19:33:21.776960 containerd[1366]: time="2025-02-13T19:33:21.776938960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777126 containerd[1366]: time="2025-02-13T19:33:21.777095440Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777126 containerd[1366]: time="2025-02-13T19:33:21.777118160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777172 containerd[1366]: time="2025-02-13T19:33:21.777131560Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777172 containerd[1366]: time="2025-02-13T19:33:21.777140760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777222 containerd[1366]: time="2025-02-13T19:33:21.777208040Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777412 containerd[1366]: time="2025-02-13T19:33:21.777395000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777517 containerd[1366]: time="2025-02-13T19:33:21.777488560Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Feb 13 19:33:21.777545 containerd[1366]: time="2025-02-13T19:33:21.777518560Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Feb 13 19:33:21.777612 containerd[1366]: time="2025-02-13T19:33:21.777595880Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Feb 13 19:33:21.777655 containerd[1366]: time="2025-02-13T19:33:21.777642240Z" level=info msg="metadata content store policy set" policy=shared Feb 13 19:33:21.780451 containerd[1366]: time="2025-02-13T19:33:21.780426240Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Feb 13 19:33:21.780515 containerd[1366]: time="2025-02-13T19:33:21.780476600Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Feb 13 19:33:21.780515 containerd[1366]: time="2025-02-13T19:33:21.780500520Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Feb 13 19:33:21.780576 containerd[1366]: time="2025-02-13T19:33:21.780518920Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Feb 13 19:33:21.780576 containerd[1366]: time="2025-02-13T19:33:21.780533680Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Feb 13 19:33:21.780699 containerd[1366]: time="2025-02-13T19:33:21.780673480Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Feb 13 19:33:21.781072 containerd[1366]: time="2025-02-13T19:33:21.781055760Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Feb 13 19:33:21.781190 containerd[1366]: time="2025-02-13T19:33:21.781172960Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Feb 13 19:33:21.781218 containerd[1366]: time="2025-02-13T19:33:21.781197120Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Feb 13 19:33:21.781218 containerd[1366]: time="2025-02-13T19:33:21.781210560Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Feb 13 19:33:21.781269 containerd[1366]: time="2025-02-13T19:33:21.781224520Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781269 containerd[1366]: time="2025-02-13T19:33:21.781238000Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781269 containerd[1366]: time="2025-02-13T19:33:21.781250520Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781269 containerd[1366]: time="2025-02-13T19:33:21.781264760Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781337 containerd[1366]: time="2025-02-13T19:33:21.781279400Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781337 containerd[1366]: time="2025-02-13T19:33:21.781292760Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781337 containerd[1366]: time="2025-02-13T19:33:21.781305200Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781337 containerd[1366]: time="2025-02-13T19:33:21.781317520Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Feb 13 19:33:21.781405 containerd[1366]: time="2025-02-13T19:33:21.781337520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781405 containerd[1366]: time="2025-02-13T19:33:21.781350960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781405 containerd[1366]: time="2025-02-13T19:33:21.781376960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781405 containerd[1366]: time="2025-02-13T19:33:21.781396000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781477 containerd[1366]: time="2025-02-13T19:33:21.781410000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781477 containerd[1366]: time="2025-02-13T19:33:21.781430160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781477 containerd[1366]: time="2025-02-13T19:33:21.781442680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781477 containerd[1366]: time="2025-02-13T19:33:21.781456600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781477 containerd[1366]: time="2025-02-13T19:33:21.781469520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781571 containerd[1366]: time="2025-02-13T19:33:21.781484000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781571 containerd[1366]: time="2025-02-13T19:33:21.781524960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781571 containerd[1366]: time="2025-02-13T19:33:21.781539040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781571 containerd[1366]: time="2025-02-13T19:33:21.781551960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781571 containerd[1366]: time="2025-02-13T19:33:21.781568440Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Feb 13 19:33:21.781654 containerd[1366]: time="2025-02-13T19:33:21.781589560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781654 containerd[1366]: time="2025-02-13T19:33:21.781602040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781654 containerd[1366]: time="2025-02-13T19:33:21.781614040Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Feb 13 19:33:21.781833 containerd[1366]: time="2025-02-13T19:33:21.781819360Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Feb 13 19:33:21.781874 containerd[1366]: time="2025-02-13T19:33:21.781840760Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Feb 13 19:33:21.781874 containerd[1366]: time="2025-02-13T19:33:21.781852720Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Feb 13 19:33:21.781874 containerd[1366]: time="2025-02-13T19:33:21.781865680Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Feb 13 19:33:21.781958 containerd[1366]: time="2025-02-13T19:33:21.781875680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.781958 containerd[1366]: time="2025-02-13T19:33:21.781889000Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Feb 13 19:33:21.781958 containerd[1366]: time="2025-02-13T19:33:21.781909360Z" level=info msg="NRI interface is disabled by configuration." Feb 13 19:33:21.781958 containerd[1366]: time="2025-02-13T19:33:21.781926800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Feb 13 19:33:21.782661 containerd[1366]: time="2025-02-13T19:33:21.782586280Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Feb 13 19:33:21.783237 containerd[1366]: time="2025-02-13T19:33:21.783148880Z" level=info msg="Connect containerd service" Feb 13 19:33:21.783405 containerd[1366]: time="2025-02-13T19:33:21.783332240Z" level=info msg="using legacy CRI server" Feb 13 19:33:21.783451 containerd[1366]: time="2025-02-13T19:33:21.783438520Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Feb 13 19:33:21.783632 containerd[1366]: time="2025-02-13T19:33:21.783615000Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Feb 13 19:33:21.784411 containerd[1366]: time="2025-02-13T19:33:21.784374600Z" 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" Feb 13 19:33:21.784826 containerd[1366]: time="2025-02-13T19:33:21.784644200Z" level=info msg="Start subscribing containerd event" Feb 13 19:33:21.784826 containerd[1366]: time="2025-02-13T19:33:21.784710640Z" level=info msg="Start recovering state" Feb 13 19:33:21.784826 containerd[1366]: time="2025-02-13T19:33:21.784797600Z" level=info msg="Start event monitor" Feb 13 19:33:21.784826 containerd[1366]: time="2025-02-13T19:33:21.784811960Z" level=info msg="Start snapshots syncer" Feb 13 19:33:21.784826 containerd[1366]: time="2025-02-13T19:33:21.784822600Z" level=info msg="Start cni network conf syncer for default" Feb 13 19:33:21.784943 containerd[1366]: time="2025-02-13T19:33:21.784834960Z" level=info msg="Start streaming server" Feb 13 19:33:21.785188 containerd[1366]: time="2025-02-13T19:33:21.785167600Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Feb 13 19:33:21.785296 containerd[1366]: time="2025-02-13T19:33:21.785283840Z" level=info msg=serving... address=/run/containerd/containerd.sock Feb 13 19:33:21.785463 containerd[1366]: time="2025-02-13T19:33:21.785440560Z" level=info msg="containerd successfully booted in 0.037459s" Feb 13 19:33:21.785536 systemd[1]: Started containerd.service - containerd container runtime. Feb 13 19:33:21.918489 sshd_keygen[1361]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Feb 13 19:33:21.937309 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Feb 13 19:33:21.947052 systemd[1]: Starting issuegen.service - Generate /run/issue... Feb 13 19:33:21.952270 systemd[1]: issuegen.service: Deactivated successfully. Feb 13 19:33:21.952438 systemd[1]: Finished issuegen.service - Generate /run/issue. Feb 13 19:33:21.954994 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Feb 13 19:33:21.968319 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Feb 13 19:33:21.971093 systemd[1]: Started getty@tty1.service - Getty on tty1. Feb 13 19:33:21.973236 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Feb 13 19:33:21.974707 systemd[1]: Reached target getty.target - Login Prompts. Feb 13 19:33:22.669904 systemd-networkd[1308]: eth0: Gained IPv6LL Feb 13 19:33:22.672502 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Feb 13 19:33:22.674233 systemd[1]: Reached target network-online.target - Network is Online. Feb 13 19:33:22.686025 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Feb 13 19:33:22.688072 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Feb 13 19:33:22.702503 systemd[1]: coreos-metadata.service: Deactivated successfully. Feb 13 19:33:22.702721 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Feb 13 19:33:22.705545 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Feb 13 19:33:22.706877 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Feb 13 19:33:22.708885 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Feb 13 19:33:22.709441 (-wrapper)[1440]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Feb 13 19:33:22.839017 systemd[1]: Starting docker.service - Docker Application Container Engine... Feb 13 19:33:22.839110 (dockerd)[1453]: 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 Feb 13 19:33:23.130889 dockerd[1453]: time="2025-02-13T19:33:23.130754760Z" level=info msg="Starting up" Feb 13 19:33:23.238873 dockerd[1453]: time="2025-02-13T19:33:23.238558280Z" level=info msg="Loading containers: start." Feb 13 19:33:23.324807 kernel: Initializing XFRM netlink socket Feb 13 19:33:23.404400 systemd-networkd[1308]: docker0: Link UP Feb 13 19:33:23.422208 dockerd[1453]: time="2025-02-13T19:33:23.422164680Z" level=info msg="Loading containers: done." Feb 13 19:33:23.436065 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck582997749-merged.mount: Deactivated successfully. Feb 13 19:33:23.436277 dockerd[1453]: time="2025-02-13T19:33:23.436177960Z" 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 Feb 13 19:33:23.436318 dockerd[1453]: time="2025-02-13T19:33:23.436295440Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Feb 13 19:33:23.436426 dockerd[1453]: time="2025-02-13T19:33:23.436400280Z" level=info msg="Daemon has completed initialization" Feb 13 19:33:23.467297 systemd[1]: Started docker.service - Docker Application Container Engine. Feb 13 19:33:23.467711 dockerd[1453]: time="2025-02-13T19:33:23.467072520Z" level=info msg="API listen on /run/docker.sock" Feb 13 19:33:23.469466 etcd-wrapper[1446]: Error response from daemon: No such container: etcd-member Feb 13 19:33:23.481045 etcd-wrapper[1581]: Error response from daemon: No such container: etcd-member Feb 13 19:33:23.517976 etcd-wrapper[1598]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally Feb 13 19:33:24.397961 etcd-wrapper[1598]: v3.5.0: Pulling from coreos/etcd Feb 13 19:33:24.688792 etcd-wrapper[1598]: 6022c6b01d76: Pulling fs layer Feb 13 19:33:24.688792 etcd-wrapper[1598]: 1d97b1ec77fc: Pulling fs layer Feb 13 19:33:24.688792 etcd-wrapper[1598]: 99ef4b690837: Pulling fs layer Feb 13 19:33:24.688792 etcd-wrapper[1598]: 435b7bf0967c: Pulling fs layer Feb 13 19:33:24.688792 etcd-wrapper[1598]: 17e4a5f7c1b5: Pulling fs layer Feb 13 19:33:24.688792 etcd-wrapper[1598]: 5b0292999756: Pulling fs layer Feb 13 19:33:24.688792 etcd-wrapper[1598]: 435b7bf0967c: Waiting Feb 13 19:33:24.688792 etcd-wrapper[1598]: 17e4a5f7c1b5: Waiting Feb 13 19:33:24.893030 etcd-wrapper[1598]: 99ef4b690837: Verifying Checksum Feb 13 19:33:24.893030 etcd-wrapper[1598]: 99ef4b690837: Download complete Feb 13 19:33:24.909468 etcd-wrapper[1598]: 1d97b1ec77fc: Verifying Checksum Feb 13 19:33:24.909468 etcd-wrapper[1598]: 1d97b1ec77fc: Download complete Feb 13 19:33:25.189335 etcd-wrapper[1598]: 17e4a5f7c1b5: Verifying Checksum Feb 13 19:33:25.189335 etcd-wrapper[1598]: 17e4a5f7c1b5: Download complete Feb 13 19:33:25.270368 etcd-wrapper[1598]: 6022c6b01d76: Verifying Checksum Feb 13 19:33:25.270368 etcd-wrapper[1598]: 6022c6b01d76: Download complete Feb 13 19:33:25.316216 etcd-wrapper[1598]: 435b7bf0967c: Verifying Checksum Feb 13 19:33:25.316216 etcd-wrapper[1598]: 435b7bf0967c: Download complete Feb 13 19:33:25.856387 etcd-wrapper[1598]: 6022c6b01d76: Pull complete Feb 13 19:33:25.961029 systemd[1]: var-lib-docker-overlay2-e28ffd0a1ec195fd6d9d3cbf5ce755fc34e6f4ba60cd7cc86845330244c3aa5f-merged.mount: Deactivated successfully. Feb 13 19:33:26.141304 etcd-wrapper[1598]: 1d97b1ec77fc: Pull complete Feb 13 19:33:26.237743 systemd[1]: var-lib-docker-overlay2-f88d22159fc3de75bccf4ef242ee6fa4a5e52e946ab5145c640f231a8f0e299c-merged.mount: Deactivated successfully. Feb 13 19:33:26.281166 etcd-wrapper[1598]: 99ef4b690837: Pull complete Feb 13 19:33:26.405499 etcd-wrapper[1598]: 435b7bf0967c: Pull complete Feb 13 19:33:26.434913 etcd-wrapper[1598]: 17e4a5f7c1b5: Pull complete Feb 13 19:33:26.638160 etcd-wrapper[1598]: 5b0292999756: Verifying Checksum Feb 13 19:33:26.638160 etcd-wrapper[1598]: 5b0292999756: Download complete Feb 13 19:33:26.654908 etcd-wrapper[1598]: 5b0292999756: Pull complete Feb 13 19:33:26.661161 etcd-wrapper[1598]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b Feb 13 19:33:26.663363 etcd-wrapper[1598]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 Feb 13 19:33:26.769872 containerd[1366]: time="2025-02-13T19:33:26.769711720Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 19:33:26.770316 containerd[1366]: time="2025-02-13T19:33:26.769838160Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 19:33:26.770316 containerd[1366]: time="2025-02-13T19:33:26.769850120Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:26.770316 containerd[1366]: time="2025-02-13T19:33:26.769962680Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:26.795931 systemd[1]: Started docker-57de5345ca163fce5acba2c060caae64ba5a47ef4f62024951c1c50c479017ea.scope - libcontainer container 57de5345ca163fce5acba2c060caae64ba5a47ef4f62024951c1c50c479017ea. Feb 13 19:33:26.809270 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"info","ts":1739475206.8496268,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"info","ts":1739475206.849702,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"97221e27ce974a7fad457640cc37b177"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"warn","ts":1739475206.8497262,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"warn","ts":1739475206.8497336,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"warn","ts":1739475206.8497438,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"warn","ts":1739475206.8497484,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"warn","ts":1739475206.8497536,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Feb 13 19:33:26.849928 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.849Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.46:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.46:2380","--advertise-client-urls=http://10.0.0.46:2379","--discovery=http://10.0.0.1:46753/v2/keys/discovery/1792836702936377202","--enable-v2=true"]} Feb 13 19:33:26.850409 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.849Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.46:2380"]} Feb 13 19:33:26.850409 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.850Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Feb 13 19:33:26.850409 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.850Z","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":"97221e27ce974a7fad457640cc37b177","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.46:2380"],"listen-peer-urls":["http://10.0.0.46:2380"],"advertise-client-urls":["http://10.0.0.46:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"97221e27ce974a7fad457640cc37b177=http://10.0.0.46:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:46753/v2/keys/discovery/1792836702936377202","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:46753/v2/keys/discovery/1792836702936377202","discovery-proxy":"","downgrade-check-interval":"5s"} Feb 13 19:33:26.852093 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.851Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.36572ms"} Feb 13 19:33:26.856827 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.856Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:46753","peer":"cec4c8faee0908bb"} Feb 13 19:33:26.856827 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.856Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:46753","peer":"24d0f364312dcedf"} Feb 13 19:33:26.856827 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.856Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:46753","self":"de6b0fb8dce1f7a4"} Feb 13 19:33:26.856827 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.856Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:46753","found-peers":3} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.859Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"de6b0fb8dce1f7a4","cluster-id":"1a0447348e4a957b"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=()"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became follower at term 0"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft de6b0fb8dce1f7a4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became follower at term 1"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975)"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059)"} Feb 13 19:33:26.860393 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.860Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059 16026920985582237604)"} Feb 13 19:33:26.861681 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:26.861Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Feb 13 19:33:26.862746 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.862Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Feb 13 19:33:26.863355 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.863Z","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"} Feb 13 19:33:26.864297 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.864Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.864297 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.864Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.865764 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.865Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.866692 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.866Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.866692 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.866Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.866692 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.866Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf","remote-peer-urls":["http://10.0.0.47:2380"]} Feb 13 19:33:26.866692 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.866Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.866692 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.866Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.868219 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.867Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.868219 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.867Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.868219 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.867Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.869014 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.868Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.869014 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.868Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.869014 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.868Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb","remote-peer-urls":["http://10.0.0.45:2380"]} Feb 13 19:33:26.869137 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.868Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"de6b0fb8dce1f7a4","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Feb 13 19:33:26.869137 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.868Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.869239 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.868Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.869326 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Feb 13 19:33:26.870112 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059 16026920985582237604)"} Feb 13 19:33:26.870112 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","added-peer-id":"24d0f364312dcedf","added-peer-peer-urls":["http://10.0.0.47:2380"]} Feb 13 19:33:26.870112 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059 16026920985582237604)"} Feb 13 19:33:26.870112 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","added-peer-id":"cec4c8faee0908bb","added-peer-peer-urls":["http://10.0.0.45:2380"]} Feb 13 19:33:26.870112 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059 16026920985582237604)"} Feb 13 19:33:26.870112 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.869Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","added-peer-id":"de6b0fb8dce1f7a4","added-peer-peer-urls":["http://10.0.0.46:2380"]} Feb 13 19:33:26.871363 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:26.871Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Feb 13 19:33:26.871683 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.46:2380"} Feb 13 19:33:26.871683 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.46:2380"} Feb 13 19:33:26.871812 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"cec4c8faee0908bb","stream-type":"stream Message"} Feb 13 19:33:26.871812 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.871812 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"cec4c8faee0908bb","stream-type":"stream MsgApp v2"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.871Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"24d0f364312dcedf","stream-type":"stream Message"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"de6b0fb8dce1f7a4","initial-advertise-peer-urls":["http://10.0.0.46:2380"],"listen-peer-urls":["http://10.0.0.46:2380"],"advertise-client-urls":["http://10.0.0.46:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"24d0f364312dcedf","stream-type":"stream MsgApp v2"} Feb 13 19:33:26.872334 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.872962 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.873083 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.872Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:26.873363 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.873Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.873363 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.873Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:26.881416 systemd[1]: var-lib-docker-overlay2-da64256a5a68d7cde6ed2412cce5494f608b730bcec3de7f6ec330b55f81ff32-merged.mount: Deactivated successfully. Feb 13 19:33:26.919647 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:26.919Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"de6b0fb8dce1f7a4","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Feb 13 19:33:27.462621 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 24d0f364312dcedf [logterm: 1, index: 3] at term 1"} Feb 13 19:33:27.463494 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [term: 1] received a MsgVote message with higher term from 24d0f364312dcedf [term: 2]"} Feb 13 19:33:27.463494 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became follower at term 2"} Feb 13 19:33:27.463494 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 1, index: 3, vote: 0] cast MsgVote for 24d0f364312dcedf [logterm: 1, index: 3] at term 2"} Feb 13 19:33:27.464309 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de6b0fb8dce1f7a4 elected leader 24d0f364312dcedf at term 2"} Feb 13 19:33:27.466872 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.466Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"de6b0fb8dce1f7a4","local-member-attributes":"{Name:97221e27ce974a7fad457640cc37b177 ClientURLs:[http://10.0.0.46:2379]}","request-path":"/0/members/de6b0fb8dce1f7a4/attributes","cluster-id":"1a0447348e4a957b","publish-timeout":"7s"} Feb 13 19:33:27.467036 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.466Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Feb 13 19:33:27.467374 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.467Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Feb 13 19:33:27.467374 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.467Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Feb 13 19:33:27.467368 systemd[1]: Started etcd-member.service - etcd (System Application Container). Feb 13 19:33:27.468043 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.467Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Feb 13 19:33:27.474783 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.474Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","cluster-version":"3.5"} Feb 13 19:33:27.474987 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:27.474Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Feb 13 19:33:27.475988 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Feb 13 19:33:27.577160 etcdctl[1697]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Feb 13 19:33:27.609085 flannel-wrapper[1708]: Error response from daemon: No such container: flannel Feb 13 19:33:27.620078 flannel-wrapper[1714]: Error response from daemon: No such container: flannel Feb 13 19:33:27.633817 flannel-wrapper[1729]: Unable to find image 'quay.io/coreos/flannel:v0.14.0-arm64' locally Feb 13 19:33:28.563495 flannel-wrapper[1729]: v0.14.0-arm64: Pulling from coreos/flannel Feb 13 19:33:28.563495 flannel-wrapper[1729]: b538f80385f9: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: 782376d11ccb: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: ab023a03e512: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: 1ce603871d35: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: 2ff40439b6d5: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: f6c30695e556: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: 071b96dd834b: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: e9e292d9edba: Pulling fs layer Feb 13 19:33:28.563495 flannel-wrapper[1729]: 1ce603871d35: Waiting Feb 13 19:33:28.563495 flannel-wrapper[1729]: 2ff40439b6d5: Waiting Feb 13 19:33:28.563495 flannel-wrapper[1729]: f6c30695e556: Waiting Feb 13 19:33:28.564082 flannel-wrapper[1729]: 071b96dd834b: Waiting Feb 13 19:33:28.564082 flannel-wrapper[1729]: e9e292d9edba: Waiting Feb 13 19:33:28.698487 flannel-wrapper[1729]: 782376d11ccb: Verifying Checksum Feb 13 19:33:28.698487 flannel-wrapper[1729]: 782376d11ccb: Download complete Feb 13 19:33:28.715515 flannel-wrapper[1729]: b538f80385f9: Verifying Checksum Feb 13 19:33:28.715515 flannel-wrapper[1729]: b538f80385f9: Download complete Feb 13 19:33:28.716543 flannel-wrapper[1729]: ab023a03e512: Verifying Checksum Feb 13 19:33:28.716543 flannel-wrapper[1729]: ab023a03e512: Download complete Feb 13 19:33:28.804260 flannel-wrapper[1729]: b538f80385f9: Pull complete Feb 13 19:33:28.832151 systemd[1]: var-lib-docker-overlay2-0036010ad321a81f9ae7a190a4548b0bb21b65d5fdc472ece2f203a0d4f9ad1b-merged.mount: Deactivated successfully. Feb 13 19:33:28.844329 flannel-wrapper[1729]: 1ce603871d35: Verifying Checksum Feb 13 19:33:28.844329 flannel-wrapper[1729]: 1ce603871d35: Download complete Feb 13 19:33:28.865029 flannel-wrapper[1729]: 782376d11ccb: Pull complete Feb 13 19:33:28.900351 flannel-wrapper[1729]: f6c30695e556: Verifying Checksum Feb 13 19:33:28.900351 flannel-wrapper[1729]: f6c30695e556: Download complete Feb 13 19:33:28.921738 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Feb 13 19:33:28.922885 systemd[1]: Started sshd@0-10.0.0.46:22-10.0.0.1:38930.service - OpenSSH per-connection server daemon (10.0.0.1:38930). Feb 13 19:33:28.975545 sshd[1754]: Accepted publickey for core from 10.0.0.1 port 38930 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:28.977381 sshd[1754]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:28.985739 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Feb 13 19:33:28.991012 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Feb 13 19:33:28.992837 systemd-logind[1360]: New session 1 of user core. Feb 13 19:33:29.002151 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Feb 13 19:33:29.018181 systemd[1]: Starting user@500.service - User Manager for UID 500... Feb 13 19:33:29.022801 (systemd)[1758]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Feb 13 19:33:29.096495 systemd[1]: var-lib-docker-overlay2-f26799178b41daa67b893d41a8ebeb2e331aa0039e7828946550add02b7db38a-merged.mount: Deactivated successfully. Feb 13 19:33:29.118119 systemd[1758]: Queued start job for default target default.target. Feb 13 19:33:29.132132 flannel-wrapper[1729]: ab023a03e512: Pull complete Feb 13 19:33:29.135288 systemd[1758]: Created slice app.slice - User Application Slice. Feb 13 19:33:29.135317 systemd[1758]: Reached target paths.target - Paths. Feb 13 19:33:29.135329 systemd[1758]: Reached target timers.target - Timers. Feb 13 19:33:29.136829 systemd[1758]: Starting dbus.socket - D-Bus User Message Bus Socket... Feb 13 19:33:29.148157 systemd[1758]: Listening on dbus.socket - D-Bus User Message Bus Socket. Feb 13 19:33:29.148360 systemd[1758]: Reached target sockets.target - Sockets. Feb 13 19:33:29.148374 systemd[1758]: Reached target basic.target - Basic System. Feb 13 19:33:29.148407 systemd[1758]: Reached target default.target - Main User Target. Feb 13 19:33:29.148431 systemd[1758]: Startup finished in 119ms. Feb 13 19:33:29.148687 systemd[1]: Started user@500.service - User Manager for UID 500. Feb 13 19:33:29.150611 systemd[1]: Started session-1.scope - Session 1 of User core. Feb 13 19:33:29.182939 flannel-wrapper[1729]: 071b96dd834b: Verifying Checksum Feb 13 19:33:29.182939 flannel-wrapper[1729]: 071b96dd834b: Download complete Feb 13 19:33:29.210370 systemd[1]: Started sshd@1-10.0.0.46:22-10.0.0.1:38946.service - OpenSSH per-connection server daemon (10.0.0.1:38946). Feb 13 19:33:29.211953 flannel-wrapper[1729]: 1ce603871d35: Pull complete Feb 13 19:33:29.244657 sshd[1774]: Accepted publickey for core from 10.0.0.1 port 38946 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:29.246047 sshd[1774]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:29.250718 systemd-logind[1360]: New session 2 of user core. Feb 13 19:33:29.257952 systemd[1]: Started session-2.scope - Session 2 of User core. Feb 13 19:33:29.266958 flannel-wrapper[1729]: e9e292d9edba: Verifying Checksum Feb 13 19:33:29.266958 flannel-wrapper[1729]: e9e292d9edba: Download complete Feb 13 19:33:29.307897 flannel-wrapper[1729]: 2ff40439b6d5: Verifying Checksum Feb 13 19:33:29.307897 flannel-wrapper[1729]: 2ff40439b6d5: Download complete Feb 13 19:33:29.323599 sshd[1774]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:29.333287 systemd[1]: sshd@1-10.0.0.46:22-10.0.0.1:38946.service: Deactivated successfully. Feb 13 19:33:29.335719 systemd[1]: session-2.scope: Deactivated successfully. Feb 13 19:33:29.337616 systemd-logind[1360]: Session 2 logged out. Waiting for processes to exit. Feb 13 19:33:29.350147 systemd[1]: Started sshd@2-10.0.0.46:22-10.0.0.1:38950.service - OpenSSH per-connection server daemon (10.0.0.1:38950). Feb 13 19:33:29.351211 systemd-logind[1360]: Removed session 2. Feb 13 19:33:29.382918 sshd[1786]: Accepted publickey for core from 10.0.0.1 port 38950 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:29.384297 sshd[1786]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:29.388815 systemd-logind[1360]: New session 3 of user core. Feb 13 19:33:29.394939 systemd[1]: Started session-3.scope - Session 3 of User core. Feb 13 19:33:29.448367 sshd[1786]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:29.452091 systemd[1]: session-3.scope: Deactivated successfully. Feb 13 19:33:29.453030 systemd[1]: sshd@2-10.0.0.46:22-10.0.0.1:38950.service: Deactivated successfully. Feb 13 19:33:29.458436 systemd-logind[1360]: Session 3 logged out. Waiting for processes to exit. Feb 13 19:33:29.459393 systemd-logind[1360]: Removed session 3. Feb 13 19:33:29.593255 flannel-wrapper[1729]: 2ff40439b6d5: Pull complete Feb 13 19:33:29.612039 flannel-wrapper[1729]: f6c30695e556: Pull complete Feb 13 19:33:29.627226 flannel-wrapper[1729]: 071b96dd834b: Pull complete Feb 13 19:33:29.642799 flannel-wrapper[1729]: e9e292d9edba: Pull complete Feb 13 19:33:29.651118 flannel-wrapper[1729]: Digest: sha256:dad4e92d4eb00d129a664ac7b44a71a5cbadea8a7f11b5b239e1e2b2701baac6 Feb 13 19:33:29.652979 flannel-wrapper[1729]: Status: Downloaded newer image for quay.io/coreos/flannel:v0.14.0-arm64 Feb 13 19:33:29.699149 containerd[1366]: time="2025-02-13T19:33:29.699076840Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 19:33:29.699149 containerd[1366]: time="2025-02-13T19:33:29.699121840Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 19:33:29.699149 containerd[1366]: time="2025-02-13T19:33:29.699132720Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:29.699555 containerd[1366]: time="2025-02-13T19:33:29.699203960Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:29.718938 systemd[1]: Started docker-677cf897d98dc94b512340a568d7eb5146701873488661afbd8c8349f4b4cced.scope - libcontainer container 677cf897d98dc94b512340a568d7eb5146701873488661afbd8c8349f4b4cced. Feb 13 19:33:29.729304 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 13 19:33:29.804357 flannel-wrapper[1729]: I0213 19:33:29.804084 1 main.go:520] Determining IP address of default interface Feb 13 19:33:29.804831 flannel-wrapper[1729]: I0213 19:33:29.804366 1 main.go:533] Using interface with name eth0 and address 10.0.0.46 Feb 13 19:33:29.804831 flannel-wrapper[1729]: I0213 19:33:29.804381 1 main.go:550] Defaulting external address to interface address (10.0.0.46) Feb 13 19:33:29.804932 flannel-wrapper[1729]: I0213 19:33:29.804580 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: None Feb 13 19:33:29.804932 flannel-wrapper[1729]: I0213 19:33:29.804587 1 main.go:257] Installing signal handlers Feb 13 19:33:29.807217 flannel-wrapper[1729]: I0213 19:33:29.807034 1 main.go:392] Found network config - Backend type: vxlan Feb 13 19:33:29.807217 flannel-wrapper[1729]: I0213 19:33:29.807078 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Feb 13 19:33:29.823230 flannel-wrapper[1729]: I0213 19:33:29.822867 1 local_manager.go:234] Picking subnet in range 10.254.1.0 ... 10.254.255.0 Feb 13 19:33:29.826047 flannel-wrapper[1729]: I0213 19:33:29.825880 1 local_manager.go:220] Allocated lease (10.254.35.0/24) to current node (10.0.0.46) Feb 13 19:33:29.826511 flannel-wrapper[1729]: I0213 19:33:29.826227 1 main.go:357] Current network or subnet (10.254.0.0/16, 10.254.35.0/24) is not equal to previous one (0.0.0.0/0, 0.0.0.0/0), trying to recycle old iptables rules Feb 13 19:33:29.826735 systemd-networkd[1308]: flannel.1: Link UP Feb 13 19:33:29.826741 systemd-networkd[1308]: flannel.1: Gained carrier Feb 13 19:33:29.843231 flannel-wrapper[1729]: I0213 19:33:29.843056 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Feb 13 19:33:29.843967 flannel-wrapper[1729]: I0213 19:33:29.843850 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Feb 13 19:33:29.844869 flannel-wrapper[1729]: I0213 19:33:29.844659 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN Feb 13 19:33:29.845627 flannel-wrapper[1729]: I0213 19:33:29.845507 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j MASQUERADE --random-fully Feb 13 19:33:29.846580 flannel-wrapper[1729]: I0213 19:33:29.846477 1 main.go:307] Setting up masking rules Feb 13 19:33:29.847481 flannel-wrapper[1729]: I0213 19:33:29.847369 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Feb 13 19:33:29.848076 flannel-wrapper[1729]: I0213 19:33:29.847561 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Feb 13 19:33:29.848076 flannel-wrapper[1729]: I0213 19:33:29.847569 1 main.go:327] Running backend. Feb 13 19:33:29.848076 flannel-wrapper[1729]: I0213 19:33:29.847669 1 vxlan_network.go:59] watching for new subnet leases Feb 13 19:33:29.848701 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Feb 13 19:33:29.849166 systemd[1]: Reached target multi-user.target - Multi-User System. Feb 13 19:33:29.850765 flannel-wrapper[1729]: I0213 19:33:29.849430 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Feb 13 19:33:29.850765 flannel-wrapper[1729]: I0213 19:33:29.849441 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -j ACCEPT Feb 13 19:33:29.850765 flannel-wrapper[1729]: I0213 19:33:29.850174 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules Feb 13 19:33:29.850765 flannel-wrapper[1729]: I0213 19:33:29.850210 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Feb 13 19:33:29.851546 flannel-wrapper[1729]: I0213 19:33:29.851081 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Feb 13 19:33:29.851546 flannel-wrapper[1729]: I0213 19:33:29.851201 1 main.go:439] Waiting for 22h59m59.971897s to renew lease Feb 13 19:33:29.852849 flannel-wrapper[1729]: I0213 19:33:29.852424 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.35.0/24 -j RETURN Feb 13 19:33:29.853059 flannel-wrapper[1729]: I0213 19:33:29.852739 1 iptables.go:172] Deleting iptables rule: -d 10.254.0.0/16 -j ACCEPT Feb 13 19:33:29.854842 flannel-wrapper[1729]: I0213 19:33:29.854026 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Feb 13 19:33:29.855081 flannel-wrapper[1729]: I0213 19:33:29.854950 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -j ACCEPT Feb 13 19:33:29.855248 flannel-wrapper[1729]: I0213 19:33:29.855048 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN Feb 13 19:33:29.856469 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Feb 13 19:33:29.857166 flannel-wrapper[1729]: I0213 19:33:29.857008 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully Feb 13 19:33:29.858082 flannel-wrapper[1729]: I0213 19:33:29.857913 1 iptables.go:160] Adding iptables rule: -d 10.254.0.0/16 -j ACCEPT Feb 13 19:33:29.859064 sh[1894]: + for try in 1 2 3 4 5 6 Feb 13 19:33:29.859064 sh[1894]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Feb 13 19:33:29.860367 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:29.859Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb","error":"EOF"} Feb 13 19:33:29.860367 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:29.859Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb","error":"EOF"} Feb 13 19:33:29.861486 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:29.861Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"cec4c8faee0908bb","error":"failed to dial cec4c8faee0908bb on stream MsgApp v2 (peer cec4c8faee0908bb failed to find local node de6b0fb8dce1f7a4)"} Feb 13 19:33:29.861828 flannel-wrapper[1729]: I0213 19:33:29.861086 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.35.0/24 -j RETURN Feb 13 19:33:29.864331 flannel-wrapper[1729]: I0213 19:33:29.864010 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully Feb 13 19:33:29.873721 sh[1911]: Error response from daemon: No such container: flannel-docker-opts Feb 13 19:33:29.884011 sh[1920]: Error response from daemon: No such container: flannel-docker-opts Feb 13 19:33:29.948739 containerd[1366]: time="2025-02-13T19:33:29.948612560Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 19:33:29.948739 containerd[1366]: time="2025-02-13T19:33:29.948687880Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 19:33:29.948739 containerd[1366]: time="2025-02-13T19:33:29.948706400Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:29.949029 containerd[1366]: time="2025-02-13T19:33:29.948852080Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:29.962969 systemd[1]: Started docker-3c33582b1ff0dc379d2dddd44edac3aaa30b3a835d7c9d0ad614306beb4d8f62.scope - libcontainer container 3c33582b1ff0dc379d2dddd44edac3aaa30b3a835d7c9d0ad614306beb4d8f62. Feb 13 19:33:29.973756 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 13 19:33:29.991522 systemd[1]: docker-3c33582b1ff0dc379d2dddd44edac3aaa30b3a835d7c9d0ad614306beb4d8f62.scope: Deactivated successfully. Feb 13 19:33:30.003261 containerd[1366]: time="2025-02-13T19:33:30.003015120Z" level=info msg="shim disconnected" id=3c33582b1ff0dc379d2dddd44edac3aaa30b3a835d7c9d0ad614306beb4d8f62 namespace=moby Feb 13 19:33:30.003261 containerd[1366]: time="2025-02-13T19:33:30.003080800Z" level=warning msg="cleaning up after shim disconnected" id=3c33582b1ff0dc379d2dddd44edac3aaa30b3a835d7c9d0ad614306beb4d8f62 namespace=moby Feb 13 19:33:30.003261 containerd[1366]: time="2025-02-13T19:33:30.003090720Z" level=info msg="cleaning up dead shim" namespace=moby Feb 13 19:33:30.003420 dockerd[1453]: time="2025-02-13T19:33:30.003210560Z" level=info msg="ignoring event" container=3c33582b1ff0dc379d2dddd44edac3aaa30b3a835d7c9d0ad614306beb4d8f62 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [term 2] received MsgTimeoutNow from 24d0f364312dcedf and starts an election to get leadership."} Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 is starting a new election at term 2"} Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became candidate at term 3"} Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 received MsgVoteResp from de6b0fb8dce1f7a4 at term 3"} Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 2, index: 30] sent MsgVote request to 24d0f364312dcedf at term 3"} Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 2, index: 30] sent MsgVote request to cec4c8faee0908bb at term 3"} Feb 13 19:33:30.028711 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de6b0fb8dce1f7a4 lost leader 24d0f364312dcedf at term 3"} Feb 13 19:33:30.030797 dockerd[1453]: time="2025-02-13T19:33:30.030735000Z" level=info msg="Processing signal 'terminated'" Feb 13 19:33:30.030796 systemd[1]: Stopping docker.service - Docker Application Container Engine... Feb 13 19:33:30.031532 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 received MsgVoteResp from 24d0f364312dcedf at term 3"} Feb 13 19:33:30.031532 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 has received 2 MsgVoteResp votes and 0 vote rejections"} Feb 13 19:33:30.031532 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became leader at term 3"} Feb 13 19:33:30.031532 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de6b0fb8dce1f7a4 elected leader de6b0fb8dce1f7a4 at term 3"} Feb 13 19:33:30.033712 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.033Z","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://10.0.0.45:2380/version","remote-member-id":"cec4c8faee0908bb","error":"Get \"http://10.0.0.45:2380/version\": dial tcp 10.0.0.45:2380: connect: connection refused"} Feb 13 19:33:30.033835 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.033Z","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"cec4c8faee0908bb","error":"Get \"http://10.0.0.45:2380/version\": dial tcp 10.0.0.45:2380: connect: connection refused"} Feb 13 19:33:30.037377 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.037Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} Feb 13 19:33:30.037377 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.037Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"97221e27ce974a7fad457640cc37b177","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.46:2380"],"advertise-client-urls":["http://10.0.0.46:2379"]} Feb 13 19:33:30.037696 flannel-wrapper[1729]: I0213 19:33:30.037262 1 main.go:376] shutdownHandler sent cancel signal... Feb 13 19:33:30.037696 flannel-wrapper[1729]: I0213 19:33:30.037317 1 watch.go:174] context canceled, close receiver chan Feb 13 19:33:30.037696 flannel-wrapper[1729]: I0213 19:33:30.037333 1 main.go:432] Stopped monitoring lease Feb 13 19:33:30.037696 flannel-wrapper[1729]: I0213 19:33:30.037340 1 main.go:345] Waiting for all goroutines to exit Feb 13 19:33:30.037696 flannel-wrapper[1729]: I0213 19:33:30.037318 1 watch.go:40] context canceled, close receiver chan Feb 13 19:33:30.037696 flannel-wrapper[1729]: I0213 19:33:30.037356 1 vxlan_network.go:74] evts chan closed Feb 13 19:33:30.038028 etcd-wrapper[1598]: WARNING: 2025/02/13 19:33:30 [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... Feb 13 19:33:30.038382 flannel-wrapper[1729]: I0213 19:33:30.037812 1 main.go:348] Exiting cleanly... Feb 13 19:33:30.039380 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.038Z","caller":"etcdserver/server.go:1398","msg":"leadership transfer starting","local-member-id":"de6b0fb8dce1f7a4","current-leader-member-id":"de6b0fb8dce1f7a4","transferee-member-id":"24d0f364312dcedf"} Feb 13 19:33:30.039380 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [term 3] starts to transfer leadership to 24d0f364312dcedf"} Feb 13 19:33:30.039380 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 sends MsgTimeoutNow to 24d0f364312dcedf immediately as 24d0f364312dcedf already has up-to-date log"} Feb 13 19:33:30.039567 systemd[1]: docker-677cf897d98dc94b512340a568d7eb5146701873488661afbd8c8349f4b4cced.scope: Deactivated successfully. Feb 13 19:33:30.040752 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.040Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [term: 3] received a MsgVote message with higher term from 24d0f364312dcedf [term: 4]"} Feb 13 19:33:30.040752 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.040Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became follower at term 4"} Feb 13 19:33:30.040752 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.040Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 3, index: 32, vote: 0] cast MsgVote for 24d0f364312dcedf [logterm: 3, index: 32] at term 4"} Feb 13 19:33:30.040752 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.040Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de6b0fb8dce1f7a4 lost leader de6b0fb8dce1f7a4 at term 4"} Feb 13 19:33:30.041548 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de6b0fb8dce1f7a4 elected leader 24d0f364312dcedf at term 4"} Feb 13 19:33:30.050558 containerd[1366]: time="2025-02-13T19:33:30.050443120Z" level=info msg="shim disconnected" id=677cf897d98dc94b512340a568d7eb5146701873488661afbd8c8349f4b4cced namespace=moby Feb 13 19:33:30.050558 containerd[1366]: time="2025-02-13T19:33:30.050503280Z" level=warning msg="cleaning up after shim disconnected" id=677cf897d98dc94b512340a568d7eb5146701873488661afbd8c8349f4b4cced namespace=moby Feb 13 19:33:30.050558 containerd[1366]: time="2025-02-13T19:33:30.050514400Z" level=info msg="cleaning up dead shim" namespace=moby Feb 13 19:33:30.050913 dockerd[1453]: time="2025-02-13T19:33:30.050807600Z" level=info msg="ignoring event" container=677cf897d98dc94b512340a568d7eb5146701873488661afbd8c8349f4b4cced module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Feb 13 19:33:30.139756 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.139Z","caller":"etcdserver/server.go:1415","msg":"leadership transfer finished","local-member-id":"de6b0fb8dce1f7a4","old-leader-member-id":"de6b0fb8dce1f7a4","new-leader-member-id":"24d0f364312dcedf","took":"100.54156ms"} Feb 13 19:33:30.139756 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.139756 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.139756 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf","error":"context canceled"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"24d0f364312dcedf","error":"failed to read 24d0f364312dcedf on stream MsgApp v2 (context canceled)"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.139Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf","error":"context canceled"} Feb 13 19:33:30.141637 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.141985 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:30.142217 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id-stream-handler":"de6b0fb8dce1f7a4","remote-peer-id-from":"24d0f364312dcedf","cluster-id":"1a0447348e4a957b"} Feb 13 19:33:30.142217 etcd-wrapper[1598]: {"level":"warn","ts":"2025-02-13T19:33:30.140Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id-stream-handler":"de6b0fb8dce1f7a4","remote-peer-id-from":"24d0f364312dcedf","cluster-id":"1a0447348e4a957b"} Feb 13 19:33:30.142217 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:30.141Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"10.0.0.46:2380"} Feb 13 19:33:30.812009 systemd[1]: var-lib-docker-overlay2-887e3787b8c0d861bb29ce1d55ef13d244871028027e5e5f85919833eebb6339-merged.mount: Deactivated successfully. Feb 13 19:33:30.812108 systemd[1]: var-lib-docker-overlay2-6bcb7753b08d01aaeb259553c26633404ee878671c8dd9a8bf359f7f78bdece1-merged.mount: Deactivated successfully. Feb 13 19:33:31.142979 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:31.142Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"10.0.0.46:2380"} Feb 13 19:33:31.142979 etcd-wrapper[1598]: {"level":"info","ts":"2025-02-13T19:33:31.142Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"97221e27ce974a7fad457640cc37b177","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.46:2380"],"advertise-client-urls":["http://10.0.0.46:2379"]} Feb 13 19:33:31.144095 systemd[1]: docker-57de5345ca163fce5acba2c060caae64ba5a47ef4f62024951c1c50c479017ea.scope: Deactivated successfully. Feb 13 19:33:31.154391 dockerd[1453]: time="2025-02-13T19:33:31.154347840Z" level=info msg="ignoring event" container=57de5345ca163fce5acba2c060caae64ba5a47ef4f62024951c1c50c479017ea module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Feb 13 19:33:31.154750 containerd[1366]: time="2025-02-13T19:33:31.154509800Z" level=info msg="shim disconnected" id=57de5345ca163fce5acba2c060caae64ba5a47ef4f62024951c1c50c479017ea namespace=moby Feb 13 19:33:31.154750 containerd[1366]: time="2025-02-13T19:33:31.154544840Z" level=warning msg="cleaning up after shim disconnected" id=57de5345ca163fce5acba2c060caae64ba5a47ef4f62024951c1c50c479017ea namespace=moby Feb 13 19:33:31.154750 containerd[1366]: time="2025-02-13T19:33:31.154554800Z" level=info msg="cleaning up dead shim" namespace=moby Feb 13 19:33:31.163373 containerd[1366]: time="2025-02-13T19:33:31.163312360Z" level=warning msg="cleanup warnings time=\"2025-02-13T19:33:31Z\" level=warning msg=\"failed to remove runc container\" error=\"runc did not terminate successfully: exit status 255: \" runtime=io.containerd.runc.v2\n" namespace=moby Feb 13 19:33:31.169601 systemd[1]: var-lib-docker-overlay2-8558ac1d8b1a4582ee4ccd173e6c674509f31fac8c241527ce58b4704c052192-merged.mount: Deactivated successfully. Feb 13 19:33:31.182327 dockerd[1453]: time="2025-02-13T19:33:31.182282160Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Feb 13 19:33:31.182701 dockerd[1453]: time="2025-02-13T19:33:31.182659400Z" level=info msg="Daemon shutdown complete" Feb 13 19:33:31.501952 systemd-networkd[1308]: flannel.1: Gained IPv6LL Feb 13 19:33:31.604017 systemd[1]: docker.service: Deactivated successfully. Feb 13 19:33:31.604318 systemd[1]: Stopped docker.service - Docker Application Container Engine. Feb 13 19:33:31.604373 systemd[1]: docker.service: Consumed 3.245s CPU time. Feb 13 19:33:31.606382 systemd[1]: docker.socket: Deactivated successfully. Feb 13 19:33:31.606763 systemd[1]: Closed docker.socket - Docker Socket for the API. Feb 13 19:33:31.606922 systemd[1]: Stopping docker.socket - Docker Socket for the API... Feb 13 19:33:31.607641 docker[2073]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? Feb 13 19:33:31.608596 systemd[1]: Starting docker.socket - Docker Socket for the API... Feb 13 19:33:31.614981 systemd[1]: etcd-member.service: Control process exited, code=exited, status=1/FAILURE Feb 13 19:33:31.615993 systemd[1]: Listening on docker.socket - Docker Socket for the API. Feb 13 19:33:31.618734 systemd[1]: Starting docker.service - Docker Application Container Engine... Feb 13 19:33:31.621990 (dockerd)[2084]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS Feb 13 19:33:31.658236 dockerd[2084]: time="2025-02-13T19:33:31.658182640Z" level=info msg="Starting up" Feb 13 19:33:31.679975 dockerd[2084]: time="2025-02-13T19:33:31.679928520Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Feb 13 19:33:31.687299 dockerd[2084]: time="2025-02-13T19:33:31.687252360Z" level=info msg="Loading containers: start." Feb 13 19:33:32.002071 dockerd[2084]: time="2025-02-13T19:33:32.001931600Z" level=info msg="Loading containers: done." Feb 13 19:33:32.010378 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1908424440-merged.mount: Deactivated successfully. Feb 13 19:33:32.011291 dockerd[2084]: time="2025-02-13T19:33:32.011243720Z" 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 Feb 13 19:33:32.011372 dockerd[2084]: time="2025-02-13T19:33:32.011337440Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Feb 13 19:33:32.011405 dockerd[2084]: time="2025-02-13T19:33:32.011378800Z" level=info msg="Daemon has completed initialization" Feb 13 19:33:32.027857 dockerd[2084]: time="2025-02-13T19:33:32.027745840Z" level=info msg="API listen on /run/docker.sock" Feb 13 19:33:32.027938 systemd[1]: Started docker.service - Docker Application Container Engine. Feb 13 19:33:32.029432 sh[1906]: Restarted Docker to apply Flannel options Feb 13 19:33:32.029696 sh[1894]: + break Feb 13 19:33:32.029696 sh[1894]: + '[' 1 '!=' fail ']' Feb 13 19:33:32.030501 docker[2045]: flannel Feb 13 19:33:32.031633 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Feb 13 19:33:32.033382 docker[2082]: etcd-member Feb 13 19:33:32.035849 systemd[1]: Startup finished in 578ms (kernel) + 3.672s (initrd) + 12.186s (userspace) = 16.437s. Feb 13 19:33:32.042152 systemd[1]: etcd-member.service: Failed with result 'exit-code'. Feb 13 19:33:32.060791 docker[2238]: flannel Feb 13 19:33:32.062085 systemd[1]: flanneld.service: Deactivated successfully. Feb 13 19:33:39.465066 systemd[1]: Started sshd@3-10.0.0.46:22-10.0.0.1:46396.service - OpenSSH per-connection server daemon (10.0.0.1:46396). Feb 13 19:33:39.498547 sshd[2248]: Accepted publickey for core from 10.0.0.1 port 46396 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:39.499744 sshd[2248]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:39.503437 systemd-logind[1360]: New session 4 of user core. Feb 13 19:33:39.512924 systemd[1]: Started session-4.scope - Session 4 of User core. Feb 13 19:33:39.563940 sshd[2248]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:39.571994 systemd[1]: sshd@3-10.0.0.46:22-10.0.0.1:46396.service: Deactivated successfully. Feb 13 19:33:39.573957 systemd[1]: session-4.scope: Deactivated successfully. Feb 13 19:33:39.575481 systemd-logind[1360]: Session 4 logged out. Waiting for processes to exit. Feb 13 19:33:39.576802 systemd[1]: Started sshd@4-10.0.0.46:22-10.0.0.1:46406.service - OpenSSH per-connection server daemon (10.0.0.1:46406). Feb 13 19:33:39.577798 systemd-logind[1360]: Removed session 4. Feb 13 19:33:39.610399 sshd[2255]: Accepted publickey for core from 10.0.0.1 port 46406 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:39.611578 sshd[2255]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:39.615067 systemd-logind[1360]: New session 5 of user core. Feb 13 19:33:39.627908 systemd[1]: Started session-5.scope - Session 5 of User core. Feb 13 19:33:39.675260 sshd[2255]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:39.684128 systemd[1]: sshd@4-10.0.0.46:22-10.0.0.1:46406.service: Deactivated successfully. Feb 13 19:33:39.685500 systemd[1]: session-5.scope: Deactivated successfully. Feb 13 19:33:39.686687 systemd-logind[1360]: Session 5 logged out. Waiting for processes to exit. Feb 13 19:33:39.687751 systemd[1]: Started sshd@5-10.0.0.46:22-10.0.0.1:46422.service - OpenSSH per-connection server daemon (10.0.0.1:46422). Feb 13 19:33:39.688445 systemd-logind[1360]: Removed session 5. Feb 13 19:33:39.722925 sshd[2262]: Accepted publickey for core from 10.0.0.1 port 46422 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:39.724224 sshd[2262]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:39.727893 systemd-logind[1360]: New session 6 of user core. Feb 13 19:33:39.735913 systemd[1]: Started session-6.scope - Session 6 of User core. Feb 13 19:33:39.786894 sshd[2262]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:39.801144 systemd[1]: sshd@5-10.0.0.46:22-10.0.0.1:46422.service: Deactivated successfully. Feb 13 19:33:39.802573 systemd[1]: session-6.scope: Deactivated successfully. Feb 13 19:33:39.803732 systemd-logind[1360]: Session 6 logged out. Waiting for processes to exit. Feb 13 19:33:39.804957 systemd[1]: Started sshd@6-10.0.0.46:22-10.0.0.1:46430.service - OpenSSH per-connection server daemon (10.0.0.1:46430). Feb 13 19:33:39.805600 systemd-logind[1360]: Removed session 6. Feb 13 19:33:39.838344 sshd[2269]: Accepted publickey for core from 10.0.0.1 port 46430 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:39.839556 sshd[2269]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:39.842993 systemd-logind[1360]: New session 7 of user core. Feb 13 19:33:39.853910 systemd[1]: Started session-7.scope - Session 7 of User core. Feb 13 19:33:39.948938 sudo[2272]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Feb 13 19:33:39.949227 sudo[2272]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Feb 13 19:33:39.974636 sudo[2272]: pam_unix(sudo:session): session closed for user root Feb 13 19:33:39.976242 sshd[2269]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:39.988200 systemd[1]: sshd@6-10.0.0.46:22-10.0.0.1:46430.service: Deactivated successfully. Feb 13 19:33:39.989616 systemd[1]: session-7.scope: Deactivated successfully. Feb 13 19:33:39.990900 systemd-logind[1360]: Session 7 logged out. Waiting for processes to exit. Feb 13 19:33:39.992131 systemd[1]: Started sshd@7-10.0.0.46:22-10.0.0.1:46432.service - OpenSSH per-connection server daemon (10.0.0.1:46432). Feb 13 19:33:39.993825 systemd-logind[1360]: Removed session 7. Feb 13 19:33:40.027025 sshd[2277]: Accepted publickey for core from 10.0.0.1 port 46432 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:40.028294 sshd[2277]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:40.032220 systemd-logind[1360]: New session 8 of user core. Feb 13 19:33:40.039935 systemd[1]: Started session-8.scope - Session 8 of User core. Feb 13 19:33:40.091150 sudo[2281]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Feb 13 19:33:40.091433 sudo[2281]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Feb 13 19:33:40.094439 sudo[2281]: pam_unix(sudo:session): session closed for user root Feb 13 19:33:40.098904 sudo[2280]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Feb 13 19:33:40.099165 sudo[2280]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Feb 13 19:33:40.115071 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Feb 13 19:33:40.116073 auditctl[2284]: No rules Feb 13 19:33:40.116906 systemd[1]: audit-rules.service: Deactivated successfully. Feb 13 19:33:40.117118 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Feb 13 19:33:40.118666 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Feb 13 19:33:40.140971 augenrules[2302]: No rules Feb 13 19:33:40.141712 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Feb 13 19:33:40.142908 sudo[2280]: pam_unix(sudo:session): session closed for user root Feb 13 19:33:40.144318 sshd[2277]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:40.147086 systemd[1]: sshd@7-10.0.0.46:22-10.0.0.1:46432.service: Deactivated successfully. Feb 13 19:33:40.149260 systemd[1]: session-8.scope: Deactivated successfully. Feb 13 19:33:40.149786 systemd-logind[1360]: Session 8 logged out. Waiting for processes to exit. Feb 13 19:33:40.150694 systemd-logind[1360]: Removed session 8. Feb 13 19:33:40.250093 systemd[1]: Started sshd@8-10.0.0.46:22-10.0.0.1:46444.service - OpenSSH per-connection server daemon (10.0.0.1:46444). Feb 13 19:33:40.284166 sshd[2310]: Accepted publickey for core from 10.0.0.1 port 46444 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:40.285266 sshd[2310]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:40.288910 systemd-logind[1360]: New session 9 of user core. Feb 13 19:33:40.307982 systemd[1]: Started session-9.scope - Session 9 of User core. Feb 13 19:33:42.292612 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. Feb 13 19:33:42.293554 systemd[1]: flanneld.service: Scheduled restart job, restart counter is at 1. Feb 13 19:33:42.307080 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Feb 13 19:33:42.308098 systemd[1]: Stopping flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Feb 13 19:33:42.321616 systemd[1]: coreos-metadata.service: Deactivated successfully. Feb 13 19:33:42.321841 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Feb 13 19:33:42.322239 docker[2321]: flannel-docker-opts Feb 13 19:33:42.342061 docker[2333]: flannel-docker-opts Feb 13 19:33:42.343925 systemd[1]: flannel-docker-opts.service: Deactivated successfully. Feb 13 19:33:42.344845 systemd[1]: Stopped flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Feb 13 19:33:42.345251 systemd[1]: Stopped flanneld.service - flannel - Network fabric for containers (System Application Container). Feb 13 19:33:42.358988 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Feb 13 19:33:42.359176 (-wrapper)[2340]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Feb 13 19:33:42.374528 etcd-wrapper[2344]: Error response from daemon: No such container: etcd-member Feb 13 19:33:42.385178 etcd-wrapper[2350]: Error response from daemon: No such container: etcd-member Feb 13 19:33:42.407791 systemd[1]: var-lib-docker-overlay2-c6f18f246fbd5d4d84618713c383f52f4ddc8500e451968e5edbb7d42d4d95e3\x2dinit-merged.mount: Deactivated successfully. Feb 13 19:33:42.460481 containerd[1366]: time="2025-02-13T19:33:42.460369840Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 19:33:42.460481 containerd[1366]: time="2025-02-13T19:33:42.460432400Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 19:33:42.460481 containerd[1366]: time="2025-02-13T19:33:42.460449320Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:42.460891 containerd[1366]: time="2025-02-13T19:33:42.460522680Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:42.477993 systemd[1]: Started docker-a205f15f8ab12468a9d8bff3c68b9d519e31e5f3cd901a64085b71a8ccc1c88b.scope - libcontainer container a205f15f8ab12468a9d8bff3c68b9d519e31e5f3cd901a64085b71a8ccc1c88b. Feb 13 19:33:42.487206 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"info","ts":1739475222.5117586,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"info","ts":1739475222.5118456,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"97221e27ce974a7fad457640cc37b177"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"warn","ts":1739475222.5118685,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"warn","ts":1739475222.511877,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"warn","ts":1739475222.5118833,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"warn","ts":1739475222.5118873,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"warn","ts":1739475222.5118926,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.511Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.46:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.46:2380","--advertise-client-urls=http://10.0.0.46:2379","--discovery=http://10.0.0.1:46753/v2/keys/discovery/1792836702936377202","--enable-v2=true"]} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.512Z","caller":"etcdmain/etcd.go:115","msg":"server has been already initialized","data-dir":"/var/lib/etcd","dir-type":"member"} Feb 13 19:33:42.512808 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.512Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.46:2380"]} Feb 13 19:33:42.513325 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.512Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Feb 13 19:33:42.513325 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.512Z","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":"97221e27ce974a7fad457640cc37b177","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.46:2380"],"listen-peer-urls":["http://10.0.0.46:2380"],"advertise-client-urls":["http://10.0.0.46: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:46753/v2/keys/discovery/1792836702936377202","discovery-proxy":"","downgrade-check-interval":"5s"} Feb 13 19:33:42.513325 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.512Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"135.84µs"} Feb 13 19:33:42.513325 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:42.512Z","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"} Feb 13 19:33:42.513720 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.513Z","caller":"etcdserver/server.go:526","msg":"No snapshot found. Recovering WAL from scratch!"} Feb 13 19:33:42.514407 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","caller":"etcdserver/raft.go:483","msg":"restarting local member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","commit-index":33} Feb 13 19:33:42.514407 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=()"} Feb 13 19:33:42.514407 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became follower at term 4"} Feb 13 19:33:42.514407 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft de6b0fb8dce1f7a4 [peers: [], term: 4, commit: 33, applied: 0, lastindex: 33, lastterm: 4]"} Feb 13 19:33:42.514571 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Feb 13 19:33:42.514571 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","recovered-remote-peer-id":"24d0f364312dcedf","recovered-remote-peer-urls":["http://10.0.0.47:2380"]} Feb 13 19:33:42.515077 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","recovered-remote-peer-id":"cec4c8faee0908bb","recovered-remote-peer-urls":["http://10.0.0.45:2380"]} Feb 13 19:33:42.515077 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","recovered-remote-peer-id":"de6b0fb8dce1f7a4","recovered-remote-peer-urls":["http://10.0.0.46:2380"]} Feb 13 19:33:42.515077 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.514Z","caller":"membership/cluster.go:285","msg":"set cluster version from store","cluster-version":"3.5"} Feb 13 19:33:42.515679 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:42.515Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Feb 13 19:33:42.516609 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.516Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Feb 13 19:33:42.517099 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.516Z","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"} Feb 13 19:33:42.517529 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.517Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.517529 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.517Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.518649 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf","remote-peer-urls":["http://10.0.0.47:2380"]} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.518Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.519295 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.519Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:42.519988 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.519Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.519988 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.519Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.520183 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.519Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.520183 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.520Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb","remote-peer-urls":["http://10.0.0.45:2380"]} Feb 13 19:33:42.520506 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.520Z","caller":"etcdserver/server.go:834","msg":"starting etcd server","local-member-id":"de6b0fb8dce1f7a4","local-server-version":"3.5.0","cluster-id":"1a0447348e4a957b","cluster-version":"3.5"} Feb 13 19:33:42.520506 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.520Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.520978 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.520Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.521188 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.520Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Feb 13 19:33:42.521379 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975)"} Feb 13 19:33:42.521379 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","added-peer-id":"24d0f364312dcedf","added-peer-peer-urls":["http://10.0.0.47:2380"]} Feb 13 19:33:42.521379 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059)"} Feb 13 19:33:42.521379 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","added-peer-id":"cec4c8faee0908bb","added-peer-peer-urls":["http://10.0.0.45:2380"]} Feb 13 19:33:42.522133 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 switched to configuration voters=(2652887792168586975 14899254447309392059 16026920985582237604)"} Feb 13 19:33:42.522133 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","added-peer-id":"de6b0fb8dce1f7a4","added-peer-peer-urls":["http://10.0.0.46:2380"]} Feb 13 19:33:42.522133 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","caller":"membership/cluster.go:523","msg":"updated cluster version","cluster-id":"1a0447348e4a957b","local-member-id":"de6b0fb8dce1f7a4","from":"3.5","to":"3.5"} Feb 13 19:33:42.522133 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.522133 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.521Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.523798 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.522Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.523866 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:42.523Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} Feb 13 19:33:42.523866 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.523Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.46:2380"} Feb 13 19:33:42.523936 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.523Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.46:2380"} Feb 13 19:33:42.523936 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.523Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"de6b0fb8dce1f7a4","initial-advertise-peer-urls":["http://10.0.0.46:2380"],"listen-peer-urls":["http://10.0.0.46:2380"],"advertise-client-urls":["http://10.0.0.46:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Feb 13 19:33:42.550252 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.549Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"cec4c8faee0908bb","stream-type":"stream Message"} Feb 13 19:33:42.550252 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.549Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:42.550252 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.550Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"cec4c8faee0908bb","stream-type":"stream MsgApp v2"} Feb 13 19:33:42.550252 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:42.550Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"cec4c8faee0908bb"} Feb 13 19:33:43.741824 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:43.741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 4, index: 33, vote: 24d0f364312dcedf] rejected MsgPreVote from cec4c8faee0908bb [logterm: 2, index: 29] at term 4"} Feb 13 19:33:44.415581 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 is starting a new election at term 4"} Feb 13 19:33:44.415581 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became pre-candidate at term 4"} Feb 13 19:33:44.415581 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 received MsgPreVoteResp from de6b0fb8dce1f7a4 at term 4"} Feb 13 19:33:44.415581 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 4, index: 33] sent MsgPreVote request to 24d0f364312dcedf at term 4"} Feb 13 19:33:44.415581 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 4, index: 33] sent MsgPreVote request to cec4c8faee0908bb at term 4"} Feb 13 19:33:44.416269 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 received MsgPreVoteResp from cec4c8faee0908bb at term 4"} Feb 13 19:33:44.416269 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 has received 2 MsgPreVoteResp votes and 0 vote rejections"} Feb 13 19:33:44.416269 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became candidate at term 5"} Feb 13 19:33:44.416269 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 received MsgVoteResp from de6b0fb8dce1f7a4 at term 5"} Feb 13 19:33:44.416269 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 4, index: 33] sent MsgVote request to 24d0f364312dcedf at term 5"} Feb 13 19:33:44.416269 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 [logterm: 4, index: 33] sent MsgVote request to cec4c8faee0908bb at term 5"} Feb 13 19:33:44.419118 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 received MsgVoteResp from cec4c8faee0908bb at term 5"} Feb 13 19:33:44.419118 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 has received 2 MsgVoteResp votes and 0 vote rejections"} Feb 13 19:33:44.419118 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de6b0fb8dce1f7a4 became leader at term 5"} Feb 13 19:33:44.419326 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de6b0fb8dce1f7a4 elected leader de6b0fb8dce1f7a4 at term 5"} Feb 13 19:33:44.420571 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.420Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"de6b0fb8dce1f7a4","local-member-attributes":"{Name:97221e27ce974a7fad457640cc37b177 ClientURLs:[http://10.0.0.46:2379]}","request-path":"/0/members/de6b0fb8dce1f7a4/attributes","cluster-id":"1a0447348e4a957b","publish-timeout":"7s"} Feb 13 19:33:44.420760 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.420Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Feb 13 19:33:44.421734 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.421Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Feb 13 19:33:44.421734 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:44.421Z","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://10.0.0.47:2380/version","remote-member-id":"24d0f364312dcedf","error":"Get \"http://10.0.0.47:2380/version\": dial tcp 10.0.0.47:2380: connect: connection refused"} Feb 13 19:33:44.421734 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:44.421Z","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"24d0f364312dcedf","error":"Get \"http://10.0.0.47:2380/version\": dial tcp 10.0.0.47:2380: connect: connection refused"} Feb 13 19:33:44.422108 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.421Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Feb 13 19:33:44.422108 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:44.421Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Feb 13 19:33:44.422565 systemd[1]: Started etcd-member.service - etcd (System Application Container). Feb 13 19:33:44.437173 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... Feb 13 19:33:44.463049 etcdctl[2425]: { "Network": "10.254.0.0/16", "Backend": {"Type": "vxlan"} } Feb 13 19:33:44.488623 flannel-wrapper[2436]: Error response from daemon: No such container: flannel Feb 13 19:33:44.500254 flannel-wrapper[2443]: Error response from daemon: No such container: flannel Feb 13 19:33:44.579069 containerd[1366]: time="2025-02-13T19:33:44.578976680Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 19:33:44.579069 containerd[1366]: time="2025-02-13T19:33:44.579025240Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 19:33:44.579069 containerd[1366]: time="2025-02-13T19:33:44.579036240Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:44.579846 containerd[1366]: time="2025-02-13T19:33:44.579109840Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:44.603948 systemd[1]: Started docker-08c035fd3cce55d746f2c89d1a42020e13b68055fd23ac964b61048a2d6eff9f.scope - libcontainer container 08c035fd3cce55d746f2c89d1a42020e13b68055fd23ac964b61048a2d6eff9f. Feb 13 19:33:44.615139 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 13 19:33:44.645663 flannel-wrapper[2458]: I0213 19:33:44.645140 1 main.go:520] Determining IP address of default interface Feb 13 19:33:44.646207 flannel-wrapper[2458]: I0213 19:33:44.645562 1 main.go:533] Using interface with name eth0 and address 10.0.0.46 Feb 13 19:33:44.646207 flannel-wrapper[2458]: I0213 19:33:44.645579 1 main.go:550] Defaulting external address to interface address (10.0.0.46) Feb 13 19:33:44.646501 flannel-wrapper[2458]: I0213 19:33:44.645681 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: 10.254.35.0/24 Feb 13 19:33:44.646501 flannel-wrapper[2458]: I0213 19:33:44.645688 1 main.go:257] Installing signal handlers Feb 13 19:33:44.647804 flannel-wrapper[2458]: I0213 19:33:44.647680 1 main.go:392] Found network config - Backend type: vxlan Feb 13 19:33:44.648000 flannel-wrapper[2458]: I0213 19:33:44.647921 1 vxlan.go:123] VXLAN config: VNI=1 Port=0 GBP=false Learning=false DirectRouting=false Feb 13 19:33:44.650624 flannel-wrapper[2458]: I0213 19:33:44.650390 1 local_manager.go:147] Found lease (10.254.35.0/24) for current IP (10.0.0.46), reusing Feb 13 19:33:44.653609 flannel-wrapper[2458]: I0213 19:33:44.653486 1 main.go:307] Setting up masking rules Feb 13 19:33:44.664765 flannel-wrapper[2458]: I0213 19:33:44.664412 1 main.go:315] Changing default FORWARD chain policy to ACCEPT Feb 13 19:33:44.664765 flannel-wrapper[2458]: I0213 19:33:44.664570 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env Feb 13 19:33:44.664765 flannel-wrapper[2458]: I0213 19:33:44.664580 1 main.go:327] Running backend. Feb 13 19:33:44.664983 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). Feb 13 19:33:44.666669 flannel-wrapper[2458]: I0213 19:33:44.664895 1 vxlan_network.go:59] watching for new subnet leases Feb 13 19:33:44.672788 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... Feb 13 19:33:44.674370 flannel-wrapper[2458]: I0213 19:33:44.674013 1 main.go:439] Waiting for 22h59m59.97657604s to renew lease Feb 13 19:33:44.674646 sh[2539]: + for try in 1 2 3 4 5 6 Feb 13 19:33:44.675008 sh[2539]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i Feb 13 19:33:44.688625 sh[2552]: Error response from daemon: No such container: flannel-docker-opts Feb 13 19:33:44.699134 sh[2559]: Error response from daemon: No such container: flannel-docker-opts Feb 13 19:33:44.757242 containerd[1366]: time="2025-02-13T19:33:44.757147240Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 19:33:44.757242 containerd[1366]: time="2025-02-13T19:33:44.757203880Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 19:33:44.757242 containerd[1366]: time="2025-02-13T19:33:44.757220560Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:44.757669 containerd[1366]: time="2025-02-13T19:33:44.757299880Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 19:33:44.781969 systemd[1]: Started docker-df205e574703a0d86d36c8094e9a6e89b745d49ec1b8416164c718a1f2f6151b.scope - libcontainer container df205e574703a0d86d36c8094e9a6e89b745d49ec1b8416164c718a1f2f6151b. Feb 13 19:33:44.792446 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 13 19:33:44.806341 systemd[1]: docker-df205e574703a0d86d36c8094e9a6e89b745d49ec1b8416164c718a1f2f6151b.scope: Deactivated successfully. Feb 13 19:33:44.818821 containerd[1366]: time="2025-02-13T19:33:44.818748960Z" level=info msg="shim disconnected" id=df205e574703a0d86d36c8094e9a6e89b745d49ec1b8416164c718a1f2f6151b namespace=moby Feb 13 19:33:44.819361 dockerd[2084]: time="2025-02-13T19:33:44.819096760Z" level=info msg="ignoring event" container=df205e574703a0d86d36c8094e9a6e89b745d49ec1b8416164c718a1f2f6151b module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Feb 13 19:33:44.819633 containerd[1366]: time="2025-02-13T19:33:44.819245440Z" level=warning msg="cleaning up after shim disconnected" id=df205e574703a0d86d36c8094e9a6e89b745d49ec1b8416164c718a1f2f6151b namespace=moby Feb 13 19:33:44.819633 containerd[1366]: time="2025-02-13T19:33:44.819260480Z" level=info msg="cleaning up dead shim" namespace=moby Feb 13 19:33:44.841509 sh[2539]: + break Feb 13 19:33:44.841509 sh[2539]: + '[' 1 '!=' fail ']' Feb 13 19:33:44.842299 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). Feb 13 19:33:45.521188 systemd[1]: var-lib-docker-overlay2-76cba083fd8a0711ec5b03768e2a8e955ef77e05fadf2cfdf8664239d36866c0\x2dinit-merged.mount: Deactivated successfully. Feb 13 19:33:47.520350 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:47.520Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"24d0f364312dcedf","rtt":"0s","error":"dial tcp 10.0.0.47:2380: connect: connection refused"} Feb 13 19:33:47.520350 etcd-wrapper[2367]: {"level":"warn","ts":"2025-02-13T19:33:47.520Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"24d0f364312dcedf","rtt":"0s","error":"dial tcp 10.0.0.47:2380: connect: connection refused"} Feb 13 19:33:48.289077 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.288Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"24d0f364312dcedf","stream-type":"stream Message"} Feb 13 19:33:48.289077 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.288Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"24d0f364312dcedf"} Feb 13 19:33:48.289077 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.288Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:48.289757 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.289Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"de6b0fb8dce1f7a4","to":"24d0f364312dcedf","stream-type":"stream MsgApp v2"} Feb 13 19:33:48.289757 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.289Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:48.321690 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.321Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:48.321690 etcd-wrapper[2367]: {"level":"info","ts":"2025-02-13T19:33:48.321Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"de6b0fb8dce1f7a4","remote-peer-id":"24d0f364312dcedf"} Feb 13 19:33:49.436493 sshd[2310]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:49.439056 systemd[1]: sshd@8-10.0.0.46:22-10.0.0.1:46444.service: Deactivated successfully. Feb 13 19:33:49.440467 systemd[1]: session-9.scope: Deactivated successfully. Feb 13 19:33:49.441724 systemd-logind[1360]: Session 9 logged out. Waiting for processes to exit. Feb 13 19:33:49.442442 systemd-logind[1360]: Removed session 9. Feb 13 19:33:59.447082 systemd[1]: Started sshd@9-10.0.0.46:22-10.0.0.1:54778.service - OpenSSH per-connection server daemon (10.0.0.1:54778). Feb 13 19:33:59.480598 sshd[2666]: Accepted publickey for core from 10.0.0.1 port 54778 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:59.481800 sshd[2666]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:59.485234 systemd-logind[1360]: New session 10 of user core. Feb 13 19:33:59.498935 systemd[1]: Started session-10.scope - Session 10 of User core. Feb 13 19:33:59.568039 sshd[2666]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:59.579145 systemd[1]: sshd@9-10.0.0.46:22-10.0.0.1:54778.service: Deactivated successfully. Feb 13 19:33:59.581184 systemd[1]: session-10.scope: Deactivated successfully. Feb 13 19:33:59.583929 systemd-logind[1360]: Session 10 logged out. Waiting for processes to exit. Feb 13 19:33:59.600025 systemd[1]: Started sshd@10-10.0.0.46:22-10.0.0.1:54794.service - OpenSSH per-connection server daemon (10.0.0.1:54794). Feb 13 19:33:59.601202 systemd-logind[1360]: Removed session 10. Feb 13 19:33:59.630386 sshd[2679]: Accepted publickey for core from 10.0.0.1 port 54794 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:59.631623 sshd[2679]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:59.635151 systemd-logind[1360]: New session 11 of user core. Feb 13 19:33:59.644903 systemd[1]: Started session-11.scope - Session 11 of User core. Feb 13 19:33:59.700742 sshd[2679]: pam_unix(sshd:session): session closed for user core Feb 13 19:33:59.704155 systemd[1]: sshd@10-10.0.0.46:22-10.0.0.1:54794.service: Deactivated successfully. Feb 13 19:33:59.705669 systemd[1]: session-11.scope: Deactivated successfully. Feb 13 19:33:59.706192 systemd-logind[1360]: Session 11 logged out. Waiting for processes to exit. Feb 13 19:33:59.706894 systemd-logind[1360]: Removed session 11. Feb 13 19:33:59.834163 systemd[1]: Started sshd@11-10.0.0.46:22-10.0.0.1:54798.service - OpenSSH per-connection server daemon (10.0.0.1:54798). Feb 13 19:33:59.867838 sshd[2695]: Accepted publickey for core from 10.0.0.1 port 54798 ssh2: RSA SHA256:JGaeIbjf5IUSNUg1jnjkSVnSyX1OvNbTOClTMYH5eIk Feb 13 19:33:59.869013 sshd[2695]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 19:33:59.872836 systemd-logind[1360]: New session 12 of user core. Feb 13 19:33:59.880919 systemd[1]: Started session-12.scope - Session 12 of User core. Feb 13 19:34:06.605710 update_engine[1363]: I20250213 19:34:06.605612 1363 update_attempter.cc:509] Updating boot flags... Feb 13 19:34:06.626795 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2712) Feb 13 19:34:06.651958 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2716) Feb 13 19:34:06.675835 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2716) Feb 13 19:34:09.134923 sshd[2695]: pam_unix(sshd:session): session closed for user core Feb 13 19:34:09.138308 systemd[1]: sshd@11-10.0.0.46:22-10.0.0.1:54798.service: Deactivated successfully. Feb 13 19:34:09.139970 systemd[1]: session-12.scope: Deactivated successfully. Feb 13 19:34:09.140511 systemd-logind[1360]: Session 12 logged out. Waiting for processes to exit. Feb 13 19:34:09.141397 systemd-logind[1360]: Removed session 12.