May 16 05:37:23.086204 kernel: Linux version 6.6.90-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.43 p3) 2.43.1) #1 SMP PREEMPT_DYNAMIC Thu May 15 22:16:42 -00 2025 May 16 05:37:23.086278 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=ffa0077ec5e89092631d817251b58c64c9261c447bd6e8bcef43c52d5e74873e May 16 05:37:23.086288 kernel: BIOS-provided physical RAM map: May 16 05:37:23.086296 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable May 16 05:37:23.086304 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved May 16 05:37:23.086314 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved May 16 05:37:23.086323 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable May 16 05:37:23.086330 kernel: BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved May 16 05:37:23.086338 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 16 05:37:23.086345 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved May 16 05:37:23.086353 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable May 16 05:37:23.086361 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 16 05:37:23.086368 kernel: NX (Execute Disable) protection: active May 16 05:37:23.086376 kernel: APIC: Static calls initialized May 16 05:37:23.086387 kernel: SMBIOS 3.0.0 present. May 16 05:37:23.086396 kernel: DMI: OpenStack Foundation OpenStack Nova, BIOS 1.16.3-debian-1.16.3-2 04/01/2014 May 16 05:37:23.086404 kernel: Hypervisor detected: KVM May 16 05:37:23.086412 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 May 16 05:37:23.086431 kernel: kvm-clock: using sched offset of 3980637790 cycles May 16 05:37:23.086453 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns May 16 05:37:23.086462 kernel: tsc: Detected 1996.249 MHz processor May 16 05:37:23.086471 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 16 05:37:23.086480 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 16 05:37:23.086488 kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000 May 16 05:37:23.086496 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs May 16 05:37:23.086505 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 16 05:37:23.086513 kernel: last_pfn = 0xbffdd max_arch_pfn = 0x400000000 May 16 05:37:23.086522 kernel: ACPI: Early table checksum verification disabled May 16 05:37:23.086532 kernel: ACPI: RSDP 0x00000000000F51E0 000014 (v00 BOCHS ) May 16 05:37:23.086541 kernel: ACPI: RSDT 0x00000000BFFE1B65 000030 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 16 05:37:23.086549 kernel: ACPI: FACP 0x00000000BFFE1A49 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 16 05:37:23.086558 kernel: ACPI: DSDT 0x00000000BFFE0040 001A09 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 16 05:37:23.086566 kernel: ACPI: FACS 0x00000000BFFE0000 000040 May 16 05:37:23.086574 kernel: ACPI: APIC 0x00000000BFFE1ABD 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 16 05:37:23.086583 kernel: ACPI: WAET 0x00000000BFFE1B3D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 16 05:37:23.086591 kernel: ACPI: Reserving FACP table memory at [mem 0xbffe1a49-0xbffe1abc] May 16 05:37:23.086599 kernel: ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a48] May 16 05:37:23.086609 kernel: ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] May 16 05:37:23.086618 kernel: ACPI: Reserving APIC table memory at [mem 0xbffe1abd-0xbffe1b3c] May 16 05:37:23.086626 kernel: ACPI: Reserving WAET table memory at [mem 0xbffe1b3d-0xbffe1b64] May 16 05:37:23.086638 kernel: No NUMA configuration found May 16 05:37:23.086646 kernel: Faking a node at [mem 0x0000000000000000-0x000000013fffffff] May 16 05:37:23.086655 kernel: NODE_DATA(0) allocated [mem 0x13fff7000-0x13fffcfff] May 16 05:37:23.086665 kernel: Zone ranges: May 16 05:37:23.086674 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 16 05:37:23.086683 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] May 16 05:37:23.086692 kernel: Normal [mem 0x0000000100000000-0x000000013fffffff] May 16 05:37:23.086700 kernel: Movable zone start for each node May 16 05:37:23.086709 kernel: Early memory node ranges May 16 05:37:23.086717 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] May 16 05:37:23.086726 kernel: node 0: [mem 0x0000000000100000-0x00000000bffdcfff] May 16 05:37:23.086737 kernel: node 0: [mem 0x0000000100000000-0x000000013fffffff] May 16 05:37:23.086745 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] May 16 05:37:23.086754 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 16 05:37:23.086762 kernel: On node 0, zone DMA: 97 pages in unavailable ranges May 16 05:37:23.086771 kernel: On node 0, zone Normal: 35 pages in unavailable ranges May 16 05:37:23.086780 kernel: ACPI: PM-Timer IO Port: 0x608 May 16 05:37:23.086788 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) May 16 05:37:23.086797 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 16 05:37:23.086805 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) May 16 05:37:23.086816 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) May 16 05:37:23.086825 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 16 05:37:23.086833 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) May 16 05:37:23.086842 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) May 16 05:37:23.086850 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 16 05:37:23.086879 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs May 16 05:37:23.086889 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() May 16 05:37:23.086898 kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices May 16 05:37:23.086906 kernel: Booting paravirtualized kernel on KVM May 16 05:37:23.086918 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 16 05:37:23.086926 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 May 16 05:37:23.086935 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u1048576 May 16 05:37:23.086944 kernel: pcpu-alloc: s197032 r8192 d32344 u1048576 alloc=1*2097152 May 16 05:37:23.086952 kernel: pcpu-alloc: [0] 0 1 May 16 05:37:23.086961 kernel: kvm-guest: PV spinlocks disabled, no host support May 16 05:37:23.086971 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=ffa0077ec5e89092631d817251b58c64c9261c447bd6e8bcef43c52d5e74873e May 16 05:37:23.086981 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 16 05:37:23.086991 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 16 05:37:23.087000 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 16 05:37:23.087009 kernel: Fallback order for Node 0: 0 May 16 05:37:23.087017 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1031901 May 16 05:37:23.087028 kernel: Policy zone: Normal May 16 05:37:23.087037 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 16 05:37:23.087046 kernel: software IO TLB: area num 2. May 16 05:37:23.087056 kernel: Memory: 3964156K/4193772K available (14336K kernel code, 2295K rwdata, 22864K rodata, 43484K init, 1592K bss, 229356K reserved, 0K cma-reserved) May 16 05:37:23.087065 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 16 05:37:23.087076 kernel: ftrace: allocating 37922 entries in 149 pages May 16 05:37:23.087085 kernel: ftrace: allocated 149 pages with 4 groups May 16 05:37:23.087094 kernel: Dynamic Preempt: voluntary May 16 05:37:23.087104 kernel: rcu: Preemptible hierarchical RCU implementation. May 16 05:37:23.087114 kernel: rcu: RCU event tracing is enabled. May 16 05:37:23.087124 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. May 16 05:37:23.087134 kernel: Trampoline variant of Tasks RCU enabled. May 16 05:37:23.087143 kernel: Rude variant of Tasks RCU enabled. May 16 05:37:23.087152 kernel: Tracing variant of Tasks RCU enabled. May 16 05:37:23.087164 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 16 05:37:23.087173 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 16 05:37:23.087182 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 May 16 05:37:23.087191 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 16 05:37:23.087201 kernel: Console: colour VGA+ 80x25 May 16 05:37:23.087210 kernel: printk: console [tty0] enabled May 16 05:37:23.087219 kernel: printk: console [ttyS0] enabled May 16 05:37:23.087228 kernel: ACPI: Core revision 20230628 May 16 05:37:23.087237 kernel: APIC: Switch to symmetric I/O mode setup May 16 05:37:23.087247 kernel: x2apic enabled May 16 05:37:23.087258 kernel: APIC: Switched APIC routing to: physical x2apic May 16 05:37:23.087267 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 May 16 05:37:23.087277 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized May 16 05:37:23.087286 kernel: Calibrating delay loop (skipped) preset value.. 3992.49 BogoMIPS (lpj=1996249) May 16 05:37:23.087295 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 May 16 05:37:23.087305 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 May 16 05:37:23.087314 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 16 05:37:23.087323 kernel: Spectre V2 : Mitigation: Retpolines May 16 05:37:23.087333 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 16 05:37:23.087345 kernel: Speculative Store Bypass: Vulnerable May 16 05:37:23.087354 kernel: x86/fpu: x87 FPU will use FXSAVE May 16 05:37:23.087363 kernel: Freeing SMP alternatives memory: 32K May 16 05:37:23.087373 kernel: pid_max: default: 32768 minimum: 301 May 16 05:37:23.087389 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 16 05:37:23.087401 kernel: landlock: Up and running. May 16 05:37:23.087411 kernel: SELinux: Initializing. May 16 05:37:23.087420 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 16 05:37:23.087430 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 16 05:37:23.087440 kernel: smpboot: CPU0: AMD Intel Core i7 9xx (Nehalem Class Core i7) (family: 0x6, model: 0x1a, stepping: 0x3) May 16 05:37:23.087450 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 16 05:37:23.087462 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 16 05:37:23.087472 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 16 05:37:23.087482 kernel: Performance Events: AMD PMU driver. May 16 05:37:23.087491 kernel: ... version: 0 May 16 05:37:23.087501 kernel: ... bit width: 48 May 16 05:37:23.087512 kernel: ... generic registers: 4 May 16 05:37:23.087522 kernel: ... value mask: 0000ffffffffffff May 16 05:37:23.087532 kernel: ... max period: 00007fffffffffff May 16 05:37:23.087542 kernel: ... fixed-purpose events: 0 May 16 05:37:23.087552 kernel: ... event mask: 000000000000000f May 16 05:37:23.087561 kernel: signal: max sigframe size: 1440 May 16 05:37:23.087571 kernel: rcu: Hierarchical SRCU implementation. May 16 05:37:23.087580 kernel: rcu: Max phase no-delay instances is 400. May 16 05:37:23.087590 kernel: smp: Bringing up secondary CPUs ... May 16 05:37:23.087601 kernel: smpboot: x86: Booting SMP configuration: May 16 05:37:23.087611 kernel: .... node #0, CPUs: #1 May 16 05:37:23.087620 kernel: smp: Brought up 1 node, 2 CPUs May 16 05:37:23.087630 kernel: smpboot: Max logical packages: 2 May 16 05:37:23.087640 kernel: smpboot: Total of 2 processors activated (7984.99 BogoMIPS) May 16 05:37:23.087649 kernel: devtmpfs: initialized May 16 05:37:23.087659 kernel: x86/mm: Memory block size: 128MB May 16 05:37:23.087669 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 16 05:37:23.087679 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 16 05:37:23.087689 kernel: pinctrl core: initialized pinctrl subsystem May 16 05:37:23.087701 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 16 05:37:23.087710 kernel: audit: initializing netlink subsys (disabled) May 16 05:37:23.087720 kernel: audit: type=2000 audit(1747373841.659:1): state=initialized audit_enabled=0 res=1 May 16 05:37:23.087730 kernel: thermal_sys: Registered thermal governor 'step_wise' May 16 05:37:23.087739 kernel: thermal_sys: Registered thermal governor 'user_space' May 16 05:37:23.087749 kernel: cpuidle: using governor menu May 16 05:37:23.087759 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 16 05:37:23.087769 kernel: dca service started, version 1.12.1 May 16 05:37:23.087778 kernel: PCI: Using configuration type 1 for base access May 16 05:37:23.087790 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 16 05:37:23.087799 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 16 05:37:23.087809 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 16 05:37:23.087819 kernel: ACPI: Added _OSI(Module Device) May 16 05:37:23.087828 kernel: ACPI: Added _OSI(Processor Device) May 16 05:37:23.087838 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 16 05:37:23.087848 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 16 05:37:23.087858 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 16 05:37:23.089032 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC May 16 05:37:23.089051 kernel: ACPI: Interpreter enabled May 16 05:37:23.089062 kernel: ACPI: PM: (supports S0 S3 S5) May 16 05:37:23.089072 kernel: ACPI: Using IOAPIC for interrupt routing May 16 05:37:23.089082 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 16 05:37:23.089092 kernel: PCI: Using E820 reservations for host bridge windows May 16 05:37:23.089101 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F May 16 05:37:23.089111 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 16 05:37:23.089270 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] May 16 05:37:23.089376 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] May 16 05:37:23.089471 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge May 16 05:37:23.089485 kernel: acpiphp: Slot [3] registered May 16 05:37:23.089495 kernel: acpiphp: Slot [4] registered May 16 05:37:23.089505 kernel: acpiphp: Slot [5] registered May 16 05:37:23.089514 kernel: acpiphp: Slot [6] registered May 16 05:37:23.089523 kernel: acpiphp: Slot [7] registered May 16 05:37:23.089533 kernel: acpiphp: Slot [8] registered May 16 05:37:23.089545 kernel: acpiphp: Slot [9] registered May 16 05:37:23.089555 kernel: acpiphp: Slot [10] registered May 16 05:37:23.089564 kernel: acpiphp: Slot [11] registered May 16 05:37:23.089574 kernel: acpiphp: Slot [12] registered May 16 05:37:23.089583 kernel: acpiphp: Slot [13] registered May 16 05:37:23.089592 kernel: acpiphp: Slot [14] registered May 16 05:37:23.089601 kernel: acpiphp: Slot [15] registered May 16 05:37:23.089611 kernel: acpiphp: Slot [16] registered May 16 05:37:23.089620 kernel: acpiphp: Slot [17] registered May 16 05:37:23.089631 kernel: acpiphp: Slot [18] registered May 16 05:37:23.089641 kernel: acpiphp: Slot [19] registered May 16 05:37:23.089650 kernel: acpiphp: Slot [20] registered May 16 05:37:23.089659 kernel: acpiphp: Slot [21] registered May 16 05:37:23.089668 kernel: acpiphp: Slot [22] registered May 16 05:37:23.089678 kernel: acpiphp: Slot [23] registered May 16 05:37:23.089687 kernel: acpiphp: Slot [24] registered May 16 05:37:23.089697 kernel: acpiphp: Slot [25] registered May 16 05:37:23.089706 kernel: acpiphp: Slot [26] registered May 16 05:37:23.089715 kernel: acpiphp: Slot [27] registered May 16 05:37:23.089726 kernel: acpiphp: Slot [28] registered May 16 05:37:23.089736 kernel: acpiphp: Slot [29] registered May 16 05:37:23.089745 kernel: acpiphp: Slot [30] registered May 16 05:37:23.089754 kernel: acpiphp: Slot [31] registered May 16 05:37:23.089763 kernel: PCI host bridge to bus 0000:00 May 16 05:37:23.089900 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 16 05:37:23.089995 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 16 05:37:23.090081 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] May 16 05:37:23.090170 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] May 16 05:37:23.090254 kernel: pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window] May 16 05:37:23.090336 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 16 05:37:23.090448 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 May 16 05:37:23.090553 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 May 16 05:37:23.090660 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 May 16 05:37:23.090760 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] May 16 05:37:23.090854 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] May 16 05:37:23.096039 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] May 16 05:37:23.096138 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] May 16 05:37:23.096253 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] May 16 05:37:23.096356 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 May 16 05:37:23.096451 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI May 16 05:37:23.096551 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB May 16 05:37:23.096653 kernel: pci 0000:00:02.0: [1af4:1050] type 00 class 0x030000 May 16 05:37:23.096750 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfe000000-0xfe7fffff pref] May 16 05:37:23.096848 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xc000000000-0xc000003fff 64bit pref] May 16 05:37:23.098008 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfeb90000-0xfeb90fff] May 16 05:37:23.098105 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfeb8ffff pref] May 16 05:37:23.098201 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 16 05:37:23.098315 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 May 16 05:37:23.098413 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc0bf] May 16 05:37:23.098507 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfeb91000-0xfeb91fff] May 16 05:37:23.098601 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xc000004000-0xc000007fff 64bit pref] May 16 05:37:23.098695 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref] May 16 05:37:23.098803 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 May 16 05:37:23.099955 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] May 16 05:37:23.100055 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfeb92000-0xfeb92fff] May 16 05:37:23.100163 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xc000008000-0xc00000bfff 64bit pref] May 16 05:37:23.100268 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00 May 16 05:37:23.100363 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0c0-0xc0ff] May 16 05:37:23.100456 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xc00000c000-0xc00000ffff 64bit pref] May 16 05:37:23.100559 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00 May 16 05:37:23.100658 kernel: pci 0000:00:06.0: reg 0x10: [io 0xc100-0xc11f] May 16 05:37:23.100750 kernel: pci 0000:00:06.0: reg 0x14: [mem 0xfeb93000-0xfeb93fff] May 16 05:37:23.100846 kernel: pci 0000:00:06.0: reg 0x20: [mem 0xc000010000-0xc000013fff 64bit pref] May 16 05:37:23.101892 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 May 16 05:37:23.101906 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 May 16 05:37:23.101916 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 May 16 05:37:23.101926 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 May 16 05:37:23.101935 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 May 16 05:37:23.101945 kernel: iommu: Default domain type: Translated May 16 05:37:23.101958 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 16 05:37:23.101967 kernel: PCI: Using ACPI for IRQ routing May 16 05:37:23.101976 kernel: PCI: pci_cache_line_size set to 64 bytes May 16 05:37:23.101986 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] May 16 05:37:23.101995 kernel: e820: reserve RAM buffer [mem 0xbffdd000-0xbfffffff] May 16 05:37:23.102098 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device May 16 05:37:23.102193 kernel: pci 0000:00:02.0: vgaarb: bridge control possible May 16 05:37:23.102287 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 16 05:37:23.102304 kernel: vgaarb: loaded May 16 05:37:23.102313 kernel: clocksource: Switched to clocksource kvm-clock May 16 05:37:23.102323 kernel: VFS: Disk quotas dquot_6.6.0 May 16 05:37:23.102332 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 16 05:37:23.102342 kernel: pnp: PnP ACPI init May 16 05:37:23.102441 kernel: pnp 00:03: [dma 2] May 16 05:37:23.102457 kernel: pnp: PnP ACPI: found 5 devices May 16 05:37:23.102467 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 16 05:37:23.102476 kernel: NET: Registered PF_INET protocol family May 16 05:37:23.102489 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 16 05:37:23.102498 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 16 05:37:23.102508 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 16 05:37:23.102517 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 16 05:37:23.102526 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 16 05:37:23.102536 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 16 05:37:23.102545 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 16 05:37:23.102554 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 16 05:37:23.102568 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 16 05:37:23.102578 kernel: NET: Registered PF_XDP protocol family May 16 05:37:23.102671 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 16 05:37:23.102760 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 16 05:37:23.102848 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] May 16 05:37:23.103977 kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] May 16 05:37:23.104061 kernel: pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window] May 16 05:37:23.104179 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release May 16 05:37:23.104278 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers May 16 05:37:23.104298 kernel: PCI: CLS 0 bytes, default 64 May 16 05:37:23.104309 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) May 16 05:37:23.104319 kernel: software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB) May 16 05:37:23.104328 kernel: Initialise system trusted keyrings May 16 05:37:23.104338 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 16 05:37:23.104348 kernel: Key type asymmetric registered May 16 05:37:23.104357 kernel: Asymmetric key parser 'x509' registered May 16 05:37:23.104366 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) May 16 05:37:23.104379 kernel: io scheduler mq-deadline registered May 16 05:37:23.104388 kernel: io scheduler kyber registered May 16 05:37:23.104398 kernel: io scheduler bfq registered May 16 05:37:23.104407 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 16 05:37:23.104418 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 May 16 05:37:23.104428 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 May 16 05:37:23.104437 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 May 16 05:37:23.104446 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 May 16 05:37:23.104456 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 16 05:37:23.104467 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 16 05:37:23.104477 kernel: random: crng init done May 16 05:37:23.104486 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 May 16 05:37:23.104496 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 May 16 05:37:23.104505 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 May 16 05:37:23.104605 kernel: rtc_cmos 00:04: RTC can wake from S4 May 16 05:37:23.104621 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 May 16 05:37:23.104703 kernel: rtc_cmos 00:04: registered as rtc0 May 16 05:37:23.104792 kernel: rtc_cmos 00:04: setting system clock to 2025-05-16T05:37:22 UTC (1747373842) May 16 05:37:23.105913 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram May 16 05:37:23.105930 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled May 16 05:37:23.105940 kernel: NET: Registered PF_INET6 protocol family May 16 05:37:23.105949 kernel: Segment Routing with IPv6 May 16 05:37:23.105959 kernel: In-situ OAM (IOAM) with IPv6 May 16 05:37:23.105968 kernel: NET: Registered PF_PACKET protocol family May 16 05:37:23.105978 kernel: Key type dns_resolver registered May 16 05:37:23.105987 kernel: IPI shorthand broadcast: enabled May 16 05:37:23.106000 kernel: sched_clock: Marking stable (1017008453, 183643016)->(1247603430, -46951961) May 16 05:37:23.106010 kernel: registered taskstats version 1 May 16 05:37:23.106019 kernel: Loading compiled-in X.509 certificates May 16 05:37:23.106029 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.90-flatcar: 22e80ca6ad28c00533ea5eb0843f23994a6e2a11' May 16 05:37:23.106038 kernel: Key type .fscrypt registered May 16 05:37:23.106047 kernel: Key type fscrypt-provisioning registered May 16 05:37:23.106057 kernel: ima: No TPM chip found, activating TPM-bypass! May 16 05:37:23.106066 kernel: ima: Allocated hash algorithm: sha1 May 16 05:37:23.106076 kernel: ima: No architecture policies found May 16 05:37:23.106087 kernel: clk: Disabling unused clocks May 16 05:37:23.106097 kernel: Freeing unused kernel image (initmem) memory: 43484K May 16 05:37:23.106106 kernel: Write protecting the kernel read-only data: 38912k May 16 05:37:23.106116 kernel: Freeing unused kernel image (rodata/data gap) memory: 1712K May 16 05:37:23.106125 kernel: Run /init as init process May 16 05:37:23.106134 kernel: with arguments: May 16 05:37:23.106143 kernel: /init May 16 05:37:23.106152 kernel: with environment: May 16 05:37:23.106161 kernel: HOME=/ May 16 05:37:23.106172 kernel: TERM=linux May 16 05:37:23.106182 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 16 05:37:23.106193 systemd[1]: Successfully made /usr/ read-only. May 16 05:37:23.106206 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 16 05:37:23.106216 systemd[1]: Detected virtualization kvm. May 16 05:37:23.106226 systemd[1]: Detected architecture x86-64. May 16 05:37:23.106236 systemd[1]: Running in initrd. May 16 05:37:23.106248 systemd[1]: No hostname configured, using default hostname. May 16 05:37:23.106258 systemd[1]: Hostname set to . May 16 05:37:23.106268 systemd[1]: Initializing machine ID from VM UUID. May 16 05:37:23.106278 systemd[1]: Queued start job for default target initrd.target. May 16 05:37:23.106287 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 05:37:23.106297 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 05:37:23.106308 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 16 05:37:23.106328 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 16 05:37:23.106340 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 16 05:37:23.106352 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 16 05:37:23.106363 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 16 05:37:23.106373 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 16 05:37:23.106386 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 05:37:23.106396 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 16 05:37:23.106407 systemd[1]: Reached target paths.target - Path Units. May 16 05:37:23.106417 systemd[1]: Reached target slices.target - Slice Units. May 16 05:37:23.106427 systemd[1]: Reached target swap.target - Swaps. May 16 05:37:23.106437 systemd[1]: Reached target timers.target - Timer Units. May 16 05:37:23.106448 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 16 05:37:23.106458 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 16 05:37:23.106468 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 16 05:37:23.106480 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 16 05:37:23.106491 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 16 05:37:23.106501 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 16 05:37:23.106511 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 16 05:37:23.106521 systemd[1]: Reached target sockets.target - Socket Units. May 16 05:37:23.106532 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 16 05:37:23.106542 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 16 05:37:23.106552 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 16 05:37:23.106562 systemd[1]: Starting systemd-fsck-usr.service... May 16 05:37:23.106575 systemd[1]: Starting systemd-journald.service - Journal Service... May 16 05:37:23.106585 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 16 05:37:23.106595 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 05:37:23.106605 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 16 05:37:23.106616 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 16 05:37:23.106650 systemd-journald[183]: Collecting audit messages is disabled. May 16 05:37:23.106677 systemd[1]: Finished systemd-fsck-usr.service. May 16 05:37:23.106688 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 16 05:37:23.106702 systemd-journald[183]: Journal started May 16 05:37:23.106726 systemd-journald[183]: Runtime Journal (/run/log/journal/17432d80addb40679162c36cfb91b1bf) is 8M, max 78.3M, 70.3M free. May 16 05:37:23.086468 systemd-modules-load[184]: Inserted module 'overlay' May 16 05:37:23.142374 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 16 05:37:23.142400 kernel: Bridge firewalling registered May 16 05:37:23.127157 systemd-modules-load[184]: Inserted module 'br_netfilter' May 16 05:37:23.151885 systemd[1]: Started systemd-journald.service - Journal Service. May 16 05:37:23.152673 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 16 05:37:23.153424 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:23.156222 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 16 05:37:23.164013 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 05:37:23.166079 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 16 05:37:23.168994 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 16 05:37:23.173061 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 16 05:37:23.183950 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 16 05:37:23.191056 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 05:37:23.197113 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 16 05:37:23.198793 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 05:37:23.200501 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 05:37:23.219267 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 16 05:37:23.233886 dracut-cmdline[223]: dracut-dracut-053 May 16 05:37:23.236905 dracut-cmdline[223]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=ffa0077ec5e89092631d817251b58c64c9261c447bd6e8bcef43c52d5e74873e May 16 05:37:23.245412 systemd-resolved[220]: Positive Trust Anchors: May 16 05:37:23.246076 systemd-resolved[220]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 16 05:37:23.246118 systemd-resolved[220]: 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 May 16 05:37:23.251994 systemd-resolved[220]: Defaulting to hostname 'linux'. May 16 05:37:23.253976 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 16 05:37:23.254599 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 16 05:37:23.312967 kernel: SCSI subsystem initialized May 16 05:37:23.325933 kernel: Loading iSCSI transport class v2.0-870. May 16 05:37:23.338930 kernel: iscsi: registered transport (tcp) May 16 05:37:23.362475 kernel: iscsi: registered transport (qla4xxx) May 16 05:37:23.362584 kernel: QLogic iSCSI HBA Driver May 16 05:37:23.415741 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 16 05:37:23.422206 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 16 05:37:23.471380 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 16 05:37:23.471491 kernel: device-mapper: uevent: version 1.0.3 May 16 05:37:23.474528 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 16 05:37:23.536190 kernel: raid6: sse2x4 gen() 5056 MB/s May 16 05:37:23.555021 kernel: raid6: sse2x2 gen() 6002 MB/s May 16 05:37:23.573396 kernel: raid6: sse2x1 gen() 9449 MB/s May 16 05:37:23.573512 kernel: raid6: using algorithm sse2x1 gen() 9449 MB/s May 16 05:37:23.592577 kernel: raid6: .... xor() 7361 MB/s, rmw enabled May 16 05:37:23.592636 kernel: raid6: using ssse3x2 recovery algorithm May 16 05:37:23.615475 kernel: xor: measuring software checksum speed May 16 05:37:23.615537 kernel: prefetch64-sse : 18512 MB/sec May 16 05:37:23.615981 kernel: generic_sse : 16848 MB/sec May 16 05:37:23.617083 kernel: xor: using function: prefetch64-sse (18512 MB/sec) May 16 05:37:23.796939 kernel: Btrfs loaded, zoned=no, fsverity=no May 16 05:37:23.814244 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 16 05:37:23.823135 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 05:37:23.867486 systemd-udevd[405]: Using default interface naming scheme 'v255'. May 16 05:37:23.879537 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 05:37:23.892503 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 16 05:37:23.930318 dracut-pre-trigger[412]: rd.md=0: removing MD RAID activation May 16 05:37:23.974406 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 16 05:37:23.980056 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 16 05:37:24.048893 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 16 05:37:24.057051 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 16 05:37:24.070105 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 16 05:37:24.079789 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 16 05:37:24.081280 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 05:37:24.082472 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 16 05:37:24.089169 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 16 05:37:24.101154 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 16 05:37:24.134897 kernel: libata version 3.00 loaded. May 16 05:37:24.138916 kernel: ata_piix 0000:00:01.1: version 2.13 May 16 05:37:24.144892 kernel: virtio_blk virtio2: 2/0/0 default/read/poll queues May 16 05:37:24.149910 kernel: scsi host0: ata_piix May 16 05:37:24.153905 kernel: scsi host1: ata_piix May 16 05:37:24.158893 kernel: virtio_blk virtio2: [vda] 20971520 512-byte logical blocks (10.7 GB/10.0 GiB) May 16 05:37:24.162655 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 May 16 05:37:24.162682 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 May 16 05:37:24.169169 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 16 05:37:24.169245 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 05:37:24.183276 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. May 16 05:37:24.183311 kernel: GPT:17805311 != 20971519 May 16 05:37:24.183324 kernel: GPT:Alternate GPT header not at the end of the disk. May 16 05:37:24.183336 kernel: GPT:17805311 != 20971519 May 16 05:37:24.183346 kernel: GPT: Use GNU Parted to correct GPT errors. May 16 05:37:24.183358 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 05:37:24.170460 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 05:37:24.171222 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 05:37:24.171275 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:24.183995 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 16 05:37:24.194022 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 05:37:24.195154 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. May 16 05:37:24.251544 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:24.262128 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 05:37:24.285497 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 05:37:24.359380 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (451) May 16 05:37:24.364196 kernel: BTRFS: device fsid 7e35ecc6-4b22-44da-ae37-cf2eabf14492 devid 1 transid 41 /dev/vda3 scanned by (udev-worker) (456) May 16 05:37:24.405114 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 16 05:37:24.423652 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 16 05:37:24.432876 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 16 05:37:24.433530 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 16 05:37:24.447147 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 16 05:37:24.458077 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 16 05:37:24.478152 disk-uuid[514]: Primary Header is updated. May 16 05:37:24.478152 disk-uuid[514]: Secondary Entries is updated. May 16 05:37:24.478152 disk-uuid[514]: Secondary Header is updated. May 16 05:37:24.487026 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 05:37:25.508091 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 05:37:25.509476 disk-uuid[515]: The operation has completed successfully. May 16 05:37:25.590317 systemd[1]: disk-uuid.service: Deactivated successfully. May 16 05:37:25.590434 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 16 05:37:25.643992 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 16 05:37:25.650169 sh[526]: Success May 16 05:37:25.663914 kernel: device-mapper: verity: sha256 using implementation "sha256-ssse3" May 16 05:37:25.726586 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 16 05:37:25.727404 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 16 05:37:25.730041 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 16 05:37:25.751049 kernel: BTRFS info (device dm-0): first mount of filesystem 7e35ecc6-4b22-44da-ae37-cf2eabf14492 May 16 05:37:25.751083 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 16 05:37:25.751096 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 16 05:37:25.753236 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 16 05:37:25.754789 kernel: BTRFS info (device dm-0): using free space tree May 16 05:37:25.769769 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 16 05:37:25.771517 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 16 05:37:25.779093 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 16 05:37:25.782601 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 16 05:37:25.813036 kernel: BTRFS info (device vda6): first mount of filesystem 82f90484-7c6e-4c5a-90fb-411944eb49d1 May 16 05:37:25.813113 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 16 05:37:25.816423 kernel: BTRFS info (device vda6): using free space tree May 16 05:37:25.822919 kernel: BTRFS info (device vda6): auto enabling async discard May 16 05:37:25.829949 kernel: BTRFS info (device vda6): last unmount of filesystem 82f90484-7c6e-4c5a-90fb-411944eb49d1 May 16 05:37:25.837435 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 16 05:37:25.847225 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 16 05:37:25.922988 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 16 05:37:25.937090 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 16 05:37:25.966383 systemd-networkd[705]: lo: Link UP May 16 05:37:25.967167 systemd-networkd[705]: lo: Gained carrier May 16 05:37:25.969011 systemd-networkd[705]: Enumeration completed May 16 05:37:25.969758 systemd[1]: Started systemd-networkd.service - Network Configuration. May 16 05:37:25.971064 systemd[1]: Reached target network.target - Network. May 16 05:37:25.972480 systemd-networkd[705]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 05:37:25.972485 systemd-networkd[705]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 16 05:37:25.976038 systemd-networkd[705]: eth0: Link UP May 16 05:37:25.976042 systemd-networkd[705]: eth0: Gained carrier May 16 05:37:25.976052 systemd-networkd[705]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 05:37:25.988913 systemd-networkd[705]: eth0: DHCPv4 address 172.24.4.121/24, gateway 172.24.4.1 acquired from 172.24.4.1 May 16 05:37:26.007962 ignition[627]: Ignition 2.20.0 May 16 05:37:26.007971 ignition[627]: Stage: fetch-offline May 16 05:37:26.009522 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 16 05:37:26.008011 ignition[627]: no configs at "/usr/lib/ignition/base.d" May 16 05:37:26.008021 ignition[627]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:26.008116 ignition[627]: parsed url from cmdline: "" May 16 05:37:26.008122 ignition[627]: no config URL provided May 16 05:37:26.008127 ignition[627]: reading system config file "/usr/lib/ignition/user.ign" May 16 05:37:26.008154 ignition[627]: no config at "/usr/lib/ignition/user.ign" May 16 05:37:26.008166 ignition[627]: failed to fetch config: resource requires networking May 16 05:37:26.008371 ignition[627]: Ignition finished successfully May 16 05:37:26.017040 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... May 16 05:37:26.031146 ignition[715]: Ignition 2.20.0 May 16 05:37:26.031163 ignition[715]: Stage: fetch May 16 05:37:26.031339 ignition[715]: no configs at "/usr/lib/ignition/base.d" May 16 05:37:26.031351 ignition[715]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:26.031434 ignition[715]: parsed url from cmdline: "" May 16 05:37:26.031437 ignition[715]: no config URL provided May 16 05:37:26.031443 ignition[715]: reading system config file "/usr/lib/ignition/user.ign" May 16 05:37:26.031451 ignition[715]: no config at "/usr/lib/ignition/user.ign" May 16 05:37:26.031535 ignition[715]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1 May 16 05:37:26.031689 ignition[715]: config drive ("/dev/disk/by-label/config-2") not found. Waiting... May 16 05:37:26.031720 ignition[715]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting... May 16 05:37:26.213708 ignition[715]: GET result: OK May 16 05:37:26.213850 ignition[715]: parsing config with SHA512: c326ddd67275819a21dc13fac4470e7c3162d407cd8b0e0149d66b5e32cc575f266533ebb9b21c0aaa8d34c7cc6702778dac84ca73adb713e172c2e63d41d438 May 16 05:37:26.236706 unknown[715]: fetched base config from "system" May 16 05:37:26.237398 ignition[715]: fetch: fetch complete May 16 05:37:26.236732 unknown[715]: fetched base config from "system" May 16 05:37:26.237411 ignition[715]: fetch: fetch passed May 16 05:37:26.236758 unknown[715]: fetched user config from "openstack" May 16 05:37:26.237506 ignition[715]: Ignition finished successfully May 16 05:37:26.242262 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). May 16 05:37:26.253279 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 16 05:37:26.288706 ignition[721]: Ignition 2.20.0 May 16 05:37:26.288733 ignition[721]: Stage: kargs May 16 05:37:26.289211 ignition[721]: no configs at "/usr/lib/ignition/base.d" May 16 05:37:26.289238 ignition[721]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:26.291060 ignition[721]: kargs: kargs passed May 16 05:37:26.293855 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 16 05:37:26.291158 ignition[721]: Ignition finished successfully May 16 05:37:26.304246 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 16 05:37:26.333014 ignition[727]: Ignition 2.20.0 May 16 05:37:26.333024 ignition[727]: Stage: disks May 16 05:37:26.333207 ignition[727]: no configs at "/usr/lib/ignition/base.d" May 16 05:37:26.336194 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 16 05:37:26.333221 ignition[727]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:26.338447 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 16 05:37:26.334008 ignition[727]: disks: disks passed May 16 05:37:26.340204 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 16 05:37:26.334051 ignition[727]: Ignition finished successfully May 16 05:37:26.342272 systemd[1]: Reached target local-fs.target - Local File Systems. May 16 05:37:26.344127 systemd[1]: Reached target sysinit.target - System Initialization. May 16 05:37:26.345766 systemd[1]: Reached target basic.target - Basic System. May 16 05:37:26.354041 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 16 05:37:26.393171 systemd-fsck[735]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks May 16 05:37:26.405174 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 16 05:37:26.411180 systemd[1]: Mounting sysroot.mount - /sysroot... May 16 05:37:26.526199 kernel: EXT4-fs (vda9): mounted filesystem 14ea3086-9247-48be-9c0b-44ef9d324f10 r/w with ordered data mode. Quota mode: none. May 16 05:37:26.528344 systemd[1]: Mounted sysroot.mount - /sysroot. May 16 05:37:26.530976 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 16 05:37:26.543129 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 16 05:37:26.547580 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 16 05:37:26.549224 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 16 05:37:26.551449 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent... May 16 05:37:26.553921 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 16 05:37:26.553953 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 16 05:37:26.563023 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (743) May 16 05:37:26.567897 kernel: BTRFS info (device vda6): first mount of filesystem 82f90484-7c6e-4c5a-90fb-411944eb49d1 May 16 05:37:26.569940 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 16 05:37:26.570052 kernel: BTRFS info (device vda6): using free space tree May 16 05:37:26.572091 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 16 05:37:26.580015 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 16 05:37:26.596496 kernel: BTRFS info (device vda6): auto enabling async discard May 16 05:37:26.599665 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 16 05:37:26.690480 initrd-setup-root[770]: cut: /sysroot/etc/passwd: No such file or directory May 16 05:37:26.700208 initrd-setup-root[778]: cut: /sysroot/etc/group: No such file or directory May 16 05:37:26.706949 initrd-setup-root[785]: cut: /sysroot/etc/shadow: No such file or directory May 16 05:37:26.713936 initrd-setup-root[792]: cut: /sysroot/etc/gshadow: No such file or directory May 16 05:37:26.810798 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 16 05:37:26.815978 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 16 05:37:26.818063 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 16 05:37:26.825653 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 16 05:37:26.828659 kernel: BTRFS info (device vda6): last unmount of filesystem 82f90484-7c6e-4c5a-90fb-411944eb49d1 May 16 05:37:26.854146 ignition[859]: INFO : Ignition 2.20.0 May 16 05:37:26.854146 ignition[859]: INFO : Stage: mount May 16 05:37:26.856342 ignition[859]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 05:37:26.856342 ignition[859]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:26.856342 ignition[859]: INFO : mount: mount passed May 16 05:37:26.856342 ignition[859]: INFO : Ignition finished successfully May 16 05:37:26.858345 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 16 05:37:26.859666 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 16 05:37:27.557511 systemd-networkd[705]: eth0: Gained IPv6LL May 16 05:37:33.763129 coreos-metadata[745]: May 16 05:37:33.763 WARN failed to locate config-drive, using the metadata service API instead May 16 05:37:33.803154 coreos-metadata[745]: May 16 05:37:33.803 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 May 16 05:37:33.818464 coreos-metadata[745]: May 16 05:37:33.818 INFO Fetch successful May 16 05:37:33.819947 coreos-metadata[745]: May 16 05:37:33.819 INFO wrote hostname ci-4230-1-1-n-2d0ce5bf67.novalocal to /sysroot/etc/hostname May 16 05:37:33.822434 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully. May 16 05:37:33.822704 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent. May 16 05:37:33.845646 systemd[1]: Starting ignition-files.service - Ignition (files)... May 16 05:37:33.874601 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 16 05:37:33.894967 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (876) May 16 05:37:33.903994 kernel: BTRFS info (device vda6): first mount of filesystem 82f90484-7c6e-4c5a-90fb-411944eb49d1 May 16 05:37:33.904154 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 16 05:37:33.907331 kernel: BTRFS info (device vda6): using free space tree May 16 05:37:33.918984 kernel: BTRFS info (device vda6): auto enabling async discard May 16 05:37:33.925150 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 16 05:37:33.968608 ignition[894]: INFO : Ignition 2.20.0 May 16 05:37:33.968608 ignition[894]: INFO : Stage: files May 16 05:37:33.971519 ignition[894]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 05:37:33.971519 ignition[894]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:33.971519 ignition[894]: DEBUG : files: compiled without relabeling support, skipping May 16 05:37:33.977031 ignition[894]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 16 05:37:33.977031 ignition[894]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 16 05:37:33.981440 ignition[894]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 16 05:37:33.981440 ignition[894]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 16 05:37:33.981440 ignition[894]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 16 05:37:33.981036 unknown[894]: wrote ssh authorized keys file for user: core May 16 05:37:33.988637 ignition[894]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" May 16 05:37:33.988637 ignition[894]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/20-clct-provider-override.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/20-clct-provider-override.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" May 16 05:37:33.988637 ignition[894]: INFO : files: op(6): [started] processing unit "coreos-metadata-sshkeys@.service" May 16 05:37:33.988637 ignition[894]: INFO : files: op(6): op(7): [started] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata-sshkeys@.service.d/20-clct-provider-override.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(6): op(7): [finished] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata-sshkeys@.service.d/20-clct-provider-override.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(6): [finished] processing unit "coreos-metadata-sshkeys@.service" May 16 05:37:33.988637 ignition[894]: INFO : files: op(8): [started] processing unit "etcd-member.service" May 16 05:37:33.988637 ignition[894]: INFO : files: op(8): op(9): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" May 16 05:37:33.988637 ignition[894]: INFO : files: op(8): [finished] processing unit "etcd-member.service" May 16 05:37:33.988637 ignition[894]: INFO : files: op(a): [started] processing unit "flannel-docker-opts.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(a): op(b): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" May 16 05:37:34.019412 ignition[894]: INFO : files: op(a): op(b): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" May 16 05:37:34.019412 ignition[894]: INFO : files: op(a): [finished] processing unit "flannel-docker-opts.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(c): [started] processing unit "docker.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(c): [finished] processing unit "docker.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(d): [started] processing unit "flanneld.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(d): op(e): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" May 16 05:37:34.019412 ignition[894]: INFO : files: op(d): op(e): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" May 16 05:37:34.019412 ignition[894]: INFO : files: op(d): [finished] processing unit "flanneld.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(f): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " May 16 05:37:34.019412 ignition[894]: INFO : files: op(f): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " May 16 05:37:34.019412 ignition[894]: INFO : files: op(10): [started] setting preset to enabled for "docker.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(10): [finished] setting preset to enabled for "docker.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(11): [started] setting preset to enabled for "etcd-member.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(11): [finished] setting preset to enabled for "etcd-member.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(12): [started] setting preset to enabled for "flanneld.service" May 16 05:37:34.019412 ignition[894]: INFO : files: op(12): [finished] setting preset to enabled for "flanneld.service" May 16 05:37:34.019412 ignition[894]: INFO : files: createResultFile: createFiles: op(13): [started] writing file "/sysroot/etc/.ignition-result.json" May 16 05:37:34.019412 ignition[894]: INFO : files: createResultFile: createFiles: op(13): [finished] writing file "/sysroot/etc/.ignition-result.json" May 16 05:37:34.019412 ignition[894]: INFO : files: files passed May 16 05:37:34.019412 ignition[894]: INFO : Ignition finished successfully May 16 05:37:34.010426 systemd[1]: Finished ignition-files.service - Ignition (files). May 16 05:37:34.025163 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 16 05:37:34.035530 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 16 05:37:34.042893 systemd[1]: ignition-quench.service: Deactivated successfully. May 16 05:37:34.042983 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 16 05:37:34.049503 initrd-setup-root-after-ignition[923]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 16 05:37:34.049503 initrd-setup-root-after-ignition[923]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 16 05:37:34.051603 initrd-setup-root-after-ignition[927]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 16 05:37:34.053455 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 16 05:37:34.058216 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 16 05:37:34.064020 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 16 05:37:34.086492 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 16 05:37:34.086594 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 16 05:37:34.088075 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 16 05:37:34.089100 systemd[1]: Reached target initrd.target - Initrd Default Target. May 16 05:37:34.090217 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 16 05:37:34.091013 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 16 05:37:34.107880 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 16 05:37:34.114008 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 16 05:37:34.124492 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 16 05:37:34.125984 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 05:37:34.126657 systemd[1]: Stopped target timers.target - Timer Units. May 16 05:37:34.127838 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 16 05:37:34.127986 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 16 05:37:34.129205 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 16 05:37:34.129927 systemd[1]: Stopped target basic.target - Basic System. May 16 05:37:34.131008 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 16 05:37:34.132023 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 16 05:37:34.133023 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 16 05:37:34.134176 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 16 05:37:34.135308 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 16 05:37:34.136549 systemd[1]: Stopped target sysinit.target - System Initialization. May 16 05:37:34.137664 systemd[1]: Stopped target local-fs.target - Local File Systems. May 16 05:37:34.138772 systemd[1]: Stopped target swap.target - Swaps. May 16 05:37:34.139761 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 16 05:37:34.139901 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 16 05:37:34.141026 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 16 05:37:34.141729 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 05:37:34.142710 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 16 05:37:34.143053 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 05:37:34.143952 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 16 05:37:34.144071 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 16 05:37:34.147059 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 16 05:37:34.147190 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 16 05:37:34.148102 systemd[1]: ignition-files.service: Deactivated successfully. May 16 05:37:34.148230 systemd[1]: Stopped ignition-files.service - Ignition (files). May 16 05:37:34.157954 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 16 05:37:34.158818 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 16 05:37:34.159035 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 16 05:37:34.169822 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 16 05:37:34.170495 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 16 05:37:34.170652 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 16 05:37:34.177025 ignition[947]: INFO : Ignition 2.20.0 May 16 05:37:34.177025 ignition[947]: INFO : Stage: umount May 16 05:37:34.177025 ignition[947]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 05:37:34.177025 ignition[947]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" May 16 05:37:34.177025 ignition[947]: INFO : umount: umount passed May 16 05:37:34.177025 ignition[947]: INFO : Ignition finished successfully May 16 05:37:34.173056 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 16 05:37:34.173188 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 16 05:37:34.177659 systemd[1]: ignition-mount.service: Deactivated successfully. May 16 05:37:34.177760 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 16 05:37:34.181797 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 16 05:37:34.181969 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 16 05:37:34.183678 systemd[1]: ignition-disks.service: Deactivated successfully. May 16 05:37:34.183753 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 16 05:37:34.185164 systemd[1]: ignition-kargs.service: Deactivated successfully. May 16 05:37:34.185232 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 16 05:37:34.185704 systemd[1]: ignition-fetch.service: Deactivated successfully. May 16 05:37:34.185746 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). May 16 05:37:34.186879 systemd[1]: Stopped target network.target - Network. May 16 05:37:34.188080 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 16 05:37:34.188141 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 16 05:37:34.188768 systemd[1]: Stopped target paths.target - Path Units. May 16 05:37:34.189936 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 16 05:37:34.193922 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 05:37:34.194423 systemd[1]: Stopped target slices.target - Slice Units. May 16 05:37:34.194846 systemd[1]: Stopped target sockets.target - Socket Units. May 16 05:37:34.195366 systemd[1]: iscsid.socket: Deactivated successfully. May 16 05:37:34.195403 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 16 05:37:34.198550 systemd[1]: iscsiuio.socket: Deactivated successfully. May 16 05:37:34.198586 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 16 05:37:34.199260 systemd[1]: ignition-setup.service: Deactivated successfully. May 16 05:37:34.199305 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 16 05:37:34.199764 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 16 05:37:34.199804 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 16 05:37:34.202229 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 16 05:37:34.203198 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 16 05:37:34.205585 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 16 05:37:34.207491 systemd[1]: systemd-resolved.service: Deactivated successfully. May 16 05:37:34.207605 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 16 05:37:34.213084 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 16 05:37:34.213390 systemd[1]: systemd-networkd.service: Deactivated successfully. May 16 05:37:34.213498 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 16 05:37:34.215200 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. May 16 05:37:34.215401 systemd[1]: sysroot-boot.service: Deactivated successfully. May 16 05:37:34.215492 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 16 05:37:34.217780 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 16 05:37:34.217836 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 16 05:37:34.218947 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 16 05:37:34.218994 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 16 05:37:34.229992 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 16 05:37:34.230993 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 16 05:37:34.231052 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 16 05:37:34.232337 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 16 05:37:34.232382 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 16 05:37:34.233650 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 16 05:37:34.233691 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 16 05:37:34.234242 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 16 05:37:34.234289 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 05:37:34.235742 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 05:37:34.237771 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. May 16 05:37:34.237831 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. May 16 05:37:34.245126 systemd[1]: systemd-udevd.service: Deactivated successfully. May 16 05:37:34.245273 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 05:37:34.246689 systemd[1]: network-cleanup.service: Deactivated successfully. May 16 05:37:34.246789 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 16 05:37:34.248266 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 16 05:37:34.248326 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 16 05:37:34.249510 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 16 05:37:34.249541 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 16 05:37:34.250619 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 16 05:37:34.250664 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 16 05:37:34.252196 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 16 05:37:34.252238 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 16 05:37:34.253326 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 16 05:37:34.253370 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 05:37:34.266026 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 16 05:37:34.266833 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 16 05:37:34.266919 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 05:37:34.268929 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 05:37:34.268976 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:34.272011 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 16 05:37:34.272104 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 16 05:37:34.272910 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 16 05:37:34.279038 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 16 05:37:34.286962 systemd[1]: Switching root. May 16 05:37:34.315393 systemd-journald[183]: Journal stopped May 16 05:37:35.613202 systemd-journald[183]: Received SIGTERM from PID 1 (systemd). May 16 05:37:35.613260 kernel: SELinux: policy capability network_peer_controls=1 May 16 05:37:35.613289 kernel: SELinux: policy capability open_perms=1 May 16 05:37:35.613304 kernel: SELinux: policy capability extended_socket_class=1 May 16 05:37:35.613315 kernel: SELinux: policy capability always_check_network=0 May 16 05:37:35.613327 kernel: SELinux: policy capability cgroup_seclabel=1 May 16 05:37:35.613342 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 16 05:37:35.613353 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 16 05:37:35.613364 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 16 05:37:35.613380 kernel: audit: type=1403 audit(1747373854.425:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 16 05:37:35.613393 systemd[1]: Successfully loaded SELinux policy in 47.273ms. May 16 05:37:35.613415 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 27.168ms. May 16 05:37:35.613429 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 16 05:37:35.613442 systemd[1]: Detected virtualization kvm. May 16 05:37:35.613455 systemd[1]: Detected architecture x86-64. May 16 05:37:35.613469 systemd[1]: Detected first boot. May 16 05:37:35.613482 systemd[1]: Hostname set to . May 16 05:37:35.613495 systemd[1]: Initializing machine ID from VM UUID. May 16 05:37:35.613507 zram_generator::config[994]: No configuration found. May 16 05:37:35.613520 kernel: Guest personality initialized and is inactive May 16 05:37:35.613532 kernel: VMCI host device registered (name=vmci, major=10, minor=125) May 16 05:37:35.613544 kernel: Initialized host personality May 16 05:37:35.613555 kernel: NET: Registered PF_VSOCK protocol family May 16 05:37:35.613568 systemd[1]: Populated /etc with preset unit settings. May 16 05:37:35.613581 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 16 05:37:35.613594 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 16 05:37:35.613606 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 16 05:37:35.613624 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 16 05:37:35.613637 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 16 05:37:35.613649 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 16 05:37:35.613662 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. May 16 05:37:35.613677 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 16 05:37:35.613689 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 16 05:37:35.613704 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 16 05:37:35.613717 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 16 05:37:35.613730 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 16 05:37:35.613743 systemd[1]: Created slice user.slice - User and Session Slice. May 16 05:37:35.613755 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 05:37:35.613768 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 05:37:35.613781 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 16 05:37:35.613796 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 16 05:37:35.613809 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 16 05:37:35.613823 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 16 05:37:35.613836 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 16 05:37:35.613848 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 05:37:35.616140 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 16 05:37:35.616167 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 16 05:37:35.616181 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 16 05:37:35.616193 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 16 05:37:35.616206 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 05:37:35.616219 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 16 05:37:35.616231 systemd[1]: Reached target slices.target - Slice Units. May 16 05:37:35.616243 systemd[1]: Reached target swap.target - Swaps. May 16 05:37:35.616256 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 16 05:37:35.616269 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 16 05:37:35.616284 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 16 05:37:35.616297 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 16 05:37:35.616310 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 16 05:37:35.616323 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 16 05:37:35.616335 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 16 05:37:35.616348 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 16 05:37:35.616360 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 16 05:37:35.616373 systemd[1]: Mounting media.mount - External Media Directory... May 16 05:37:35.616385 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:35.616400 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 16 05:37:35.616413 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 16 05:37:35.616425 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 16 05:37:35.616438 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). May 16 05:37:35.616451 systemd[1]: Reached target machines.target - Containers. May 16 05:37:35.616464 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 16 05:37:35.616477 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 05:37:35.616489 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 16 05:37:35.616502 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 16 05:37:35.616517 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 05:37:35.616529 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 16 05:37:35.616542 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 05:37:35.616554 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 16 05:37:35.616567 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 05:37:35.616580 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 16 05:37:35.616592 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 16 05:37:35.616605 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 16 05:37:35.616619 kernel: loop: module loaded May 16 05:37:35.616631 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 16 05:37:35.616644 systemd[1]: Stopped systemd-fsck-usr.service. May 16 05:37:35.616657 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 16 05:37:35.616670 systemd[1]: Starting systemd-journald.service - Journal Service... May 16 05:37:35.616682 kernel: fuse: init (API version 7.39) May 16 05:37:35.616695 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 16 05:37:35.616708 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 16 05:37:35.616720 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 16 05:37:35.616735 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 16 05:37:35.616748 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 16 05:37:35.616761 systemd[1]: verity-setup.service: Deactivated successfully. May 16 05:37:35.616774 systemd[1]: Stopped verity-setup.service. May 16 05:37:35.616788 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:35.616804 kernel: ACPI: bus type drm_connector registered May 16 05:37:35.616816 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 16 05:37:35.616829 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 16 05:37:35.616842 systemd[1]: Mounted media.mount - External Media Directory. May 16 05:37:35.616857 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 16 05:37:35.618777 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 16 05:37:35.618792 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 16 05:37:35.618805 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 16 05:37:35.618817 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 16 05:37:35.618830 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 16 05:37:35.618842 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 16 05:37:35.618855 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 05:37:35.618920 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 05:37:35.618954 systemd-journald[1098]: Collecting audit messages is disabled. May 16 05:37:35.618983 systemd[1]: modprobe@drm.service: Deactivated successfully. May 16 05:37:35.618996 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 16 05:37:35.619008 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 05:37:35.619022 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 05:37:35.619035 systemd-journald[1098]: Journal started May 16 05:37:35.619059 systemd-journald[1098]: Runtime Journal (/run/log/journal/17432d80addb40679162c36cfb91b1bf) is 8M, max 78.3M, 70.3M free. May 16 05:37:35.224213 systemd[1]: Queued start job for default target multi-user.target. May 16 05:37:35.231057 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 16 05:37:35.231455 systemd[1]: systemd-journald.service: Deactivated successfully. May 16 05:37:35.622908 systemd[1]: Started systemd-journald.service - Journal Service. May 16 05:37:35.622706 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 16 05:37:35.623907 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 16 05:37:35.624970 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 05:37:35.625134 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 05:37:35.625965 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 16 05:37:35.630534 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 16 05:37:35.631452 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 16 05:37:35.632323 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 16 05:37:35.642814 systemd[1]: Reached target network-pre.target - Preparation for Network. May 16 05:37:35.649284 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 16 05:37:35.653066 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 16 05:37:35.653713 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 16 05:37:35.653820 systemd[1]: Reached target local-fs.target - Local File Systems. May 16 05:37:35.655602 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 16 05:37:35.661590 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 16 05:37:35.666984 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 16 05:37:35.667617 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 05:37:35.671984 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 16 05:37:35.675086 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 16 05:37:35.677429 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 16 05:37:35.680009 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 16 05:37:35.680763 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 16 05:37:35.688039 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 16 05:37:35.688841 systemd-journald[1098]: Time spent on flushing to /var/log/journal/17432d80addb40679162c36cfb91b1bf is 50.933ms for 957 entries. May 16 05:37:35.688841 systemd-journald[1098]: System Journal (/var/log/journal/17432d80addb40679162c36cfb91b1bf) is 8M, max 584.8M, 576.8M free. May 16 05:37:35.750434 systemd-journald[1098]: Received client request to flush runtime journal. May 16 05:37:35.750474 kernel: loop0: detected capacity change from 0 to 138176 May 16 05:37:35.698479 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 16 05:37:35.702170 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 16 05:37:35.706788 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 16 05:37:35.708239 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 16 05:37:35.709992 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 16 05:37:35.710692 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 16 05:37:35.724100 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 16 05:37:35.743470 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 16 05:37:35.744353 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 16 05:37:35.756291 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 16 05:37:35.757354 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 16 05:37:35.763683 udevadm[1139]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. May 16 05:37:35.803798 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 16 05:37:35.819462 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 16 05:37:35.855234 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 16 05:37:35.865053 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 16 05:37:35.865615 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 16 05:37:35.886903 kernel: loop1: detected capacity change from 0 to 8 May 16 05:37:35.896775 systemd-tmpfiles[1153]: ACLs are not supported, ignoring. May 16 05:37:35.896795 systemd-tmpfiles[1153]: ACLs are not supported, ignoring. May 16 05:37:35.903054 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 05:37:35.909058 kernel: loop2: detected capacity change from 0 to 147912 May 16 05:37:35.970999 kernel: loop3: detected capacity change from 0 to 138176 May 16 05:37:36.010733 kernel: loop4: detected capacity change from 0 to 8 May 16 05:37:36.013966 kernel: loop5: detected capacity change from 0 to 147912 May 16 05:37:36.088213 (sd-merge)[1158]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-openstack'. May 16 05:37:36.088757 (sd-merge)[1158]: Merged extensions into '/usr'. May 16 05:37:36.097411 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 16 05:37:36.109353 systemd[1]: Starting ensure-sysext.service... May 16 05:37:36.115690 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 16 05:37:36.130949 systemd[1]: Reload requested from client PID 1160 ('systemctl') (unit ensure-sysext.service)... May 16 05:37:36.132286 systemd[1]: Reloading... May 16 05:37:36.157235 systemd-tmpfiles[1161]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 16 05:37:36.157502 systemd-tmpfiles[1161]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 16 05:37:36.158571 systemd-tmpfiles[1161]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 16 05:37:36.158853 systemd-tmpfiles[1161]: ACLs are not supported, ignoring. May 16 05:37:36.158957 systemd-tmpfiles[1161]: ACLs are not supported, ignoring. May 16 05:37:36.173993 systemd-tmpfiles[1161]: Detected autofs mount point /boot during canonicalization of boot. May 16 05:37:36.174004 systemd-tmpfiles[1161]: Skipping /boot May 16 05:37:36.197720 systemd-tmpfiles[1161]: Detected autofs mount point /boot during canonicalization of boot. May 16 05:37:36.198359 systemd-tmpfiles[1161]: Skipping /boot May 16 05:37:36.259524 zram_generator::config[1187]: No configuration found. May 16 05:37:36.550131 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. May 16 05:37:36.637170 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 16 05:37:36.637689 systemd[1]: Reloading finished in 505 ms. May 16 05:37:36.675847 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 05:37:36.695048 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 05:37:36.702019 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 16 05:37:36.708966 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 16 05:37:36.719452 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 16 05:37:36.725051 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 16 05:37:36.726555 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 16 05:37:36.739741 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 05:37:36.744933 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:36.745136 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 05:37:36.750946 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 05:37:36.758175 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 05:37:36.760644 ldconfig[1128]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 16 05:37:36.761100 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 05:37:36.762804 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 05:37:36.762969 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 16 05:37:36.766736 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 16 05:37:36.768248 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:36.771066 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 16 05:37:36.772075 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 05:37:36.772413 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 05:37:36.776656 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 05:37:36.776890 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 05:37:36.784950 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 16 05:37:36.796639 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 05:37:36.797955 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 05:37:36.804135 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 16 05:37:36.810218 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:36.810473 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 05:37:36.820224 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 05:37:36.829669 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 05:37:36.830476 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 05:37:36.830622 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 16 05:37:36.837215 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 16 05:37:36.838908 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:36.844461 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:36.844817 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 05:37:36.853285 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 16 05:37:36.856944 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 05:37:36.858580 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 05:37:36.858708 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 16 05:37:36.858910 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 16 05:37:36.859623 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 16 05:37:36.861311 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 05:37:36.862017 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 05:37:36.863010 systemd-udevd[1259]: Using default interface naming scheme 'v255'. May 16 05:37:36.863993 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 05:37:36.864242 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 05:37:36.869664 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 16 05:37:36.876484 systemd[1]: Finished ensure-sysext.service. May 16 05:37:36.884029 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 16 05:37:36.885446 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 16 05:37:36.886987 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 05:37:36.887913 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 05:37:36.891636 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 16 05:37:36.891683 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). May 16 05:37:36.897000 augenrules[1297]: No rules May 16 05:37:36.901196 systemd[1]: audit-rules.service: Deactivated successfully. May 16 05:37:36.901435 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 05:37:36.903281 systemd[1]: modprobe@drm.service: Deactivated successfully. May 16 05:37:36.903439 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 16 05:37:36.912991 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 16 05:37:36.938946 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 05:37:36.950031 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 16 05:37:36.984054 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 16 05:37:36.985008 systemd[1]: Reached target time-set.target - System Time Set. May 16 05:37:37.022019 systemd-resolved[1256]: Positive Trust Anchors: May 16 05:37:37.022449 systemd-resolved[1256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 16 05:37:37.022547 systemd-resolved[1256]: 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 May 16 05:37:37.034050 systemd-resolved[1256]: Using system hostname 'ci-4230-1-1-n-2d0ce5bf67.novalocal'. May 16 05:37:37.037790 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 16 05:37:37.038568 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 16 05:37:37.076516 systemd-networkd[1310]: lo: Link UP May 16 05:37:37.076826 systemd-networkd[1310]: lo: Gained carrier May 16 05:37:37.077680 systemd-networkd[1310]: Enumeration completed May 16 05:37:37.077785 systemd[1]: Started systemd-networkd.service - Network Configuration. May 16 05:37:37.078537 systemd[1]: Reached target network.target - Network. May 16 05:37:37.085025 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 16 05:37:37.087116 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 16 05:37:37.104935 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 16 05:37:37.107156 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 16 05:37:37.138301 systemd-networkd[1310]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 05:37:37.138711 systemd-networkd[1310]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 16 05:37:37.140244 systemd-networkd[1310]: eth0: Link UP May 16 05:37:37.140251 systemd-networkd[1310]: eth0: Gained carrier May 16 05:37:37.140267 systemd-networkd[1310]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 05:37:37.143995 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1315) May 16 05:37:37.149153 systemd-networkd[1310]: eth0: DHCPv4 address 172.24.4.121/24, gateway 172.24.4.1 acquired from 172.24.4.1 May 16 05:37:37.150036 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:37.191905 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 May 16 05:37:37.200038 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 May 16 05:37:37.208877 kernel: ACPI: button: Power Button [PWRF] May 16 05:37:37.213191 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 16 05:37:37.222079 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 16 05:37:37.223880 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 May 16 05:37:37.245139 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 16 05:37:37.265910 kernel: [drm] pci: virtio-vga detected at 0000:00:02.0 May 16 05:37:37.267891 kernel: virtio-pci 0000:00:02.0: vgaarb: deactivate vga console May 16 05:37:37.273608 kernel: Console: switching to colour dummy device 80x25 May 16 05:37:37.275466 kernel: [drm] features: -virgl +edid -resource_blob -host_visible May 16 05:37:37.275505 kernel: [drm] features: -context_init May 16 05:37:37.282141 kernel: [drm] number of scanouts: 1 May 16 05:37:37.282211 kernel: [drm] number of cap sets: 0 May 16 05:37:37.282227 kernel: mousedev: PS/2 mouse device common for all mice May 16 05:37:37.286310 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 05:37:37.293952 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:02.0 on minor 0 May 16 05:37:37.294900 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 05:37:37.295157 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:37.305692 kernel: fbcon: virtio_gpudrmfb (fb0) is primary device May 16 05:37:37.305776 kernel: Console: switching to colour frame buffer device 160x50 May 16 05:37:37.308162 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 05:37:37.314895 kernel: virtio-pci 0000:00:02.0: [drm] fb0: virtio_gpudrmfb frame buffer device May 16 05:37:37.323415 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 05:37:37.323668 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:37.334004 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 05:37:37.335724 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 16 05:37:37.342076 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 16 05:37:37.366957 lvm[1353]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 16 05:37:37.395959 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 16 05:37:37.396678 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 16 05:37:37.402039 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 16 05:37:37.431730 lvm[1357]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 16 05:37:37.455029 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 05:37:37.458901 systemd[1]: Reached target sysinit.target - System Initialization. May 16 05:37:37.461729 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 16 05:37:37.462007 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 16 05:37:37.463544 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 16 05:37:37.463694 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 16 05:37:37.463777 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 16 05:37:37.463884 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 16 05:37:37.463927 systemd[1]: Reached target paths.target - Path Units. May 16 05:37:37.464490 systemd[1]: Reached target timers.target - Timer Units. May 16 05:37:37.467520 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 16 05:37:37.469725 systemd[1]: Starting docker.socket - Docker Socket for the API... May 16 05:37:37.474043 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 16 05:37:37.476381 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 16 05:37:37.476489 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 16 05:37:37.478726 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 16 05:37:37.479958 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 16 05:37:37.482408 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 16 05:37:37.485101 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 16 05:37:37.487787 systemd[1]: Reached target sockets.target - Socket Units. May 16 05:37:37.490445 systemd[1]: Reached target basic.target - Basic System. May 16 05:37:37.492636 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 16 05:37:37.492745 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 16 05:37:37.506030 systemd[1]: Starting containerd.service - containerd container runtime... May 16 05:37:37.511297 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... May 16 05:37:37.521008 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... May 16 05:37:37.531074 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 16 05:37:37.538564 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 16 05:37:37.553059 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 16 05:37:37.556511 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). May 16 05:37:37.560827 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 16 05:37:37.564179 coreos-metadata[1366]: May 16 05:37:37.563 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1 May 16 05:37:37.571097 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 16 05:37:37.574337 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 16 05:37:37.580554 coreos-metadata[1366]: May 16 05:37:37.580 INFO Fetch successful May 16 05:37:37.580554 coreos-metadata[1366]: May 16 05:37:37.580 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 May 16 05:37:37.581708 coreos-metadata[1365]: May 16 05:37:37.581 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1 May 16 05:37:37.585831 systemd[1]: Starting systemd-logind.service - User Login Management... May 16 05:37:37.585985 jq[1372]: false May 16 05:37:37.589484 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 16 05:37:37.590156 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 16 05:37:37.591487 coreos-metadata[1366]: May 16 05:37:37.591 INFO Fetch successful May 16 05:37:37.591487 coreos-metadata[1366]: May 16 05:37:37.591 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1 May 16 05:37:37.593071 systemd[1]: Starting update-engine.service - Update Engine... May 16 05:37:37.599883 extend-filesystems[1373]: Found loop3 May 16 05:37:37.606478 extend-filesystems[1373]: Found loop4 May 16 05:37:37.606478 extend-filesystems[1373]: Found loop5 May 16 05:37:37.606478 extend-filesystems[1373]: Found vda May 16 05:37:37.606478 extend-filesystems[1373]: Found vda1 May 16 05:37:37.606478 extend-filesystems[1373]: Found vda2 May 16 05:37:37.606478 extend-filesystems[1373]: Found vda3 May 16 05:37:37.606478 extend-filesystems[1373]: Found usr May 16 05:37:37.606478 extend-filesystems[1373]: Found vda4 May 16 05:37:37.606478 extend-filesystems[1373]: Found vda6 May 16 05:37:37.606478 extend-filesystems[1373]: Found vda7 May 16 05:37:37.606478 extend-filesystems[1373]: Found vda9 May 16 05:37:37.606478 extend-filesystems[1373]: Checking size of /dev/vda9 May 16 05:37:37.679092 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 2014203 blocks May 16 05:37:37.685095 kernel: EXT4-fs (vda9): resized filesystem to 2014203 May 16 05:37:37.601989 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.601 INFO Fetch successful May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.601 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1 May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.613 INFO Fetch successful May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.614 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1 May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.625 INFO Fetch successful May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.625 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1 May 16 05:37:37.685416 coreos-metadata[1366]: May 16 05:37:37.642 INFO Fetch successful May 16 05:37:37.641781 dbus-daemon[1369]: [system] SELinux support is enabled May 16 05:37:37.685820 coreos-metadata[1365]: May 16 05:37:37.621 INFO Fetch successful May 16 05:37:37.685820 coreos-metadata[1365]: May 16 05:37:37.621 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1 May 16 05:37:37.685820 coreos-metadata[1365]: May 16 05:37:37.621 INFO Fetch successful May 16 05:37:37.687055 extend-filesystems[1373]: Resized partition /dev/vda9 May 16 05:37:37.618303 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 16 05:37:37.709461 extend-filesystems[1392]: resize2fs 1.47.1 (20-May-2024) May 16 05:37:37.709461 extend-filesystems[1392]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required May 16 05:37:37.709461 extend-filesystems[1392]: old_desc_blocks = 1, new_desc_blocks = 1 May 16 05:37:37.709461 extend-filesystems[1392]: The filesystem on /dev/vda9 is now 2014203 (4k) blocks long. May 16 05:37:37.763980 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1321) May 16 05:37:37.618528 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 16 05:37:37.764096 jq[1381]: true May 16 05:37:37.764373 extend-filesystems[1373]: Resized filesystem in /dev/vda9 May 16 05:37:37.619077 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 16 05:37:37.619264 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 16 05:37:37.778990 update_engine[1379]: I20250516 05:37:37.758955 1379 main.cc:92] Flatcar Update Engine starting May 16 05:37:37.778990 update_engine[1379]: I20250516 05:37:37.773058 1379 update_check_scheduler.cc:74] Next update check in 6m45s May 16 05:37:37.635563 unknown[1365]: wrote ssh authorized keys file for user: core May 16 05:37:37.781175 update-ssh-keys[1398]: Updated "/home/core/.ssh/authorized_keys" May 16 05:37:37.643018 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 16 05:37:37.673280 systemd[1]: motdgen.service: Deactivated successfully. May 16 05:37:37.781547 jq[1404]: true May 16 05:37:37.673938 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 16 05:37:37.682143 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). May 16 05:37:37.682187 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 16 05:37:37.693052 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). May 16 05:37:37.693076 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 16 05:37:37.714084 systemd[1]: extend-filesystems.service: Deactivated successfully. May 16 05:37:37.714317 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 16 05:37:37.749589 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). May 16 05:37:37.779954 (ntainerd)[1406]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 16 05:37:37.807643 systemd-logind[1378]: New seat seat0. May 16 05:37:37.811849 systemd-logind[1378]: Watching system buttons on /dev/input/event1 (Power Button) May 16 05:37:37.811905 systemd-logind[1378]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) May 16 05:37:37.813481 systemd[1]: Started systemd-logind.service - User Login Management. May 16 05:37:37.820207 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. May 16 05:37:37.823237 systemd[1]: Started update-engine.service - Update Engine. May 16 05:37:37.832822 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 16 05:37:37.840424 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 16 05:37:37.879142 bash[1431]: Updated "/home/core/.ssh/authorized_keys" May 16 05:37:37.886352 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 16 05:37:37.905152 systemd[1]: Starting sshkeys.service... May 16 05:37:37.937246 systemd[1]: Finished sshkeys.service. May 16 05:37:37.994744 locksmithd[1421]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 16 05:37:38.209606 containerd[1406]: time="2025-05-16T05:37:38.209526843Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 May 16 05:37:38.262046 containerd[1406]: time="2025-05-16T05:37:38.261836971Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.263499 containerd[1406]: time="2025-05-16T05:37:38.263461257Z" 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.90-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 16 05:37:38.263499 containerd[1406]: time="2025-05-16T05:37:38.263493467Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 16 05:37:38.263583 containerd[1406]: time="2025-05-16T05:37:38.263512613Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 16 05:37:38.263710 containerd[1406]: time="2025-05-16T05:37:38.263683824Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 16 05:37:38.263739 containerd[1406]: time="2025-05-16T05:37:38.263710675Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.263805 containerd[1406]: time="2025-05-16T05:37:38.263778402Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 16 05:37:38.263805 containerd[1406]: time="2025-05-16T05:37:38.263800543Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264016659Z" 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 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264042678Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264058347Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264070470Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264167411Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264367276Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264489075Z" 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 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264504874Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264597398Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 16 05:37:38.264888 containerd[1406]: time="2025-05-16T05:37:38.264664824Z" level=info msg="metadata content store policy set" policy=shared May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.272773733Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.272813668Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.272829708Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.272846209Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.272878689Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.272994978Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273208338Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273297375Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273315348Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273330777Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273344784Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273359301Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273373568Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 16 05:37:38.274881 containerd[1406]: time="2025-05-16T05:37:38.273388235Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273402993Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273416498Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273428982Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273440623Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273460200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273475178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273488012Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273501988Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273516215Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273530502Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273548305Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273562782Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273575977Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275234 containerd[1406]: time="2025-05-16T05:37:38.273592789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273605182Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273624909Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273638264Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273652811Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273672729Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273686655Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273700601Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273739033Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273755825Z" 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 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273766655Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273779178Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273790449Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273802702Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 16 05:37:38.275526 containerd[1406]: time="2025-05-16T05:37:38.273812912Z" level=info msg="NRI interface is disabled by configuration." May 16 05:37:38.275806 containerd[1406]: time="2025-05-16T05:37:38.273823351Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 16 05:37:38.275829 containerd[1406]: time="2025-05-16T05:37:38.274158810Z" 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}" May 16 05:37:38.275829 containerd[1406]: time="2025-05-16T05:37:38.274215857Z" level=info msg="Connect containerd service" May 16 05:37:38.275829 containerd[1406]: time="2025-05-16T05:37:38.274248819Z" level=info msg="using legacy CRI server" May 16 05:37:38.275829 containerd[1406]: time="2025-05-16T05:37:38.274256634Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 16 05:37:38.275829 containerd[1406]: time="2025-05-16T05:37:38.274366901Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 16 05:37:38.276140 containerd[1406]: time="2025-05-16T05:37:38.274854104Z" 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" May 16 05:37:38.276342 containerd[1406]: time="2025-05-16T05:37:38.276314644Z" level=info msg="Start subscribing containerd event" May 16 05:37:38.276425 containerd[1406]: time="2025-05-16T05:37:38.276410854Z" level=info msg="Start recovering state" May 16 05:37:38.276524 containerd[1406]: time="2025-05-16T05:37:38.276510681Z" level=info msg="Start event monitor" May 16 05:37:38.276585 containerd[1406]: time="2025-05-16T05:37:38.276572337Z" level=info msg="Start snapshots syncer" May 16 05:37:38.276639 containerd[1406]: time="2025-05-16T05:37:38.276626899Z" level=info msg="Start cni network conf syncer for default" May 16 05:37:38.276690 containerd[1406]: time="2025-05-16T05:37:38.276678466Z" level=info msg="Start streaming server" May 16 05:37:38.277087 containerd[1406]: time="2025-05-16T05:37:38.277070311Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 16 05:37:38.277240 containerd[1406]: time="2025-05-16T05:37:38.277210644Z" level=info msg=serving... address=/run/containerd/containerd.sock May 16 05:37:38.277487 systemd[1]: Started containerd.service - containerd container runtime. May 16 05:37:38.279294 containerd[1406]: time="2025-05-16T05:37:38.279248316Z" level=info msg="containerd successfully booted in 0.068988s" May 16 05:37:38.482088 sshd_keygen[1408]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 16 05:37:38.510535 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 16 05:37:38.518359 systemd[1]: Starting issuegen.service - Generate /run/issue... May 16 05:37:38.533849 systemd[1]: issuegen.service: Deactivated successfully. May 16 05:37:38.534135 systemd[1]: Finished issuegen.service - Generate /run/issue. May 16 05:37:38.545391 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 16 05:37:38.554544 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 16 05:37:38.565144 systemd-networkd[1310]: eth0: Gained IPv6LL May 16 05:37:38.565212 systemd[1]: Started getty@tty1.service - Getty on tty1. May 16 05:37:38.566326 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:38.579269 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 16 05:37:38.580177 systemd[1]: Reached target getty.target - Login Prompts. May 16 05:37:38.583363 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 16 05:37:38.588836 systemd[1]: Reached target network-online.target - Network is Online. May 16 05:37:38.603779 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... May 16 05:37:38.604602 (-wrapper)[1465]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS May 16 05:37:38.612181 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 16 05:37:38.664052 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 16 05:37:38.859321 systemd[1]: Starting docker.service - Docker Application Container Engine... May 16 05:37:38.869461 (dockerd)[1485]: 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 May 16 05:37:39.742353 dockerd[1485]: time="2025-05-16T05:37:39.742209148Z" level=info msg="Starting up" May 16 05:37:39.960765 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport1243579919-merged.mount: Deactivated successfully. May 16 05:37:40.069810 dockerd[1485]: time="2025-05-16T05:37:40.069568741Z" level=info msg="Loading containers: start." May 16 05:37:40.317996 kernel: Initializing XFRM netlink socket May 16 05:37:40.458732 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:40.460235 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:40.473493 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:40.571501 systemd-networkd[1310]: docker0: Link UP May 16 05:37:40.572052 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:40.632452 dockerd[1485]: time="2025-05-16T05:37:40.632358674Z" level=info msg="Loading containers: done." May 16 05:37:40.665541 dockerd[1485]: time="2025-05-16T05:37:40.665430019Z" 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 May 16 05:37:40.665837 dockerd[1485]: time="2025-05-16T05:37:40.665650583Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 May 16 05:37:40.665972 dockerd[1485]: time="2025-05-16T05:37:40.665858893Z" level=info msg="Daemon has completed initialization" May 16 05:37:40.735006 dockerd[1485]: time="2025-05-16T05:37:40.734550895Z" level=info msg="API listen on /run/docker.sock" May 16 05:37:40.734712 systemd[1]: Started docker.service - Docker Application Container Engine. May 16 05:37:40.737592 etcd-wrapper[1470]: Error response from daemon: No such container: etcd-member May 16 05:37:40.767953 etcd-wrapper[1661]: Error response from daemon: No such container: etcd-member May 16 05:37:40.831962 etcd-wrapper[1679]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally May 16 05:37:40.954441 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2942840796-merged.mount: Deactivated successfully. May 16 05:37:42.203247 etcd-wrapper[1679]: v3.5.0: Pulling from coreos/etcd May 16 05:37:42.565581 etcd-wrapper[1679]: 1813d21adc01: Pulling fs layer May 16 05:37:42.565581 etcd-wrapper[1679]: 6e96907ab677: Pulling fs layer May 16 05:37:42.565581 etcd-wrapper[1679]: 444ed0ea8673: Pulling fs layer May 16 05:37:42.565581 etcd-wrapper[1679]: 0fd2df5633f0: Pulling fs layer May 16 05:37:42.565581 etcd-wrapper[1679]: 8cc22b9456bb: Pulling fs layer May 16 05:37:42.565581 etcd-wrapper[1679]: 7ac70aecd290: Pulling fs layer May 16 05:37:42.565581 etcd-wrapper[1679]: 4b376c64dfe4: Pulling fs layer May 16 05:37:42.566690 etcd-wrapper[1679]: 0fd2df5633f0: Waiting May 16 05:37:42.566690 etcd-wrapper[1679]: 8cc22b9456bb: Waiting May 16 05:37:42.566690 etcd-wrapper[1679]: 7ac70aecd290: Waiting May 16 05:37:42.566690 etcd-wrapper[1679]: 4b376c64dfe4: Waiting May 16 05:37:43.134198 etcd-wrapper[1679]: 444ed0ea8673: Verifying Checksum May 16 05:37:43.134403 etcd-wrapper[1679]: 444ed0ea8673: Download complete May 16 05:37:43.157475 etcd-wrapper[1679]: 6e96907ab677: Verifying Checksum May 16 05:37:43.157653 etcd-wrapper[1679]: 6e96907ab677: Download complete May 16 05:37:43.490098 etcd-wrapper[1679]: 1813d21adc01: Verifying Checksum May 16 05:37:43.490523 etcd-wrapper[1679]: 1813d21adc01: Download complete May 16 05:37:43.521491 etcd-wrapper[1679]: 8cc22b9456bb: Verifying Checksum May 16 05:37:43.534791 etcd-wrapper[1679]: 8cc22b9456bb: Download complete May 16 05:37:43.558113 etcd-wrapper[1679]: 0fd2df5633f0: Verifying Checksum May 16 05:37:43.558113 etcd-wrapper[1679]: 0fd2df5633f0: Download complete May 16 05:37:43.641052 login[1462]: pam_lastlog(login:session): file /var/log/lastlog is locked/read, retrying May 16 05:37:43.643479 login[1463]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 16 05:37:43.653198 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 16 05:37:43.659328 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 16 05:37:43.674631 systemd-logind[1378]: New session 2 of user core. May 16 05:37:43.688155 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 16 05:37:43.690512 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 16 05:37:43.696257 systemd[1]: Started sshd@0-172.24.4.121:22-172.24.4.1:51262.service - OpenSSH per-connection server daemon (172.24.4.1:51262). May 16 05:37:43.699033 systemd[1]: Starting user@500.service - User Manager for UID 500... May 16 05:37:43.714281 (systemd)[1702]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 16 05:37:43.720406 systemd-logind[1378]: New session c1 of user core. May 16 05:37:43.827602 etcd-wrapper[1679]: 4b376c64dfe4: Verifying Checksum May 16 05:37:43.829265 etcd-wrapper[1679]: 4b376c64dfe4: Download complete May 16 05:37:43.848623 etcd-wrapper[1679]: 7ac70aecd290: Verifying Checksum May 16 05:37:43.848926 etcd-wrapper[1679]: 7ac70aecd290: Download complete May 16 05:37:43.923732 systemd[1702]: Queued start job for default target default.target. May 16 05:37:43.927912 systemd[1702]: Created slice app.slice - User Application Slice. May 16 05:37:43.927937 systemd[1702]: Reached target paths.target - Paths. May 16 05:37:43.927984 systemd[1702]: Reached target timers.target - Timers. May 16 05:37:43.939000 systemd[1702]: Starting dbus.socket - D-Bus User Message Bus Socket... May 16 05:37:43.948823 systemd[1702]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 16 05:37:43.948917 systemd[1702]: Reached target sockets.target - Sockets. May 16 05:37:43.948960 systemd[1702]: Reached target basic.target - Basic System. May 16 05:37:43.949002 systemd[1702]: Reached target default.target - Main User Target. May 16 05:37:43.949031 systemd[1702]: Startup finished in 217ms. May 16 05:37:43.950126 systemd[1]: Started user@500.service - User Manager for UID 500. May 16 05:37:43.957423 systemd[1]: Started session-2.scope - Session 2 of User core. May 16 05:37:44.645183 login[1462]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 16 05:37:44.656114 systemd-logind[1378]: New session 1 of user core. May 16 05:37:44.659339 systemd[1]: Started session-1.scope - Session 1 of User core. May 16 05:37:44.682687 etcd-wrapper[1679]: 1813d21adc01: Pull complete May 16 05:37:44.913161 systemd[1]: var-lib-docker-overlay2-af56b2fcc0c8d130706d348dd135f6262131f74f9ff8b8f1d9e3ef7096eee4dc-merged.mount: Deactivated successfully. May 16 05:37:45.202916 sshd[1701]: Accepted publickey for core from 172.24.4.1 port 51262 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:37:45.206198 sshd-session[1701]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:37:45.219437 systemd-logind[1378]: New session 3 of user core. May 16 05:37:45.226212 systemd[1]: Started session-3.scope - Session 3 of User core. May 16 05:37:45.560134 etcd-wrapper[1679]: 6e96907ab677: Pull complete May 16 05:37:45.823148 systemd[1]: var-lib-docker-overlay2-feba7236054f46f19971930a3ede2099bad33e0872db0aa0838e7a14f5519aaa-merged.mount: Deactivated successfully. May 16 05:37:45.915400 systemd[1]: Started sshd@1-172.24.4.121:22-172.24.4.1:51268.service - OpenSSH per-connection server daemon (172.24.4.1:51268). May 16 05:37:45.935595 etcd-wrapper[1679]: 444ed0ea8673: Pull complete May 16 05:37:46.132902 systemd[1]: var-lib-docker-overlay2-0ee824ee74103d69804b335ed6f2f783979cb7e2300671af6a62f815e9c57bfa-merged.mount: Deactivated successfully. May 16 05:37:46.237676 etcd-wrapper[1679]: 0fd2df5633f0: Pull complete May 16 05:37:46.276281 systemd[1]: var-lib-docker-overlay2-52cc3d0aa68d97ff7a8a058a03027306f7c2496f876a8df86dc32419def9c97b-merged.mount: Deactivated successfully. May 16 05:37:46.302694 etcd-wrapper[1679]: 8cc22b9456bb: Pull complete May 16 05:37:46.370098 etcd-wrapper[1679]: 7ac70aecd290: Pull complete May 16 05:37:46.423105 etcd-wrapper[1679]: 4b376c64dfe4: Pull complete May 16 05:37:46.443586 etcd-wrapper[1679]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b May 16 05:37:46.453985 etcd-wrapper[1679]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 May 16 05:37:46.816166 containerd[1406]: time="2025-05-16T05:37:46.815564364Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 05:37:46.816166 containerd[1406]: time="2025-05-16T05:37:46.815664642Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 05:37:46.816166 containerd[1406]: time="2025-05-16T05:37:46.815702383Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:37:46.816166 containerd[1406]: time="2025-05-16T05:37:46.815837476Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:37:46.849371 systemd[1]: Started docker-60873285e41407c926653bb4f6622f29f26c7e3446068dc23ae52e6c6931978e.scope - libcontainer container 60873285e41407c926653bb4f6622f29f26c7e3446068dc23ae52e6c6931978e. May 16 05:37:46.942330 etcd-wrapper[1679]: {"level":"info","ts":1747373866.9419148,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} May 16 05:37:46.943000 etcd-wrapper[1679]: {"level":"info","ts":1747373866.942335,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"17432d80addb40679162c36cfb91b1bf"} May 16 05:37:46.943000 etcd-wrapper[1679]: {"level":"warn","ts":1747373866.9425516,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} May 16 05:37:46.944113 etcd-wrapper[1679]: {"level":"warn","ts":1747373866.9427142,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} May 16 05:37:46.944113 etcd-wrapper[1679]: {"level":"warn","ts":1747373866.9427457,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} May 16 05:37:46.944113 etcd-wrapper[1679]: {"level":"warn","ts":1747373866.9427598,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} May 16 05:37:46.944113 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:46.942Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.24.4.121:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.24.4.121:2380","--advertise-client-urls=http://172.24.4.121:2379","--discovery=https://discovery.etcd.io/a1fba48abcea8732d6c2bc0550fee5c7","--enable-v2=true"]} May 16 05:37:46.944113 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:46.943Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://172.24.4.121:2380"]} May 16 05:37:46.944113 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:46.943Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} May 16 05:37:46.944512 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:46.943Z","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":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"17432d80addb40679162c36cfb91b1bf","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://172.24.4.121:2380"],"listen-peer-urls":["http://172.24.4.121:2380"],"advertise-client-urls":["http://172.24.4.121:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"17432d80addb40679162c36cfb91b1bf=http://172.24.4.121:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/a1fba48abcea8732d6c2bc0550fee5c7","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":"https://discovery.etcd.io/a1fba48abcea8732d6c2bc0550fee5c7","discovery-proxy":"","downgrade-check-interval":"5s"} May 16 05:37:46.949673 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:46.949Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.387478ms"} May 16 05:37:47.324434 sshd[1745]: Accepted publickey for core from 172.24.4.1 port 51268 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:37:47.326567 sshd-session[1745]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:37:47.335966 systemd-logind[1378]: New session 4 of user core. May 16 05:37:47.351179 systemd[1]: Started session-4.scope - Session 4 of User core. May 16 05:37:47.954505 sshd[1812]: Connection closed by 172.24.4.1 port 51268 May 16 05:37:47.954822 sshd-session[1745]: pam_unix(sshd:session): session closed for user core May 16 05:37:47.969142 systemd[1]: sshd@1-172.24.4.121:22-172.24.4.1:51268.service: Deactivated successfully. May 16 05:37:47.972322 systemd[1]: session-4.scope: Deactivated successfully. May 16 05:37:47.974793 systemd-logind[1378]: Session 4 logged out. Waiting for processes to exit. May 16 05:37:47.980442 systemd[1]: Started sshd@2-172.24.4.121:22-172.24.4.1:51274.service - OpenSSH per-connection server daemon (172.24.4.1:51274). May 16 05:37:47.983293 systemd-logind[1378]: Removed session 4. May 16 05:37:48.074617 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:48.074Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"76bb1a5cfdb1ab60"} May 16 05:37:48.076169 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:48.074Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"3e3709663cbbde08"} May 16 05:37:48.076169 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:48.075Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":2,"needed-peers":1} May 16 05:37:49.441344 sshd[1817]: Accepted publickey for core from 172.24.4.1 port 51274 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:37:49.444789 sshd-session[1817]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:37:49.458982 systemd-logind[1378]: New session 5 of user core. May 16 05:37:49.470300 systemd[1]: Started session-5.scope - Session 5 of User core. May 16 05:37:50.061168 sshd[1820]: Connection closed by 172.24.4.1 port 51274 May 16 05:37:50.061761 sshd-session[1817]: pam_unix(sshd:session): session closed for user core May 16 05:37:50.064688 systemd[1]: sshd@2-172.24.4.121:22-172.24.4.1:51274.service: Deactivated successfully. May 16 05:37:50.066472 systemd[1]: session-5.scope: Deactivated successfully. May 16 05:37:50.068130 systemd-logind[1378]: Session 5 logged out. Waiting for processes to exit. May 16 05:37:50.069722 systemd-logind[1378]: Removed session 5. May 16 05:37:51.532573 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.531Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"d8528f75f71ac082"} May 16 05:37:51.532573 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.531Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} May 16 05:37:51.542624 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.542Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"3e3709663cbbde08","cluster-id":"f384eccd80dfbdc3"} May 16 05:37:51.543063 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=()"} May 16 05:37:51.543063 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became follower at term 0"} May 16 05:37:51.543063 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3e3709663cbbde08 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} May 16 05:37:51.543598 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became follower at term 1"} May 16 05:37:51.543598 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320)"} May 16 05:37:51.543598 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920)"} May 16 05:37:51.544279 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920 15587678997102379138)"} May 16 05:37:51.546445 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:51.546Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} May 16 05:37:51.548809 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.548Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} May 16 05:37:51.550613 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.550Z","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"} May 16 05:37:51.552593 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.552Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.553016 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.552Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.555964 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.553Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.557816 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.556Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.559520 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.558Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.559520 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.558Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60","remote-peer-urls":["http://172.24.4.32:2380"]} May 16 05:37:51.559520 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.558Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.559520 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.558Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.559520 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.558Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.559520 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.558Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.564338 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.561Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.564338 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.562Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.564338 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.562Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.564338 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.563Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082","remote-peer-urls":["http://172.24.4.236:2380"]} May 16 05:37:51.564338 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.563Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"3e3709663cbbde08","local-server-version":"3.5.0","cluster-version":"to_be_decided"} May 16 05:37:51.569905 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.569Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.571401 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:51.571Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} May 16 05:37:51.571945 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.571Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.573300 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920 15587678997102379138)"} May 16 05:37:51.574434 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.574Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","added-peer-id":"3e3709663cbbde08","added-peer-peer-urls":["http://172.24.4.121:2380"]} May 16 05:37:51.574921 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.574Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"172.24.4.121:2380"} May 16 05:37:51.574921 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.574Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"172.24.4.121:2380"} May 16 05:37:51.575500 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.575Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"3e3709663cbbde08","initial-advertise-peer-urls":["http://172.24.4.121:2380"],"listen-peer-urls":["http://172.24.4.121:2380"],"advertise-client-urls":["http://172.24.4.121:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} May 16 05:37:51.576218 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920 15587678997102379138)"} May 16 05:37:51.577094 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.576Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","added-peer-id":"76bb1a5cfdb1ab60","added-peer-peer-urls":["http://172.24.4.32:2380"]} May 16 05:37:51.577094 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.576Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} May 16 05:37:51.578008 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920 15587678997102379138)"} May 16 05:37:51.578922 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.578Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","added-peer-id":"d8528f75f71ac082","added-peer-peer-urls":["http://172.24.4.236:2380"]} May 16 05:37:51.582214 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.581Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"76bb1a5cfdb1ab60","stream-type":"stream MsgApp v2"} May 16 05:37:51.582741 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.582Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.583159 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.582Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.584555 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.584Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"76bb1a5cfdb1ab60","stream-type":"stream Message"} May 16 05:37:51.584555 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.584Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.605710 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.605Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.605710 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.605Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:51.920029 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.919Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"d8528f75f71ac082","stream-type":"stream Message"} May 16 05:37:51.920029 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.919Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d8528f75f71ac082"} May 16 05:37:51.920029 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.919Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.920029 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.919Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"d8528f75f71ac082","stream-type":"stream MsgApp v2"} May 16 05:37:51.920029 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.919Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.922555 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.921Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.922555 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.921Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:51.930479 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.930Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"3e3709663cbbde08","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} May 16 05:37:51.931086 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.930Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 is starting a new election at term 1"} May 16 05:37:51.931600 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became pre-candidate at term 1"} May 16 05:37:51.932024 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 received MsgPreVoteResp from 3e3709663cbbde08 at term 1"} May 16 05:37:51.932945 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 1, index: 3] sent MsgPreVote request to 76bb1a5cfdb1ab60 at term 1"} May 16 05:37:51.932945 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 1, index: 3] sent MsgPreVote request to d8528f75f71ac082 at term 1"} May 16 05:37:51.934275 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 received MsgPreVoteResp from d8528f75f71ac082 at term 1"} May 16 05:37:51.934275 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 has received 2 MsgPreVoteResp votes and 0 vote rejections"} May 16 05:37:51.934275 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became candidate at term 2"} May 16 05:37:51.934275 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 received MsgVoteResp from 3e3709663cbbde08 at term 2"} May 16 05:37:51.934275 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 1, index: 3] sent MsgVote request to 76bb1a5cfdb1ab60 at term 2"} May 16 05:37:51.934275 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 1, index: 3] sent MsgVote request to d8528f75f71ac082 at term 2"} May 16 05:37:51.937629 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 received MsgVoteResp from d8528f75f71ac082 at term 2"} May 16 05:37:51.937629 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 has received 2 MsgVoteResp votes and 0 vote rejections"} May 16 05:37:51.937629 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became leader at term 2"} May 16 05:37:51.937629 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e3709663cbbde08 elected leader 3e3709663cbbde08 at term 2"} May 16 05:37:51.946361 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.945Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"3e3709663cbbde08","local-member-attributes":"{Name:17432d80addb40679162c36cfb91b1bf ClientURLs:[http://172.24.4.121:2379]}","request-path":"/0/members/3e3709663cbbde08/attributes","cluster-id":"f384eccd80dfbdc3","publish-timeout":"7s"} May 16 05:37:51.946361 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.945Z","caller":"etcdserver/server.go:2476","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} May 16 05:37:51.948288 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.947Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} May 16 05:37:51.948853 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.948Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} May 16 05:37:51.951629 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.949Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} May 16 05:37:51.951629 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.950Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} May 16 05:37:51.951655 systemd[1]: Started etcd-member.service - etcd (System Application Container). May 16 05:37:51.955555 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.954Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","cluster-version":"3.5"} May 16 05:37:51.957962 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.957Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} May 16 05:37:51.958697 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:51.957Z","caller":"etcdserver/server.go:2500","msg":"cluster version is updated","cluster-version":"3.5"} May 16 05:37:51.969385 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... May 16 05:37:52.166743 etcdctl[1829]: { "Network": "10.254.0.0/16", "Backend": {"Type": "udp"} } May 16 05:37:52.224194 flannel-wrapper[1837]: Error response from daemon: No such container: flannel May 16 05:37:52.240380 flannel-wrapper[1844]: Error response from daemon: No such container: flannel May 16 05:37:52.263299 flannel-wrapper[1859]: Unable to find image 'quay.io/coreos/flannel:v0.14.0' locally May 16 05:37:53.537112 flannel-wrapper[1859]: v0.14.0: Pulling from coreos/flannel May 16 05:37:53.964299 flannel-wrapper[1859]: 801bfaa63ef2: Pulling fs layer May 16 05:37:53.964299 flannel-wrapper[1859]: e4264a7179f6: Pulling fs layer May 16 05:37:53.964299 flannel-wrapper[1859]: bc75ea45ad2e: Pulling fs layer May 16 05:37:53.964299 flannel-wrapper[1859]: 78648579d12a: Pulling fs layer May 16 05:37:53.964299 flannel-wrapper[1859]: 3393447261e4: Pulling fs layer May 16 05:37:53.964299 flannel-wrapper[1859]: 071b96dd834b: Pulling fs layer May 16 05:37:53.964299 flannel-wrapper[1859]: 4de2f0468a91: Pulling fs layer May 16 05:37:53.966086 flannel-wrapper[1859]: 78648579d12a: Waiting May 16 05:37:53.966086 flannel-wrapper[1859]: 3393447261e4: Waiting May 16 05:37:53.966086 flannel-wrapper[1859]: 071b96dd834b: Waiting May 16 05:37:53.966086 flannel-wrapper[1859]: 4de2f0468a91: Waiting May 16 05:37:54.442948 flannel-wrapper[1859]: 801bfaa63ef2: Verifying Checksum May 16 05:37:54.443140 flannel-wrapper[1859]: 801bfaa63ef2: Download complete May 16 05:37:54.471631 flannel-wrapper[1859]: bc75ea45ad2e: Verifying Checksum May 16 05:37:54.471991 flannel-wrapper[1859]: bc75ea45ad2e: Download complete May 16 05:37:54.496168 flannel-wrapper[1859]: e4264a7179f6: Verifying Checksum May 16 05:37:54.496555 flannel-wrapper[1859]: e4264a7179f6: Download complete May 16 05:37:54.622569 flannel-wrapper[1859]: 801bfaa63ef2: Pull complete May 16 05:37:54.840733 flannel-wrapper[1859]: 3393447261e4: Verifying Checksum May 16 05:37:54.840733 flannel-wrapper[1859]: 3393447261e4: Download complete May 16 05:37:54.951534 flannel-wrapper[1859]: 071b96dd834b: Verifying Checksum May 16 05:37:54.951934 flannel-wrapper[1859]: 071b96dd834b: Download complete May 16 05:37:55.011192 systemd[1]: var-lib-docker-overlay2-615cafc9021609b6379cb4ddc45f459315fcf4d7fe8063b4c10595089a154c5a-merged.mount: Deactivated successfully. May 16 05:37:55.356761 flannel-wrapper[1859]: 78648579d12a: Verifying Checksum May 16 05:37:55.356761 flannel-wrapper[1859]: 78648579d12a: Download complete May 16 05:37:55.511951 flannel-wrapper[1859]: 4de2f0468a91: Download complete May 16 05:37:55.550810 flannel-wrapper[1859]: e4264a7179f6: Pull complete May 16 05:37:55.688560 systemd[1]: var-lib-docker-overlay2-6494d9d4331a2ca3c8fb92ce2c6758e86cd6e9bc7e885e98bead49fb81a85f54-merged.mount: Deactivated successfully. May 16 05:37:55.787475 flannel-wrapper[1859]: bc75ea45ad2e: Pull complete May 16 05:37:56.307668 systemd[1]: var-lib-docker-overlay2-c0aa8bb0c3da530030886a9da0fdcb57b40c22b31caa8f6a90d24830fe093d5b-merged.mount: Deactivated successfully. May 16 05:37:57.006500 flannel-wrapper[1859]: 78648579d12a: Pull complete May 16 05:37:57.051203 systemd[1]: var-lib-docker-overlay2-1b97b829d9232f394273a25c491bf84c0c8d03ee26a2588bfc7ea6422ff250cf-merged.mount: Deactivated successfully. May 16 05:37:57.067309 flannel-wrapper[1859]: 3393447261e4: Pull complete May 16 05:37:57.106827 systemd[1]: var-lib-docker-overlay2-56914598d867d29eaa3514fc459bee0170be8d99600a790a3a451557686089ed-merged.mount: Deactivated successfully. May 16 05:37:57.124434 flannel-wrapper[1859]: 071b96dd834b: Pull complete May 16 05:37:57.187962 flannel-wrapper[1859]: 4de2f0468a91: Pull complete May 16 05:37:57.206811 flannel-wrapper[1859]: Digest: sha256:4a330b2f2e74046e493b2edc30d61fdebbdddaaedcb32d62736f25be8d3c64d5 May 16 05:37:57.216355 flannel-wrapper[1859]: Status: Downloaded newer image for quay.io/coreos/flannel:v0.14.0 May 16 05:37:57.371117 containerd[1406]: time="2025-05-16T05:37:57.370215199Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 05:37:57.371117 containerd[1406]: time="2025-05-16T05:37:57.370370380Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 05:37:57.371117 containerd[1406]: time="2025-05-16T05:37:57.370424291Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:37:57.371117 containerd[1406]: time="2025-05-16T05:37:57.370655786Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:37:57.402028 systemd[1]: Started docker-3218234fa034d144ec007fa4def37f01b492d6f1ebb46cdd2ea2a844e5ae8ef0.scope - libcontainer container 3218234fa034d144ec007fa4def37f01b492d6f1ebb46cdd2ea2a844e5ae8ef0. May 16 05:37:57.453275 flannel-wrapper[1859]: I0516 05:37:57.452389 1 main.go:520] Determining IP address of default interface May 16 05:37:57.454393 flannel-wrapper[1859]: I0516 05:37:57.453891 1 main.go:533] Using interface with name eth0 and address 172.24.4.121 May 16 05:37:57.454393 flannel-wrapper[1859]: I0516 05:37:57.453928 1 main.go:550] Defaulting external address to interface address (172.24.4.121) May 16 05:37:57.454393 flannel-wrapper[1859]: I0516 05:37:57.454028 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: None May 16 05:37:57.454393 flannel-wrapper[1859]: I0516 05:37:57.454034 1 main.go:257] Installing signal handlers May 16 05:37:57.458038 flannel-wrapper[1859]: I0516 05:37:57.457695 1 main.go:392] Found network config - Backend type: udp May 16 05:37:57.462173 flannel-wrapper[1859]: I0516 05:37:57.461853 1 local_manager.go:234] Picking subnet in range 10.254.1.0 ... 10.254.255.0 May 16 05:37:57.464175 flannel-wrapper[1859]: I0516 05:37:57.463892 1 local_manager.go:220] Allocated lease (10.254.87.0/24) to current node (172.24.4.121) May 16 05:37:57.472901 kernel: tun: Universal TUN/TAP device driver, 1.6 May 16 05:37:57.475520 systemd-timesyncd[1295]: Network configuration changed, trying to establish connection. May 16 05:37:57.476726 systemd-networkd[1310]: flannel0: Link UP May 16 05:37:57.478335 flannel-wrapper[1859]: I0516 05:37:57.476530 1 main.go:357] Current network or subnet (10.254.0.0/16, 10.254.87.0/24) is not equal to previous one (0.0.0.0/0, 0.0.0.0/0), trying to recycle old iptables rules May 16 05:37:57.477616 systemd-networkd[1310]: flannel0: Gained carrier May 16 05:37:57.477996 systemd-networkd[1310]: flannel0: Gained IPv6LL May 16 05:37:57.503583 flannel-wrapper[1859]: I0516 05:37:57.503265 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN May 16 05:37:57.505324 flannel-wrapper[1859]: I0516 05:37:57.505025 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully May 16 05:37:57.507080 flannel-wrapper[1859]: I0516 05:37:57.506641 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN May 16 05:37:57.508446 flannel-wrapper[1859]: I0516 05:37:57.508105 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j MASQUERADE --random-fully May 16 05:37:57.509837 flannel-wrapper[1859]: I0516 05:37:57.509532 1 main.go:307] Setting up masking rules May 16 05:37:57.510813 flannel-wrapper[1859]: I0516 05:37:57.510527 1 main.go:315] Changing default FORWARD chain policy to ACCEPT May 16 05:37:57.510813 flannel-wrapper[1859]: I0516 05:37:57.510647 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env May 16 05:37:57.510813 flannel-wrapper[1859]: I0516 05:37:57.510660 1 main.go:327] Running backend. May 16 05:37:57.510958 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). May 16 05:37:57.511470 systemd[1]: Reached target multi-user.target - Multi-User System. May 16 05:37:57.513838 flannel-wrapper[1859]: I0516 05:37:57.512632 1 udp_network_amd64.go:100] Watching for new subnet leases May 16 05:37:57.517023 flannel-wrapper[1859]: I0516 05:37:57.514590 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules May 16 05:37:57.517023 flannel-wrapper[1859]: I0516 05:37:57.514607 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -j ACCEPT May 16 05:37:57.518119 flannel-wrapper[1859]: I0516 05:37:57.517954 1 iptables.go:172] Deleting iptables rule: -d 10.254.0.0/16 -j ACCEPT May 16 05:37:57.519445 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... May 16 05:37:57.523139 flannel-wrapper[1859]: I0516 05:37:57.520661 1 main.go:439] Waiting for 22h59m59.941640016s to renew lease May 16 05:37:57.523139 flannel-wrapper[1859]: I0516 05:37:57.520759 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -j ACCEPT May 16 05:37:57.523991 flannel-wrapper[1859]: I0516 05:37:57.523802 1 udp_network_amd64.go:196] Subnet added: 10.254.99.0/24 May 16 05:37:57.526094 flannel-wrapper[1859]: I0516 05:37:57.525974 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules May 16 05:37:57.526210 flannel-wrapper[1859]: I0516 05:37:57.526097 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN May 16 05:37:57.527276 sh[1986]: + for try in 1 2 3 4 5 6 May 16 05:37:57.527713 sh[1986]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i May 16 05:37:57.528730 flannel-wrapper[1859]: I0516 05:37:57.528599 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully May 16 05:37:57.529573 flannel-wrapper[1859]: I0516 05:37:57.529453 1 iptables.go:160] Adding iptables rule: -d 10.254.0.0/16 -j ACCEPT May 16 05:37:57.531946 flannel-wrapper[1859]: I0516 05:37:57.531797 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.87.0/24 -j RETURN May 16 05:37:57.532943 flannel-wrapper[1859]: I0516 05:37:57.532758 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully May 16 05:37:57.534771 flannel-wrapper[1859]: I0516 05:37:57.534581 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN May 16 05:37:57.536684 flannel-wrapper[1859]: I0516 05:37:57.536539 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully May 16 05:37:57.540402 flannel-wrapper[1859]: I0516 05:37:57.538580 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.87.0/24 -j RETURN May 16 05:37:57.540648 flannel-wrapper[1859]: I0516 05:37:57.540497 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully May 16 05:37:57.551641 sh[2003]: Error response from daemon: No such container: flannel-docker-opts May 16 05:37:57.566657 sh[2018]: Error response from daemon: No such container: flannel-docker-opts May 16 05:37:57.599355 flannel-wrapper[1859]: I0516 05:37:57.598695 1 udp_network_amd64.go:196] Subnet added: 10.254.57.0/24 May 16 05:37:57.639308 systemd-timesyncd[1295]: Contacted time server 137.110.222.27:123 (2.flatcar.pool.ntp.org). May 16 05:37:57.639409 systemd-timesyncd[1295]: Initial clock synchronization to Fri 2025-05-16 05:37:57.753245 UTC. May 16 05:37:57.718993 containerd[1406]: time="2025-05-16T05:37:57.718772629Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 05:37:57.718993 containerd[1406]: time="2025-05-16T05:37:57.718838392Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 05:37:57.718993 containerd[1406]: time="2025-05-16T05:37:57.718877004Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:37:57.719474 containerd[1406]: time="2025-05-16T05:37:57.718977222Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:37:57.746236 systemd[1]: Started docker-d8a0bebe4e8a38f38cc16cdc00958275a5f496efcbf36fc8975ff5b0b8bc6880.scope - libcontainer container d8a0bebe4e8a38f38cc16cdc00958275a5f496efcbf36fc8975ff5b0b8bc6880. May 16 05:37:57.792344 systemd[1]: docker-d8a0bebe4e8a38f38cc16cdc00958275a5f496efcbf36fc8975ff5b0b8bc6880.scope: Deactivated successfully. May 16 05:37:57.813312 dockerd[1485]: time="2025-05-16T05:37:57.813251143Z" level=info msg="ignoring event" container=d8a0bebe4e8a38f38cc16cdc00958275a5f496efcbf36fc8975ff5b0b8bc6880 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 16 05:37:57.814818 containerd[1406]: time="2025-05-16T05:37:57.814756757Z" level=info msg="shim disconnected" id=d8a0bebe4e8a38f38cc16cdc00958275a5f496efcbf36fc8975ff5b0b8bc6880 namespace=moby May 16 05:37:57.814818 containerd[1406]: time="2025-05-16T05:37:57.814806570Z" level=warning msg="cleaning up after shim disconnected" id=d8a0bebe4e8a38f38cc16cdc00958275a5f496efcbf36fc8975ff5b0b8bc6880 namespace=moby May 16 05:37:57.815050 containerd[1406]: time="2025-05-16T05:37:57.814819745Z" level=info msg="cleaning up dead shim" namespace=moby May 16 05:37:57.828001 containerd[1406]: time="2025-05-16T05:37:57.827840004Z" level=warning msg="cleanup warnings time=\"2025-05-16T05:37:57Z\" 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 May 16 05:37:57.865305 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 16 05:37:57.867606 dockerd[1485]: time="2025-05-16T05:37:57.865169796Z" level=info msg="Processing signal 'terminated'" May 16 05:37:57.878701 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.877Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} May 16 05:37:57.878701 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.877Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"17432d80addb40679162c36cfb91b1bf","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://172.24.4.121:2380"],"advertise-client-urls":["http://172.24.4.121:2379"]} May 16 05:37:57.893298 flannel-wrapper[1859]: I0516 05:37:57.886591 1 watch.go:40] context canceled, close receiver chan May 16 05:37:57.893298 flannel-wrapper[1859]: I0516 05:37:57.887193 1 udp_network_amd64.go:114] evts chan closed May 16 05:37:57.893298 flannel-wrapper[1859]: I0516 05:37:57.886813 1 main.go:376] shutdownHandler sent cancel signal... May 16 05:37:57.893298 flannel-wrapper[1859]: I0516 05:37:57.886978 1 watch.go:174] context canceled, close receiver chan May 16 05:37:57.893298 flannel-wrapper[1859]: I0516 05:37:57.887244 1 main.go:432] Stopped monitoring lease May 16 05:37:57.893298 flannel-wrapper[1859]: I0516 05:37:57.887251 1 main.go:345] Waiting for all goroutines to exit May 16 05:37:57.893955 systemd-networkd[1310]: flannel0: Link DOWN May 16 05:37:57.893961 systemd-networkd[1310]: flannel0: Lost carrier May 16 05:37:57.899770 flannel-wrapper[1859]: I0516 05:37:57.898671 1 main.go:348] Exiting cleanly... May 16 05:37:57.900279 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.897Z","caller":"etcdserver/server.go:1398","msg":"leadership transfer starting","local-member-id":"3e3709663cbbde08","current-leader-member-id":"3e3709663cbbde08","transferee-member-id":"76bb1a5cfdb1ab60"} May 16 05:37:57.900279 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [term 2] starts to transfer leadership to 76bb1a5cfdb1ab60"} May 16 05:37:57.900279 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 sends MsgTimeoutNow to 76bb1a5cfdb1ab60 immediately as 76bb1a5cfdb1ab60 already has up-to-date log"} May 16 05:37:57.900279 etcd-wrapper[1679]: WARNING: 2025/05/16 05:37:57 [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: operation was canceled". Reconnecting... May 16 05:37:57.901635 systemd[1]: docker-3218234fa034d144ec007fa4def37f01b492d6f1ebb46cdd2ea2a844e5ae8ef0.scope: Deactivated successfully. May 16 05:37:57.904281 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [term: 2] received a MsgVote message with higher term from 76bb1a5cfdb1ab60 [term: 3]"} May 16 05:37:57.904281 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became follower at term 3"} May 16 05:37:57.904281 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 2, index: 30, vote: 0] cast MsgVote for 76bb1a5cfdb1ab60 [logterm: 2, index: 30] at term 3"} May 16 05:37:57.904281 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e3709663cbbde08 lost leader 3e3709663cbbde08 at term 3"} May 16 05:37:57.907542 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e3709663cbbde08 elected leader 76bb1a5cfdb1ab60 at term 3"} May 16 05:37:57.918328 dockerd[1485]: time="2025-05-16T05:37:57.918282650Z" level=info msg="ignoring event" container=3218234fa034d144ec007fa4def37f01b492d6f1ebb46cdd2ea2a844e5ae8ef0 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 16 05:37:57.918501 containerd[1406]: time="2025-05-16T05:37:57.918379752Z" level=info msg="shim disconnected" id=3218234fa034d144ec007fa4def37f01b492d6f1ebb46cdd2ea2a844e5ae8ef0 namespace=moby May 16 05:37:57.918501 containerd[1406]: time="2025-05-16T05:37:57.918432861Z" level=warning msg="cleaning up after shim disconnected" id=3218234fa034d144ec007fa4def37f01b492d6f1ebb46cdd2ea2a844e5ae8ef0 namespace=moby May 16 05:37:57.918501 containerd[1406]: time="2025-05-16T05:37:57.918443591Z" level=info msg="cleaning up dead shim" namespace=moby May 16 05:37:57.931570 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.930Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082","error":"EOF"} May 16 05:37:57.931570 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.930Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082","error":"EOF"} May 16 05:37:57.935511 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.935Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"d8528f75f71ac082","error":"failed to dial d8528f75f71ac082 on stream MsgApp v2 (peer d8528f75f71ac082 failed to find local node 3e3709663cbbde08)"} May 16 05:37:57.998125 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.997Z","caller":"etcdserver/server.go:1415","msg":"leadership transfer finished","local-member-id":"3e3709663cbbde08","old-leader-member-id":"3e3709663cbbde08","new-leader-member-id":"76bb1a5cfdb1ab60","took":"100.322104ms"} May 16 05:37:57.999165 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.997Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:57.999165 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.998Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:57.999165 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.998Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60","error":"context canceled"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"76bb1a5cfdb1ab60","error":"failed to read 76bb1a5cfdb1ab60 on stream MsgApp v2 (context canceled)"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60","error":"context canceled"} May 16 05:37:58.001122 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.002119 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:37:58.002119 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:57.999Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002119 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:58.000Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002119 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.000Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002119 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:58.001Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002119 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.001Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002699 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.002Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002699 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.002Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002870 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.002Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.002870 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.002Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"d8528f75f71ac082"} May 16 05:37:58.004019 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:58.003Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"3e3709663cbbde08","remote-peer-id-stream-handler":"3e3709663cbbde08","remote-peer-id-from":"76bb1a5cfdb1ab60","cluster-id":"f384eccd80dfbdc3"} May 16 05:37:58.005822 etcd-wrapper[1679]: {"level":"warn","ts":"2025-05-16T05:37:58.004Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"3e3709663cbbde08","remote-peer-id-stream-handler":"3e3709663cbbde08","remote-peer-id-from":"76bb1a5cfdb1ab60","cluster-id":"f384eccd80dfbdc3"} May 16 05:37:58.007329 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:58.007Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"172.24.4.121:2380"} May 16 05:37:58.034666 systemd[1]: var-lib-docker-overlay2-f53e2cdd5124c498dd6651d282233cf5c61bb8529faff253b0eca424a89d29ad-merged.mount: Deactivated successfully. May 16 05:37:59.008683 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:59.007Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"172.24.4.121:2380"} May 16 05:37:59.008683 etcd-wrapper[1679]: {"level":"info","ts":"2025-05-16T05:37:59.008Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"17432d80addb40679162c36cfb91b1bf","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://172.24.4.121:2380"],"advertise-client-urls":["http://172.24.4.121:2379"]} May 16 05:37:59.011785 systemd[1]: docker-60873285e41407c926653bb4f6622f29f26c7e3446068dc23ae52e6c6931978e.scope: Deactivated successfully. May 16 05:37:59.046452 dockerd[1485]: time="2025-05-16T05:37:59.046362506Z" level=info msg="ignoring event" container=60873285e41407c926653bb4f6622f29f26c7e3446068dc23ae52e6c6931978e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 16 05:37:59.047592 containerd[1406]: time="2025-05-16T05:37:59.046682424Z" level=info msg="shim disconnected" id=60873285e41407c926653bb4f6622f29f26c7e3446068dc23ae52e6c6931978e namespace=moby May 16 05:37:59.047592 containerd[1406]: time="2025-05-16T05:37:59.046767419Z" level=warning msg="cleaning up after shim disconnected" id=60873285e41407c926653bb4f6622f29f26c7e3446068dc23ae52e6c6931978e namespace=moby May 16 05:37:59.047592 containerd[1406]: time="2025-05-16T05:37:59.046796198Z" level=info msg="cleaning up dead shim" namespace=moby May 16 05:37:59.096921 systemd[1]: var-lib-docker-overlay2-031931e27ac89f3249b058e1964ffdead3995fed845d85ec2e5269445ab0beed-merged.mount: Deactivated successfully. May 16 05:37:59.130217 dockerd[1485]: time="2025-05-16T05:37:59.130119603Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby May 16 05:37:59.131161 dockerd[1485]: time="2025-05-16T05:37:59.130313909Z" level=info msg="Daemon shutdown complete" May 16 05:37:59.452519 systemd[1]: docker.service: Deactivated successfully. May 16 05:37:59.453143 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 16 05:37:59.453266 systemd[1]: docker.service: Consumed 7.298s CPU time, 374.3M memory peak. May 16 05:37:59.455636 systemd[1]: docker.socket: Deactivated successfully. May 16 05:37:59.458186 docker[2175]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? May 16 05:37:59.459275 docker[2148]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? May 16 05:37:59.459750 systemd[1]: Closed docker.socket - Docker Socket for the API. May 16 05:37:59.459967 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 16 05:37:59.464173 systemd[1]: Starting docker.socket - Docker Socket for the API... May 16 05:37:59.472198 systemd[1]: flanneld.service: Control process exited, code=exited, status=1/FAILURE May 16 05:37:59.474832 systemd[1]: etcd-member.service: Control process exited, code=exited, status=1/FAILURE May 16 05:37:59.481141 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 16 05:37:59.495672 systemd[1]: Starting docker.service - Docker Application Container Engine... May 16 05:37:59.519393 (dockerd)[2190]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS May 16 05:37:59.570142 dockerd[2190]: time="2025-05-16T05:37:59.570061097Z" level=info msg="Starting up" May 16 05:37:59.633757 dockerd[2190]: time="2025-05-16T05:37:59.633686893Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 16 05:37:59.654261 dockerd[2190]: time="2025-05-16T05:37:59.654094826Z" level=info msg="Loading containers: start." May 16 05:38:00.117686 systemd[1]: Started sshd@3-172.24.4.121:22-172.24.4.1:33832.service - OpenSSH per-connection server daemon (172.24.4.1:33832). May 16 05:38:00.242428 dockerd[2190]: time="2025-05-16T05:38:00.242211115Z" level=info msg="Loading containers: done." May 16 05:38:00.267046 dockerd[2190]: time="2025-05-16T05:38:00.266954199Z" 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 May 16 05:38:00.267355 dockerd[2190]: time="2025-05-16T05:38:00.267148702Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 May 16 05:38:00.267355 dockerd[2190]: time="2025-05-16T05:38:00.267236383Z" level=info msg="Daemon has completed initialization" May 16 05:38:00.323604 dockerd[2190]: time="2025-05-16T05:38:00.323481327Z" level=info msg="API listen on /run/docker.sock" May 16 05:38:00.323785 systemd[1]: Started docker.service - Docker Application Container Engine. May 16 05:38:00.329221 sh[1994]: Restarted Docker to apply Flannel options May 16 05:38:00.329979 sh[1986]: + break May 16 05:38:00.329979 sh[1986]: + '[' 1 '!=' fail ']' May 16 05:38:00.331358 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). May 16 05:38:00.332105 systemd[1]: Startup finished in 1.248s (kernel) + 11.622s (initrd) + 25.953s (userspace) = 38.824s. May 16 05:38:00.342704 docker[2187]: etcd-member May 16 05:38:00.346121 docker[2186]: flannel May 16 05:38:00.346570 systemd[1]: etcd-member.service: Failed with result 'exit-code'. May 16 05:38:00.350282 systemd[1]: flanneld.service: Failed with result 'exit-code'. May 16 05:38:01.487859 sshd[2331]: Accepted publickey for core from 172.24.4.1 port 33832 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:01.490639 sshd-session[2331]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:01.503378 systemd-logind[1378]: New session 6 of user core. May 16 05:38:01.513206 systemd[1]: Started session-6.scope - Session 6 of User core. May 16 05:38:02.251095 sshd[2398]: Connection closed by 172.24.4.1 port 33832 May 16 05:38:02.251684 sshd-session[2331]: pam_unix(sshd:session): session closed for user core May 16 05:38:02.268953 systemd[1]: sshd@3-172.24.4.121:22-172.24.4.1:33832.service: Deactivated successfully. May 16 05:38:02.272328 systemd[1]: session-6.scope: Deactivated successfully. May 16 05:38:02.276323 systemd-logind[1378]: Session 6 logged out. Waiting for processes to exit. May 16 05:38:02.281585 systemd[1]: Started sshd@4-172.24.4.121:22-172.24.4.1:33834.service - OpenSSH per-connection server daemon (172.24.4.1:33834). May 16 05:38:02.285138 systemd-logind[1378]: Removed session 6. May 16 05:38:03.541212 sshd[2403]: Accepted publickey for core from 172.24.4.1 port 33834 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:03.544923 sshd-session[2403]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:03.559808 systemd-logind[1378]: New session 7 of user core. May 16 05:38:03.566232 systemd[1]: Started session-7.scope - Session 7 of User core. May 16 05:38:04.143561 sshd[2406]: Connection closed by 172.24.4.1 port 33834 May 16 05:38:04.147012 sshd-session[2403]: pam_unix(sshd:session): session closed for user core May 16 05:38:04.164032 systemd[1]: sshd@4-172.24.4.121:22-172.24.4.1:33834.service: Deactivated successfully. May 16 05:38:04.167692 systemd[1]: session-7.scope: Deactivated successfully. May 16 05:38:04.172210 systemd-logind[1378]: Session 7 logged out. Waiting for processes to exit. May 16 05:38:04.178545 systemd[1]: Started sshd@5-172.24.4.121:22-172.24.4.1:47506.service - OpenSSH per-connection server daemon (172.24.4.1:47506). May 16 05:38:04.182040 systemd-logind[1378]: Removed session 7. May 16 05:38:05.417723 sshd[2411]: Accepted publickey for core from 172.24.4.1 port 47506 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:05.422905 sshd-session[2411]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:05.445976 systemd-logind[1378]: New session 8 of user core. May 16 05:38:05.463476 systemd[1]: Started session-8.scope - Session 8 of User core. May 16 05:38:06.142065 sshd[2414]: Connection closed by 172.24.4.1 port 47506 May 16 05:38:06.146228 sshd-session[2411]: pam_unix(sshd:session): session closed for user core May 16 05:38:06.167272 systemd[1]: sshd@5-172.24.4.121:22-172.24.4.1:47506.service: Deactivated successfully. May 16 05:38:06.174464 systemd[1]: session-8.scope: Deactivated successfully. May 16 05:38:06.182619 systemd-logind[1378]: Session 8 logged out. Waiting for processes to exit. May 16 05:38:06.195630 systemd[1]: Started sshd@6-172.24.4.121:22-172.24.4.1:47510.service - OpenSSH per-connection server daemon (172.24.4.1:47510). May 16 05:38:06.198378 systemd-logind[1378]: Removed session 8. May 16 05:38:07.615916 sshd[2419]: Accepted publickey for core from 172.24.4.1 port 47510 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:07.620149 sshd-session[2419]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:07.643114 systemd-logind[1378]: New session 9 of user core. May 16 05:38:07.658252 systemd[1]: Started session-9.scope - Session 9 of User core. May 16 05:38:08.085615 sudo[2423]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 16 05:38:08.088399 sudo[2423]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 05:38:08.119685 sudo[2423]: pam_unix(sudo:session): session closed for user root May 16 05:38:08.275945 sshd[2422]: Connection closed by 172.24.4.1 port 47510 May 16 05:38:08.278152 sshd-session[2419]: pam_unix(sshd:session): session closed for user core May 16 05:38:08.295353 systemd[1]: sshd@6-172.24.4.121:22-172.24.4.1:47510.service: Deactivated successfully. May 16 05:38:08.301865 systemd[1]: session-9.scope: Deactivated successfully. May 16 05:38:08.308501 systemd-logind[1378]: Session 9 logged out. Waiting for processes to exit. May 16 05:38:08.317560 systemd[1]: Started sshd@7-172.24.4.121:22-172.24.4.1:47512.service - OpenSSH per-connection server daemon (172.24.4.1:47512). May 16 05:38:08.321526 systemd-logind[1378]: Removed session 9. May 16 05:38:09.337030 sshd[2428]: Accepted publickey for core from 172.24.4.1 port 47512 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:09.340414 sshd-session[2428]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:09.355534 systemd-logind[1378]: New session 10 of user core. May 16 05:38:09.367317 systemd[1]: Started session-10.scope - Session 10 of User core. May 16 05:38:09.776086 sudo[2433]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 16 05:38:09.776926 sudo[2433]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 05:38:09.786582 sudo[2433]: pam_unix(sudo:session): session closed for user root May 16 05:38:09.800420 sudo[2432]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 16 05:38:09.801186 sudo[2432]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 05:38:09.831591 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 05:38:09.926120 augenrules[2455]: No rules May 16 05:38:09.928587 systemd[1]: audit-rules.service: Deactivated successfully. May 16 05:38:09.929259 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 05:38:09.931834 sudo[2432]: pam_unix(sudo:session): session closed for user root May 16 05:38:10.211215 sshd[2431]: Connection closed by 172.24.4.1 port 47512 May 16 05:38:10.237444 sshd-session[2428]: pam_unix(sshd:session): session closed for user core May 16 05:38:10.254797 systemd[1]: sshd@7-172.24.4.121:22-172.24.4.1:47512.service: Deactivated successfully. May 16 05:38:10.263593 systemd[1]: session-10.scope: Deactivated successfully. May 16 05:38:10.271020 systemd-logind[1378]: Session 10 logged out. Waiting for processes to exit. May 16 05:38:10.274549 systemd-logind[1378]: Removed session 10. May 16 05:38:10.424129 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. May 16 05:38:10.427604 systemd[1]: flanneld.service: Scheduled restart job, restart counter is at 1. May 16 05:38:10.439362 systemd[1]: Stopping flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... May 16 05:38:10.519003 docker[2463]: flannel-docker-opts May 16 05:38:10.571119 docker[2470]: flannel-docker-opts May 16 05:38:10.575506 systemd[1]: flannel-docker-opts.service: Deactivated successfully. May 16 05:38:10.576434 systemd[1]: Stopped flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). May 16 05:38:10.578350 systemd[1]: Stopped flanneld.service - flannel - Network fabric for containers (System Application Container). May 16 05:38:10.586483 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... May 16 05:38:10.588699 (-wrapper)[2480]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS May 16 05:38:10.637731 etcd-wrapper[2484]: Error response from daemon: No such container: etcd-member May 16 05:38:10.666431 etcd-wrapper[2492]: Error response from daemon: No such container: etcd-member May 16 05:38:10.718640 systemd[1]: var-lib-docker-overlay2-e6c97259f9bbcabc263e75573543190e0f9a97f3fc7fcec6364a4e457eb0f1c2\x2dinit-merged.mount: Deactivated successfully. May 16 05:38:10.744117 systemd[1]: var-lib-docker-overlay2-e6c97259f9bbcabc263e75573543190e0f9a97f3fc7fcec6364a4e457eb0f1c2-merged.mount: Deactivated successfully. May 16 05:38:10.874510 containerd[1406]: time="2025-05-16T05:38:10.873689754Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 05:38:10.874510 containerd[1406]: time="2025-05-16T05:38:10.873906089Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 05:38:10.874510 containerd[1406]: time="2025-05-16T05:38:10.873951002Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:38:10.874510 containerd[1406]: time="2025-05-16T05:38:10.874154294Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:38:10.912032 systemd[1]: Started docker-ffb995b3ff7d63f727745de1d668145bf6adb4ecc0f4b5c340cc932957dd0e0a.scope - libcontainer container ffb995b3ff7d63f727745de1d668145bf6adb4ecc0f4b5c340cc932957dd0e0a. May 16 05:38:10.982264 etcd-wrapper[2509]: {"level":"info","ts":1747373890.9815726,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"info","ts":1747373890.9817057,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"17432d80addb40679162c36cfb91b1bf"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"warn","ts":1747373890.9817333,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"warn","ts":1747373890.981741,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"warn","ts":1747373890.9817483,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"warn","ts":1747373890.9817533,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.981Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.24.4.121:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.24.4.121:2380","--advertise-client-urls=http://172.24.4.121:2379","--discovery=https://discovery.etcd.io/a1fba48abcea8732d6c2bc0550fee5c7","--enable-v2=true"]} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.982Z","caller":"etcdmain/etcd.go:115","msg":"server has been already initialized","data-dir":"/var/lib/etcd","dir-type":"member"} May 16 05:38:10.982969 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.982Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://172.24.4.121:2380"]} May 16 05:38:10.983539 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.982Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} May 16 05:38:10.983539 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.983Z","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":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":true,"name":"17432d80addb40679162c36cfb91b1bf","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://172.24.4.121:2380"],"listen-peer-urls":["http://172.24.4.121:2380"],"advertise-client-urls":["http://172.24.4.121: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":"https://discovery.etcd.io/a1fba48abcea8732d6c2bc0550fee5c7","discovery-proxy":"","downgrade-check-interval":"5s"} May 16 05:38:10.984300 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.983Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"504.629µs"} May 16 05:38:10.984300 etcd-wrapper[2509]: {"level":"warn","ts":"2025-05-16T05:38:10.984Z","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"} May 16 05:38:10.984558 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.984Z","caller":"etcdserver/server.go:526","msg":"No snapshot found. Recovering WAL from scratch!"} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","caller":"etcdserver/raft.go:483","msg":"restarting local member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","commit-index":32} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=()"} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became follower at term 3"} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3e3709663cbbde08 [peers: [], term: 3, commit: 32, applied: 0, lastindex: 32, lastterm: 3]"} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","recovered-remote-peer-id":"3e3709663cbbde08","recovered-remote-peer-urls":["http://172.24.4.121:2380"]} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","recovered-remote-peer-id":"76bb1a5cfdb1ab60","recovered-remote-peer-urls":["http://172.24.4.32:2380"]} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","recovered-remote-peer-id":"d8528f75f71ac082","recovered-remote-peer-urls":["http://172.24.4.236:2380"]} May 16 05:38:10.986470 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.985Z","caller":"membership/cluster.go:285","msg":"set cluster version from store","cluster-version":"3.5"} May 16 05:38:10.987428 etcd-wrapper[2509]: {"level":"warn","ts":"2025-05-16T05:38:10.987Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} May 16 05:38:10.989114 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.988Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} May 16 05:38:10.990056 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.989Z","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"} May 16 05:38:10.991111 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.990Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.991111 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.990Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.992586 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.991Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.993340 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.993Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.994401 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.993Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.994401 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.993Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.994401 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.993Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60","remote-peer-urls":["http://172.24.4.32:2380"]} May 16 05:38:10.994401 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.993Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.994401 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.993Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.994401 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.994Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:10.995486 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.995Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.996012 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.995Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.996318 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.996Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.996590 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.996Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.996801 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.996Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:10.997803 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.996Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082","remote-peer-urls":["http://172.24.4.236:2380"]} May 16 05:38:10.998276 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.998Z","caller":"etcdserver/server.go:834","msg":"starting etcd server","local-member-id":"3e3709663cbbde08","local-server-version":"3.5.0","cluster-id":"f384eccd80dfbdc3","cluster-version":"3.5"} May 16 05:38:10.999479 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:10.999Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} May 16 05:38:11.000479 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.000Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320)"} May 16 05:38:11.001404 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.001Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","added-peer-id":"3e3709663cbbde08","added-peer-peer-urls":["http://172.24.4.121:2380"]} May 16 05:38:11.001758 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920)"} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.001Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","added-peer-id":"76bb1a5cfdb1ab60","added-peer-peer-urls":["http://172.24.4.32:2380"]} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.002Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d8528f75f71ac082"} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.002Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"warn","ts":"2025-05-16T05:38:11.002Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.002Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 switched to configuration voters=(4483062288780877320 8555460903815981920 15587678997102379138)"} May 16 05:38:11.003387 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.002Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","added-peer-id":"d8528f75f71ac082","added-peer-peer-urls":["http://172.24.4.236:2380"]} May 16 05:38:11.003776 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.003Z","caller":"membership/cluster.go:523","msg":"updated cluster version","cluster-id":"f384eccd80dfbdc3","local-member-id":"3e3709663cbbde08","from":"3.5","to":"3.5"} May 16 05:38:11.003776 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.003Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"3e3709663cbbde08","initial-advertise-peer-urls":["http://172.24.4.121:2380"],"listen-peer-urls":["http://172.24.4.121:2380"],"advertise-client-urls":["http://172.24.4.121:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} May 16 05:38:11.003776 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.002Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"172.24.4.121:2380"} May 16 05:38:11.003776 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.003Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"172.24.4.121:2380"} May 16 05:38:11.041370 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.040Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"d8528f75f71ac082","stream-type":"stream MsgApp v2"} May 16 05:38:11.041370 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.040Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:11.041889 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.041Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"d8528f75f71ac082","stream-type":"stream Message"} May 16 05:38:11.041889 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.041Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"d8528f75f71ac082"} May 16 05:38:11.369271 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.368Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"76bb1a5cfdb1ab60","stream-type":"stream Message"} May 16 05:38:11.369271 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.368Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:11.369271 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.368Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:11.372545 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.372Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"3e3709663cbbde08","to":"76bb1a5cfdb1ab60","stream-type":"stream MsgApp v2"} May 16 05:38:11.372545 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.372Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:11.390273 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 3, index: 32, vote: 76bb1a5cfdb1ab60] cast MsgPreVote for d8528f75f71ac082 [logterm: 3, index: 32] at term 3"} May 16 05:38:11.397419 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [term: 3] received a MsgVote message with higher term from d8528f75f71ac082 [term: 4]"} May 16 05:38:11.397419 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 became follower at term 4"} May 16 05:38:11.397419 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e3709663cbbde08 [logterm: 3, index: 32, vote: 0] cast MsgVote for d8528f75f71ac082 [logterm: 3, index: 32] at term 4"} May 16 05:38:11.401025 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.400Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:11.401366 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.400Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"3e3709663cbbde08","remote-peer-id":"76bb1a5cfdb1ab60"} May 16 05:38:11.403479 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.403Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"3e3709663cbbde08","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} May 16 05:38:11.410242 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e3709663cbbde08 elected leader d8528f75f71ac082 at term 4"} May 16 05:38:11.418353 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.417Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"3e3709663cbbde08","local-member-attributes":"{Name:17432d80addb40679162c36cfb91b1bf ClientURLs:[http://172.24.4.121:2379]}","request-path":"/0/members/3e3709663cbbde08/attributes","cluster-id":"f384eccd80dfbdc3","publish-timeout":"7s"} May 16 05:38:11.419830 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.417Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} May 16 05:38:11.420204 systemd[1]: Started etcd-member.service - etcd (System Application Container). May 16 05:38:11.422184 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.419Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} May 16 05:38:11.422184 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.419Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} May 16 05:38:11.424444 etcd-wrapper[2509]: {"level":"info","ts":"2025-05-16T05:38:11.423Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} May 16 05:38:11.433323 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... May 16 05:38:11.530980 etcdctl[2569]: { "Network": "10.254.0.0/16", "Backend": {"Type": "udp"} } May 16 05:38:11.586016 flannel-wrapper[2577]: Error response from daemon: No such container: flannel May 16 05:38:11.612916 flannel-wrapper[2585]: Error response from daemon: No such container: flannel May 16 05:38:11.814087 containerd[1406]: time="2025-05-16T05:38:11.813731862Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 05:38:11.814905 containerd[1406]: time="2025-05-16T05:38:11.813859652Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 05:38:11.814905 containerd[1406]: time="2025-05-16T05:38:11.814562299Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:38:11.815478 containerd[1406]: time="2025-05-16T05:38:11.815263911Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:38:11.857310 systemd[1]: Started docker-525555eadd5839d4cb639da51fb3cf245a0df02f8e359515cb896202cb96b4d7.scope - libcontainer container 525555eadd5839d4cb639da51fb3cf245a0df02f8e359515cb896202cb96b4d7. May 16 05:38:11.937113 flannel-wrapper[2600]: I0516 05:38:11.936703 1 main.go:520] Determining IP address of default interface May 16 05:38:11.940620 flannel-wrapper[2600]: I0516 05:38:11.940391 1 main.go:533] Using interface with name eth0 and address 172.24.4.121 May 16 05:38:11.940620 flannel-wrapper[2600]: I0516 05:38:11.940435 1 main.go:550] Defaulting external address to interface address (172.24.4.121) May 16 05:38:11.941117 flannel-wrapper[2600]: I0516 05:38:11.940984 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: 10.254.87.0/24 May 16 05:38:11.941117 flannel-wrapper[2600]: I0516 05:38:11.940999 1 main.go:257] Installing signal handlers May 16 05:38:11.944620 flannel-wrapper[2600]: I0516 05:38:11.944479 1 main.go:392] Found network config - Backend type: udp May 16 05:38:11.949257 flannel-wrapper[2600]: I0516 05:38:11.949101 1 local_manager.go:147] Found lease (10.254.87.0/24) for current IP (172.24.4.121), reusing May 16 05:38:11.953918 flannel-wrapper[2600]: I0516 05:38:11.953761 1 main.go:307] Setting up masking rules May 16 05:38:11.954403 systemd-networkd[1310]: flannel0: Link UP May 16 05:38:11.954413 systemd-networkd[1310]: flannel0: Gained carrier May 16 05:38:11.954587 systemd-networkd[1310]: flannel0: Gained IPv6LL May 16 05:38:11.975654 flannel-wrapper[2600]: I0516 05:38:11.975459 1 main.go:315] Changing default FORWARD chain policy to ACCEPT May 16 05:38:11.976227 flannel-wrapper[2600]: I0516 05:38:11.976041 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env May 16 05:38:11.976227 flannel-wrapper[2600]: I0516 05:38:11.976052 1 main.go:327] Running backend. May 16 05:38:11.977161 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). May 16 05:38:11.978003 flannel-wrapper[2600]: I0516 05:38:11.977781 1 udp_network_amd64.go:100] Watching for new subnet leases May 16 05:38:11.984194 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... May 16 05:38:11.985325 flannel-wrapper[2600]: I0516 05:38:11.984730 1 main.go:439] Waiting for 22h59m59.964961209s to renew lease May 16 05:38:11.986509 flannel-wrapper[2600]: I0516 05:38:11.986358 1 udp_network_amd64.go:196] Subnet added: 10.254.99.0/24 May 16 05:38:11.986812 flannel-wrapper[2600]: I0516 05:38:11.986687 1 udp_network_amd64.go:196] Subnet added: 10.254.57.0/24 May 16 05:38:11.996210 sh[2685]: + for try in 1 2 3 4 5 6 May 16 05:38:11.996210 sh[2685]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i May 16 05:38:12.019389 sh[2694]: Error response from daemon: No such container: flannel-docker-opts May 16 05:38:12.038140 sh[2702]: Error response from daemon: No such container: flannel-docker-opts May 16 05:38:12.106855 systemd[1]: var-lib-docker-overlay2-4a941051cd261568045972607393d733748d1c3b99f142f92b2e61f52a59d549-merged.mount: Deactivated successfully. May 16 05:38:12.192354 containerd[1406]: time="2025-05-16T05:38:12.191432378Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 05:38:12.192354 containerd[1406]: time="2025-05-16T05:38:12.191537054Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 05:38:12.192354 containerd[1406]: time="2025-05-16T05:38:12.191573492Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:38:12.192354 containerd[1406]: time="2025-05-16T05:38:12.191716735Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 05:38:12.230334 systemd[1]: Started docker-7d1c6b8cdde1af6d6b466d5408c02fdd21fa91026505d5342dae53dc1dc0ca41.scope - libcontainer container 7d1c6b8cdde1af6d6b466d5408c02fdd21fa91026505d5342dae53dc1dc0ca41. May 16 05:38:12.284039 systemd[1]: docker-7d1c6b8cdde1af6d6b466d5408c02fdd21fa91026505d5342dae53dc1dc0ca41.scope: Deactivated successfully. May 16 05:38:12.311733 dockerd[2190]: time="2025-05-16T05:38:12.311613684Z" level=info msg="ignoring event" container=7d1c6b8cdde1af6d6b466d5408c02fdd21fa91026505d5342dae53dc1dc0ca41 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 16 05:38:12.312730 containerd[1406]: time="2025-05-16T05:38:12.312034977Z" level=info msg="shim disconnected" id=7d1c6b8cdde1af6d6b466d5408c02fdd21fa91026505d5342dae53dc1dc0ca41 namespace=moby May 16 05:38:12.312730 containerd[1406]: time="2025-05-16T05:38:12.312208633Z" level=warning msg="cleaning up after shim disconnected" id=7d1c6b8cdde1af6d6b466d5408c02fdd21fa91026505d5342dae53dc1dc0ca41 namespace=moby May 16 05:38:12.312730 containerd[1406]: time="2025-05-16T05:38:12.312222610Z" level=info msg="cleaning up dead shim" namespace=moby May 16 05:38:12.344318 sh[2685]: + break May 16 05:38:12.344318 sh[2685]: + '[' 1 '!=' fail ']' May 16 05:38:12.345053 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). May 16 05:38:16.709443 systemd[1]: Started sshd@8-172.24.4.121:22-172.24.4.1:58562.service - OpenSSH per-connection server daemon (172.24.4.1:58562). May 16 05:38:18.127844 sshd[2799]: Accepted publickey for core from 172.24.4.1 port 58562 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:18.131942 sshd-session[2799]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:18.156013 systemd-logind[1378]: New session 11 of user core. May 16 05:38:18.160222 systemd[1]: Started session-11.scope - Session 11 of User core. May 16 05:38:18.811806 sshd[2807]: Connection closed by 172.24.4.1 port 58562 May 16 05:38:18.811404 sshd-session[2799]: pam_unix(sshd:session): session closed for user core May 16 05:38:18.835220 systemd[1]: sshd@8-172.24.4.121:22-172.24.4.1:58562.service: Deactivated successfully. May 16 05:38:18.839715 systemd[1]: session-11.scope: Deactivated successfully. May 16 05:38:18.843471 systemd-logind[1378]: Session 11 logged out. Waiting for processes to exit. May 16 05:38:18.851474 systemd[1]: Started sshd@9-172.24.4.121:22-172.24.4.1:58572.service - OpenSSH per-connection server daemon (172.24.4.1:58572). May 16 05:38:18.854987 systemd-logind[1378]: Removed session 11. May 16 05:38:20.652657 sshd[2817]: Accepted publickey for core from 172.24.4.1 port 58572 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:38:20.655775 sshd-session[2817]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:38:20.669401 systemd-logind[1378]: New session 12 of user core. May 16 05:38:20.681271 systemd[1]: Started session-12.scope - Session 12 of User core. May 16 05:38:21.192028 sshd[2820]: Connection closed by 172.24.4.1 port 58572 May 16 05:38:21.191786 sshd-session[2817]: pam_unix(sshd:session): session closed for user core May 16 05:38:21.197995 systemd[1]: sshd@9-172.24.4.121:22-172.24.4.1:58572.service: Deactivated successfully. May 16 05:38:21.202553 systemd[1]: session-12.scope: Deactivated successfully. May 16 05:38:21.206640 systemd-logind[1378]: Session 12 logged out. Waiting for processes to exit. May 16 05:38:21.209631 systemd-logind[1378]: Removed session 12. May 16 05:38:23.511646 update_engine[1379]: I20250516 05:38:23.511284 1379 update_attempter.cc:509] Updating boot flags... May 16 05:38:23.594222 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2841) May 16 05:38:23.693938 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2840) May 16 05:39:23.088541 systemd[1]: Started sshd@10-172.24.4.121:22-172.24.4.1:35466.service - OpenSSH per-connection server daemon (172.24.4.1:35466). May 16 05:39:24.093737 sshd[2924]: Accepted publickey for core from 172.24.4.1 port 35466 ssh2: RSA SHA256:4jSRrXpuZYgXVqbyu7E0jO5dFsAeAUAhVSFWXq0UR/4 May 16 05:39:24.096844 sshd-session[2924]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 05:39:24.113777 systemd-logind[1378]: New session 13 of user core. May 16 05:39:24.118285 systemd[1]: Started session-13.scope - Session 13 of User core. May 16 05:39:33.853592 sshd[2926]: Connection closed by 172.24.4.1 port 35466 May 16 05:39:33.853259 sshd-session[2924]: pam_unix(sshd:session): session closed for user core May 16 05:39:33.863312 systemd[1]: sshd@10-172.24.4.121:22-172.24.4.1:35466.service: Deactivated successfully. May 16 05:39:33.867321 systemd[1]: session-13.scope: Deactivated successfully. May 16 05:39:33.869216 systemd-logind[1378]: Session 13 logged out. Waiting for processes to exit. May 16 05:39:33.871746 systemd-logind[1378]: Removed session 13.