May 27 17:35:06.940520 kernel: Linux version 6.12.30-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.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Tue May 27 15:32:02 -00 2025 May 27 17:35:06.940545 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=daa3e2d55cc4a7ff0ec15aa9bb0c07df9999cb4e3041f3adad1b1101efdea101 May 27 17:35:06.940557 kernel: BIOS-provided physical RAM map: May 27 17:35:06.940564 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000002ffff] usable May 27 17:35:06.940570 kernel: BIOS-e820: [mem 0x0000000000030000-0x000000000004ffff] reserved May 27 17:35:06.940577 kernel: BIOS-e820: [mem 0x0000000000050000-0x000000000009efff] usable May 27 17:35:06.940584 kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved May 27 17:35:06.940591 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009b8ecfff] usable May 27 17:35:06.940601 kernel: BIOS-e820: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved May 27 17:35:06.940607 kernel: BIOS-e820: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data May 27 17:35:06.940614 kernel: BIOS-e820: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS May 27 17:35:06.940623 kernel: BIOS-e820: [mem 0x000000009bbff000-0x000000009bfb0fff] usable May 27 17:35:06.940630 kernel: BIOS-e820: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved May 27 17:35:06.940637 kernel: BIOS-e820: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS May 27 17:35:06.940645 kernel: BIOS-e820: [mem 0x000000009bfb7000-0x000000009bffffff] usable May 27 17:35:06.940652 kernel: BIOS-e820: [mem 0x000000009c000000-0x000000009cffffff] reserved May 27 17:35:06.940664 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved May 27 17:35:06.940671 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 27 17:35:06.940678 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 27 17:35:06.940685 kernel: NX (Execute Disable) protection: active May 27 17:35:06.940692 kernel: APIC: Static calls initialized May 27 17:35:06.940700 kernel: e820: update [mem 0x9a13f018-0x9a148c57] usable ==> usable May 27 17:35:06.940707 kernel: e820: update [mem 0x9a102018-0x9a13ee57] usable ==> usable May 27 17:35:06.940714 kernel: extended physical RAM map: May 27 17:35:06.940721 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000002ffff] usable May 27 17:35:06.940728 kernel: reserve setup_data: [mem 0x0000000000030000-0x000000000004ffff] reserved May 27 17:35:06.940736 kernel: reserve setup_data: [mem 0x0000000000050000-0x000000000009efff] usable May 27 17:35:06.940745 kernel: reserve setup_data: [mem 0x000000000009f000-0x000000000009ffff] reserved May 27 17:35:06.940752 kernel: reserve setup_data: [mem 0x0000000000100000-0x000000009a102017] usable May 27 17:35:06.940760 kernel: reserve setup_data: [mem 0x000000009a102018-0x000000009a13ee57] usable May 27 17:35:06.940767 kernel: reserve setup_data: [mem 0x000000009a13ee58-0x000000009a13f017] usable May 27 17:35:06.940774 kernel: reserve setup_data: [mem 0x000000009a13f018-0x000000009a148c57] usable May 27 17:35:06.940781 kernel: reserve setup_data: [mem 0x000000009a148c58-0x000000009b8ecfff] usable May 27 17:35:06.940788 kernel: reserve setup_data: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved May 27 17:35:06.940795 kernel: reserve setup_data: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data May 27 17:35:06.940803 kernel: reserve setup_data: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS May 27 17:35:06.940810 kernel: reserve setup_data: [mem 0x000000009bbff000-0x000000009bfb0fff] usable May 27 17:35:06.940817 kernel: reserve setup_data: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved May 27 17:35:06.940826 kernel: reserve setup_data: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS May 27 17:35:06.940833 kernel: reserve setup_data: [mem 0x000000009bfb7000-0x000000009bffffff] usable May 27 17:35:06.940844 kernel: reserve setup_data: [mem 0x000000009c000000-0x000000009cffffff] reserved May 27 17:35:06.940851 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved May 27 17:35:06.940859 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 27 17:35:06.940866 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 27 17:35:06.940876 kernel: efi: EFI v2.7 by EDK II May 27 17:35:06.940884 kernel: efi: SMBIOS=0x9b9d5000 ACPI=0x9bb7e000 ACPI 2.0=0x9bb7e014 MEMATTR=0x9a1af018 RNG=0x9bb73018 May 27 17:35:06.940891 kernel: random: crng init done May 27 17:35:06.940899 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 May 27 17:35:06.940906 kernel: secureboot: Secure boot enabled May 27 17:35:06.940913 kernel: SMBIOS 2.8 present. May 27 17:35:06.940921 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 May 27 17:35:06.940928 kernel: DMI: Memory slots populated: 1/1 May 27 17:35:06.940943 kernel: Hypervisor detected: KVM May 27 17:35:06.940950 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 May 27 17:35:06.940959 kernel: kvm-clock: using sched offset of 9616781244 cycles May 27 17:35:06.940969 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns May 27 17:35:06.940977 kernel: tsc: Detected 2794.748 MHz processor May 27 17:35:06.940985 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 27 17:35:06.940992 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 27 17:35:06.941000 kernel: last_pfn = 0x9c000 max_arch_pfn = 0x400000000 May 27 17:35:06.941007 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs May 27 17:35:06.941019 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 27 17:35:06.941027 kernel: Using GB pages for direct mapping May 27 17:35:06.941037 kernel: ACPI: Early table checksum verification disabled May 27 17:35:06.941047 kernel: ACPI: RSDP 0x000000009BB7E014 000024 (v02 BOCHS ) May 27 17:35:06.941055 kernel: ACPI: XSDT 0x000000009BB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) May 27 17:35:06.941063 kernel: ACPI: FACP 0x000000009BB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 27 17:35:06.941070 kernel: ACPI: DSDT 0x000000009BB7A000 002237 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 27 17:35:06.941078 kernel: ACPI: FACS 0x000000009BBDD000 000040 May 27 17:35:06.941085 kernel: ACPI: APIC 0x000000009BB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 27 17:35:06.941093 kernel: ACPI: HPET 0x000000009BB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 27 17:35:06.941100 kernel: ACPI: MCFG 0x000000009BB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 27 17:35:06.941110 kernel: ACPI: WAET 0x000000009BB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 27 17:35:06.941118 kernel: ACPI: BGRT 0x000000009BB74000 000038 (v01 INTEL EDK2 00000002 01000013) May 27 17:35:06.941125 kernel: ACPI: Reserving FACP table memory at [mem 0x9bb79000-0x9bb790f3] May 27 17:35:06.941133 kernel: ACPI: Reserving DSDT table memory at [mem 0x9bb7a000-0x9bb7c236] May 27 17:35:06.941140 kernel: ACPI: Reserving FACS table memory at [mem 0x9bbdd000-0x9bbdd03f] May 27 17:35:06.941148 kernel: ACPI: Reserving APIC table memory at [mem 0x9bb78000-0x9bb7808f] May 27 17:35:06.941155 kernel: ACPI: Reserving HPET table memory at [mem 0x9bb77000-0x9bb77037] May 27 17:35:06.941163 kernel: ACPI: Reserving MCFG table memory at [mem 0x9bb76000-0x9bb7603b] May 27 17:35:06.941170 kernel: ACPI: Reserving WAET table memory at [mem 0x9bb75000-0x9bb75027] May 27 17:35:06.941180 kernel: ACPI: Reserving BGRT table memory at [mem 0x9bb74000-0x9bb74037] May 27 17:35:06.941187 kernel: No NUMA configuration found May 27 17:35:06.941195 kernel: Faking a node at [mem 0x0000000000000000-0x000000009bffffff] May 27 17:35:06.941202 kernel: NODE_DATA(0) allocated [mem 0x9bf57dc0-0x9bf5efff] May 27 17:35:06.941210 kernel: Zone ranges: May 27 17:35:06.941217 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 27 17:35:06.941225 kernel: DMA32 [mem 0x0000000001000000-0x000000009bffffff] May 27 17:35:06.941232 kernel: Normal empty May 27 17:35:06.941240 kernel: Device empty May 27 17:35:06.941247 kernel: Movable zone start for each node May 27 17:35:06.941257 kernel: Early memory node ranges May 27 17:35:06.941265 kernel: node 0: [mem 0x0000000000001000-0x000000000002ffff] May 27 17:35:06.941272 kernel: node 0: [mem 0x0000000000050000-0x000000000009efff] May 27 17:35:06.941281 kernel: node 0: [mem 0x0000000000100000-0x000000009b8ecfff] May 27 17:35:06.941291 kernel: node 0: [mem 0x000000009bbff000-0x000000009bfb0fff] May 27 17:35:06.941301 kernel: node 0: [mem 0x000000009bfb7000-0x000000009bffffff] May 27 17:35:06.941310 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009bffffff] May 27 17:35:06.941320 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 27 17:35:06.941330 kernel: On node 0, zone DMA: 32 pages in unavailable ranges May 27 17:35:06.941343 kernel: On node 0, zone DMA: 97 pages in unavailable ranges May 27 17:35:06.941353 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges May 27 17:35:06.941363 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges May 27 17:35:06.941371 kernel: On node 0, zone DMA32: 16384 pages in unavailable ranges May 27 17:35:06.941378 kernel: ACPI: PM-Timer IO Port: 0x608 May 27 17:35:06.941386 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) May 27 17:35:06.941393 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 27 17:35:06.941401 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) May 27 17:35:06.941408 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) May 27 17:35:06.941421 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 27 17:35:06.941429 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) May 27 17:35:06.941437 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) May 27 17:35:06.941444 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 27 17:35:06.941452 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 May 27 17:35:06.941459 kernel: TSC deadline timer available May 27 17:35:06.941467 kernel: CPU topo: Max. logical packages: 1 May 27 17:35:06.941474 kernel: CPU topo: Max. logical dies: 1 May 27 17:35:06.941484 kernel: CPU topo: Max. dies per package: 1 May 27 17:35:06.941499 kernel: CPU topo: Max. threads per core: 1 May 27 17:35:06.941527 kernel: CPU topo: Num. cores per package: 4 May 27 17:35:06.941535 kernel: CPU topo: Num. threads per package: 4 May 27 17:35:06.941546 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs May 27 17:35:06.941556 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() May 27 17:35:06.941564 kernel: kvm-guest: KVM setup pv remote TLB flush May 27 17:35:06.941572 kernel: kvm-guest: setup PV sched yield May 27 17:35:06.941580 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices May 27 17:35:06.941590 kernel: Booting paravirtualized kernel on KVM May 27 17:35:06.941598 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 27 17:35:06.941607 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 May 27 17:35:06.941614 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 May 27 17:35:06.941622 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 May 27 17:35:06.941630 kernel: pcpu-alloc: [0] 0 1 2 3 May 27 17:35:06.941638 kernel: kvm-guest: PV spinlocks enabled May 27 17:35:06.941645 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 27 17:35:06.941655 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,115200 flatcar.first_boot=detected verity.usrhash=daa3e2d55cc4a7ff0ec15aa9bb0c07df9999cb4e3041f3adad1b1101efdea101 May 27 17:35:06.941666 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 27 17:35:06.941674 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 27 17:35:06.941682 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 27 17:35:06.941689 kernel: Fallback order for Node 0: 0 May 27 17:35:06.941697 kernel: Built 1 zonelists, mobility grouping on. Total pages: 638054 May 27 17:35:06.941705 kernel: Policy zone: DMA32 May 27 17:35:06.941713 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 27 17:35:06.941721 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 27 17:35:06.941731 kernel: ftrace: allocating 40081 entries in 157 pages May 27 17:35:06.941739 kernel: ftrace: allocated 157 pages with 5 groups May 27 17:35:06.941747 kernel: Dynamic Preempt: voluntary May 27 17:35:06.941755 kernel: rcu: Preemptible hierarchical RCU implementation. May 27 17:35:06.941763 kernel: rcu: RCU event tracing is enabled. May 27 17:35:06.941772 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 27 17:35:06.941779 kernel: Trampoline variant of Tasks RCU enabled. May 27 17:35:06.941787 kernel: Rude variant of Tasks RCU enabled. May 27 17:35:06.941795 kernel: Tracing variant of Tasks RCU enabled. May 27 17:35:06.941805 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 27 17:35:06.941813 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 27 17:35:06.941821 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 27 17:35:06.941829 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 27 17:35:06.941839 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 27 17:35:06.941847 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 May 27 17:35:06.941855 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 27 17:35:06.941863 kernel: Console: colour dummy device 80x25 May 27 17:35:06.941871 kernel: printk: legacy console [ttyS0] enabled May 27 17:35:06.941882 kernel: ACPI: Core revision 20240827 May 27 17:35:06.941890 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns May 27 17:35:06.941898 kernel: APIC: Switch to symmetric I/O mode setup May 27 17:35:06.941905 kernel: x2apic enabled May 27 17:35:06.941913 kernel: APIC: Switched APIC routing to: physical x2apic May 27 17:35:06.941921 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() May 27 17:35:06.941929 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() May 27 17:35:06.941944 kernel: kvm-guest: setup PV IPIs May 27 17:35:06.941952 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 May 27 17:35:06.941962 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns May 27 17:35:06.941971 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) May 27 17:35:06.941979 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 27 17:35:06.941987 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 May 27 17:35:06.941995 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 May 27 17:35:06.942005 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 27 17:35:06.942012 kernel: Spectre V2 : Mitigation: Retpolines May 27 17:35:06.942020 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 27 17:35:06.942028 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls May 27 17:35:06.942039 kernel: RETBleed: Mitigation: untrained return thunk May 27 17:35:06.942047 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier May 27 17:35:06.942055 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl May 27 17:35:06.942063 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! May 27 17:35:06.942071 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. May 27 17:35:06.942079 kernel: x86/bugs: return thunk changed May 27 17:35:06.942087 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode May 27 17:35:06.942095 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 27 17:35:06.942105 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 27 17:35:06.942113 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 27 17:35:06.942121 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 27 17:35:06.942129 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. May 27 17:35:06.942136 kernel: Freeing SMP alternatives memory: 32K May 27 17:35:06.942144 kernel: pid_max: default: 32768 minimum: 301 May 27 17:35:06.942152 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 27 17:35:06.942160 kernel: landlock: Up and running. May 27 17:35:06.942167 kernel: SELinux: Initializing. May 27 17:35:06.942178 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 27 17:35:06.942186 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 27 17:35:06.942194 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) May 27 17:35:06.942202 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. May 27 17:35:06.942209 kernel: ... version: 0 May 27 17:35:06.942217 kernel: ... bit width: 48 May 27 17:35:06.942227 kernel: ... generic registers: 6 May 27 17:35:06.942235 kernel: ... value mask: 0000ffffffffffff May 27 17:35:06.942243 kernel: ... max period: 00007fffffffffff May 27 17:35:06.942253 kernel: ... fixed-purpose events: 0 May 27 17:35:06.942261 kernel: ... event mask: 000000000000003f May 27 17:35:06.942268 kernel: signal: max sigframe size: 1776 May 27 17:35:06.942277 kernel: rcu: Hierarchical SRCU implementation. May 27 17:35:06.942288 kernel: rcu: Max phase no-delay instances is 400. May 27 17:35:06.942299 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 27 17:35:06.942309 kernel: smp: Bringing up secondary CPUs ... May 27 17:35:06.942318 kernel: smpboot: x86: Booting SMP configuration: May 27 17:35:06.942326 kernel: .... node #0, CPUs: #1 #2 #3 May 27 17:35:06.942337 kernel: smp: Brought up 1 node, 4 CPUs May 27 17:35:06.942345 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) May 27 17:35:06.942353 kernel: Memory: 2409212K/2552216K available (14336K kernel code, 2430K rwdata, 9952K rodata, 54416K init, 2552K bss, 137064K reserved, 0K cma-reserved) May 27 17:35:06.942361 kernel: devtmpfs: initialized May 27 17:35:06.942369 kernel: x86/mm: Memory block size: 128MB May 27 17:35:06.942377 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bb7f000-0x9bbfefff] (524288 bytes) May 27 17:35:06.942385 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bfb5000-0x9bfb6fff] (8192 bytes) May 27 17:35:06.942393 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 27 17:35:06.942401 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 27 17:35:06.942411 kernel: pinctrl core: initialized pinctrl subsystem May 27 17:35:06.942419 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 27 17:35:06.942427 kernel: audit: initializing netlink subsys (disabled) May 27 17:35:06.942435 kernel: audit: type=2000 audit(1748367304.423:1): state=initialized audit_enabled=0 res=1 May 27 17:35:06.942443 kernel: thermal_sys: Registered thermal governor 'step_wise' May 27 17:35:06.942451 kernel: thermal_sys: Registered thermal governor 'user_space' May 27 17:35:06.942458 kernel: cpuidle: using governor menu May 27 17:35:06.942466 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 27 17:35:06.942474 kernel: dca service started, version 1.12.1 May 27 17:35:06.942484 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] May 27 17:35:06.942492 kernel: PCI: Using configuration type 1 for base access May 27 17:35:06.942500 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 27 17:35:06.942530 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 27 17:35:06.942538 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 27 17:35:06.942546 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 27 17:35:06.942553 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 27 17:35:06.942561 kernel: ACPI: Added _OSI(Module Device) May 27 17:35:06.942569 kernel: ACPI: Added _OSI(Processor Device) May 27 17:35:06.942580 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 27 17:35:06.942588 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 27 17:35:06.942596 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 27 17:35:06.942603 kernel: ACPI: Interpreter enabled May 27 17:35:06.942611 kernel: ACPI: PM: (supports S0 S5) May 27 17:35:06.942619 kernel: ACPI: Using IOAPIC for interrupt routing May 27 17:35:06.942627 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 27 17:35:06.942635 kernel: PCI: Using E820 reservations for host bridge windows May 27 17:35:06.942643 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F May 27 17:35:06.942653 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 27 17:35:06.942875 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 27 17:35:06.943038 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] May 27 17:35:06.943169 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] May 27 17:35:06.943180 kernel: PCI host bridge to bus 0000:00 May 27 17:35:06.943369 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 27 17:35:06.943484 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 27 17:35:06.943626 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] May 27 17:35:06.943737 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] May 27 17:35:06.943846 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] May 27 17:35:06.943967 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] May 27 17:35:06.944099 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 27 17:35:06.944349 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint May 27 17:35:06.944531 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint May 27 17:35:06.944657 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] May 27 17:35:06.944777 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] May 27 17:35:06.944896 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] May 27 17:35:06.945026 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 27 17:35:06.945162 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint May 27 17:35:06.945286 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] May 27 17:35:06.945427 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] May 27 17:35:06.945577 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] May 27 17:35:06.945738 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint May 27 17:35:06.945862 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] May 27 17:35:06.945994 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] May 27 17:35:06.946117 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] May 27 17:35:06.946255 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint May 27 17:35:06.946409 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] May 27 17:35:06.946586 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] May 27 17:35:06.946744 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] May 27 17:35:06.946900 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] May 27 17:35:06.947078 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint May 27 17:35:06.947225 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO May 27 17:35:06.947426 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint May 27 17:35:06.947601 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] May 27 17:35:06.947761 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] May 27 17:35:06.948000 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint May 27 17:35:06.948155 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] May 27 17:35:06.948172 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 May 27 17:35:06.948183 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 May 27 17:35:06.948198 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 May 27 17:35:06.948209 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 May 27 17:35:06.948220 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 May 27 17:35:06.948231 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 May 27 17:35:06.948241 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 May 27 17:35:06.948253 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 May 27 17:35:06.948265 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 May 27 17:35:06.948275 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 May 27 17:35:06.948286 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 May 27 17:35:06.948300 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 May 27 17:35:06.948311 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 May 27 17:35:06.948321 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 May 27 17:35:06.948331 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 May 27 17:35:06.948342 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 May 27 17:35:06.948353 kernel: iommu: Default domain type: Translated May 27 17:35:06.948364 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 27 17:35:06.948375 kernel: efivars: Registered efivars operations May 27 17:35:06.948386 kernel: PCI: Using ACPI for IRQ routing May 27 17:35:06.948400 kernel: PCI: pci_cache_line_size set to 64 bytes May 27 17:35:06.948410 kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] May 27 17:35:06.948421 kernel: e820: reserve RAM buffer [mem 0x9a102018-0x9bffffff] May 27 17:35:06.948431 kernel: e820: reserve RAM buffer [mem 0x9a13f018-0x9bffffff] May 27 17:35:06.948442 kernel: e820: reserve RAM buffer [mem 0x9b8ed000-0x9bffffff] May 27 17:35:06.948452 kernel: e820: reserve RAM buffer [mem 0x9bfb1000-0x9bffffff] May 27 17:35:06.948665 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device May 27 17:35:06.948828 kernel: pci 0000:00:01.0: vgaarb: bridge control possible May 27 17:35:06.949005 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 27 17:35:06.949029 kernel: vgaarb: loaded May 27 17:35:06.949041 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 May 27 17:35:06.949052 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter May 27 17:35:06.949062 kernel: clocksource: Switched to clocksource kvm-clock May 27 17:35:06.949073 kernel: VFS: Disk quotas dquot_6.6.0 May 27 17:35:06.949083 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 27 17:35:06.949094 kernel: pnp: PnP ACPI init May 27 17:35:06.949290 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved May 27 17:35:06.949313 kernel: pnp: PnP ACPI: found 6 devices May 27 17:35:06.949325 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 27 17:35:06.949337 kernel: NET: Registered PF_INET protocol family May 27 17:35:06.949348 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 27 17:35:06.949360 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 27 17:35:06.949372 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 27 17:35:06.949383 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 27 17:35:06.949395 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 27 17:35:06.949406 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 27 17:35:06.949422 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 27 17:35:06.949433 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 27 17:35:06.949444 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 27 17:35:06.949455 kernel: NET: Registered PF_XDP protocol family May 27 17:35:06.949665 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window May 27 17:35:06.949838 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned May 27 17:35:06.950000 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 27 17:35:06.950145 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 27 17:35:06.950297 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] May 27 17:35:06.950473 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] May 27 17:35:06.950641 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] May 27 17:35:06.950784 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] May 27 17:35:06.950805 kernel: PCI: CLS 0 bytes, default 64 May 27 17:35:06.950818 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns May 27 17:35:06.950827 kernel: Initialise system trusted keyrings May 27 17:35:06.950835 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 27 17:35:06.950849 kernel: Key type asymmetric registered May 27 17:35:06.950857 kernel: Asymmetric key parser 'x509' registered May 27 17:35:06.950880 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 27 17:35:06.950890 kernel: io scheduler mq-deadline registered May 27 17:35:06.950898 kernel: io scheduler kyber registered May 27 17:35:06.950906 kernel: io scheduler bfq registered May 27 17:35:06.950915 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 27 17:35:06.950923 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 May 27 17:35:06.950932 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 May 27 17:35:06.950951 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 May 27 17:35:06.950961 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 27 17:35:06.950972 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 27 17:35:06.950980 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 May 27 17:35:06.950988 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 May 27 17:35:06.950996 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 May 27 17:35:06.951145 kernel: rtc_cmos 00:04: RTC can wake from S4 May 27 17:35:06.951159 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 May 27 17:35:06.951305 kernel: rtc_cmos 00:04: registered as rtc0 May 27 17:35:06.951446 kernel: rtc_cmos 00:04: setting system clock to 2025-05-27T17:35:06 UTC (1748367306) May 27 17:35:06.951578 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram May 27 17:35:06.951590 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled May 27 17:35:06.951599 kernel: efifb: probing for efifb May 27 17:35:06.951607 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k May 27 17:35:06.951616 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 May 27 17:35:06.951624 kernel: efifb: scrolling: redraw May 27 17:35:06.951632 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 27 17:35:06.951644 kernel: Console: switching to colour frame buffer device 160x50 May 27 17:35:06.951653 kernel: fb0: EFI VGA frame buffer device May 27 17:35:06.951664 kernel: pstore: Using crash dump compression: deflate May 27 17:35:06.951678 kernel: pstore: Registered efi_pstore as persistent store backend May 27 17:35:06.951688 kernel: NET: Registered PF_INET6 protocol family May 27 17:35:06.951699 kernel: Segment Routing with IPv6 May 27 17:35:06.951713 kernel: In-situ OAM (IOAM) with IPv6 May 27 17:35:06.951724 kernel: NET: Registered PF_PACKET protocol family May 27 17:35:06.951734 kernel: Key type dns_resolver registered May 27 17:35:06.951745 kernel: IPI shorthand broadcast: enabled May 27 17:35:06.951755 kernel: sched_clock: Marking stable (3642002901, 145326567)->(3826624136, -39294668) May 27 17:35:06.951766 kernel: registered taskstats version 1 May 27 17:35:06.951776 kernel: Loading compiled-in X.509 certificates May 27 17:35:06.951788 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.30-flatcar: 9507e5c390e18536b38d58c90da64baf0ac9837c' May 27 17:35:06.951798 kernel: Demotion targets for Node 0: null May 27 17:35:06.951812 kernel: Key type .fscrypt registered May 27 17:35:06.951823 kernel: Key type fscrypt-provisioning registered May 27 17:35:06.951833 kernel: ima: No TPM chip found, activating TPM-bypass! May 27 17:35:06.951845 kernel: ima: Allocated hash algorithm: sha1 May 27 17:35:06.951856 kernel: ima: No architecture policies found May 27 17:35:06.951867 kernel: clk: Disabling unused clocks May 27 17:35:06.951878 kernel: Warning: unable to open an initial console. May 27 17:35:06.951889 kernel: Freeing unused kernel image (initmem) memory: 54416K May 27 17:35:06.951900 kernel: Write protecting the kernel read-only data: 24576k May 27 17:35:06.951914 kernel: Freeing unused kernel image (rodata/data gap) memory: 288K May 27 17:35:06.951925 kernel: Run /init as init process May 27 17:35:06.951946 kernel: with arguments: May 27 17:35:06.951956 kernel: /init May 27 17:35:06.951966 kernel: with environment: May 27 17:35:06.951977 kernel: HOME=/ May 27 17:35:06.951987 kernel: TERM=linux May 27 17:35:06.951997 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 27 17:35:06.952009 systemd[1]: Successfully made /usr/ read-only. May 27 17:35:06.952027 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 27 17:35:06.952039 systemd[1]: Detected virtualization kvm. May 27 17:35:06.952049 systemd[1]: Detected architecture x86-64. May 27 17:35:06.952060 systemd[1]: Running in initrd. May 27 17:35:06.952071 systemd[1]: No hostname configured, using default hostname. May 27 17:35:06.952082 systemd[1]: Hostname set to . May 27 17:35:06.952096 systemd[1]: Initializing machine ID from VM UUID. May 27 17:35:06.952108 systemd[1]: Queued start job for default target initrd.target. May 27 17:35:06.952120 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 27 17:35:06.952131 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 27 17:35:06.952144 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 27 17:35:06.952158 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 27 17:35:06.952170 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 27 17:35:06.952182 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 27 17:35:06.952199 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 27 17:35:06.952208 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 27 17:35:06.952217 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 27 17:35:06.952229 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 27 17:35:06.952240 systemd[1]: Reached target paths.target - Path Units. May 27 17:35:06.952252 systemd[1]: Reached target slices.target - Slice Units. May 27 17:35:06.952263 systemd[1]: Reached target swap.target - Swaps. May 27 17:35:06.952274 systemd[1]: Reached target timers.target - Timer Units. May 27 17:35:06.952290 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 27 17:35:06.952311 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 27 17:35:06.952325 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 27 17:35:06.952345 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 27 17:35:06.952366 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 27 17:35:06.952382 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 27 17:35:06.952394 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 27 17:35:06.952405 systemd[1]: Reached target sockets.target - Socket Units. May 27 17:35:06.952420 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 27 17:35:06.952432 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 27 17:35:06.952444 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 27 17:35:06.952456 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). May 27 17:35:06.952467 systemd[1]: Starting systemd-fsck-usr.service... May 27 17:35:06.952478 systemd[1]: Starting systemd-journald.service - Journal Service... May 27 17:35:06.952489 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 27 17:35:06.952500 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 17:35:06.952525 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 27 17:35:06.952540 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 27 17:35:06.952551 systemd[1]: Finished systemd-fsck-usr.service. May 27 17:35:06.952563 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 27 17:35:06.952608 systemd-journald[219]: Collecting audit messages is disabled. May 27 17:35:06.952642 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 27 17:35:06.952655 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 27 17:35:06.952667 systemd-journald[219]: Journal started May 27 17:35:06.952691 systemd-journald[219]: Runtime Journal (/run/log/journal/e254593e671d46ffb93c17a30454865c) is 6M, max 48.2M, 42.2M free. May 27 17:35:06.952829 systemd-modules-load[222]: Inserted module 'overlay' May 27 17:35:06.956533 systemd[1]: Started systemd-journald.service - Journal Service. May 27 17:35:06.957641 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 27 17:35:06.963206 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:06.968644 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 27 17:35:06.977056 systemd-tmpfiles[236]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 27 17:35:07.026052 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 17:35:07.026925 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 27 17:35:07.026689 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 17:35:07.032102 systemd-modules-load[222]: Inserted module 'br_netfilter' May 27 17:35:07.032530 kernel: Bridge firewalling registered May 27 17:35:07.033336 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 27 17:35:07.037064 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 27 17:35:07.047025 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 27 17:35:07.051118 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 27 17:35:07.063748 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 27 17:35:07.068358 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 27 17:35:07.083167 dracut-cmdline[260]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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,115200 flatcar.first_boot=detected verity.usrhash=daa3e2d55cc4a7ff0ec15aa9bb0c07df9999cb4e3041f3adad1b1101efdea101 May 27 17:35:07.132289 systemd-resolved[263]: Positive Trust Anchors: May 27 17:35:07.132315 systemd-resolved[263]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 27 17:35:07.132357 systemd-resolved[263]: 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 27 17:35:07.135443 systemd-resolved[263]: Defaulting to hostname 'linux'. May 27 17:35:07.137182 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 27 17:35:07.143102 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 27 17:35:07.212571 kernel: SCSI subsystem initialized May 27 17:35:07.222561 kernel: Loading iSCSI transport class v2.0-870. May 27 17:35:07.235569 kernel: iscsi: registered transport (tcp) May 27 17:35:07.261025 kernel: iscsi: registered transport (qla4xxx) May 27 17:35:07.261126 kernel: QLogic iSCSI HBA Driver May 27 17:35:07.287825 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 27 17:35:07.308651 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 27 17:35:07.312741 systemd[1]: Reached target network-pre.target - Preparation for Network. May 27 17:35:07.379006 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 27 17:35:07.381187 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 27 17:35:07.445569 kernel: raid6: avx2x4 gen() 29608 MB/s May 27 17:35:07.462571 kernel: raid6: avx2x2 gen() 27643 MB/s May 27 17:35:07.479848 kernel: raid6: avx2x1 gen() 20938 MB/s May 27 17:35:07.479952 kernel: raid6: using algorithm avx2x4 gen() 29608 MB/s May 27 17:35:07.497931 kernel: raid6: .... xor() 5895 MB/s, rmw enabled May 27 17:35:07.498052 kernel: raid6: using avx2x2 recovery algorithm May 27 17:35:07.522570 kernel: xor: automatically using best checksumming function avx May 27 17:35:07.725581 kernel: Btrfs loaded, zoned=no, fsverity=no May 27 17:35:07.737367 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 27 17:35:07.740052 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 17:35:07.777027 systemd-udevd[472]: Using default interface naming scheme 'v255'. May 27 17:35:07.783863 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 17:35:07.787711 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 27 17:35:07.828014 dracut-pre-trigger[479]: rd.md=0: removing MD RAID activation May 27 17:35:07.865933 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 27 17:35:07.867626 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 27 17:35:07.963011 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 27 17:35:07.966190 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 27 17:35:08.044593 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues May 27 17:35:08.052833 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 27 17:35:08.071249 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 27 17:35:08.071500 kernel: cryptd: max_cpu_qlen set to 1000 May 27 17:35:08.053017 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:08.073867 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 27 17:35:08.077096 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 17:35:08.080123 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 17:35:08.079693 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. May 27 17:35:08.082530 kernel: libata version 3.00 loaded. May 27 17:35:08.083291 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 27 17:35:08.083444 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:08.092664 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 17:35:08.112903 kernel: AES CTR mode by8 optimization enabled May 27 17:35:08.134397 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 May 27 17:35:08.134457 kernel: ahci 0000:00:1f.2: version 3.0 May 27 17:35:08.136534 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 May 27 17:35:08.164441 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode May 27 17:35:08.164732 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) May 27 17:35:08.164875 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only May 27 17:35:08.176561 kernel: scsi host0: ahci May 27 17:35:08.176886 kernel: scsi host1: ahci May 27 17:35:08.177707 kernel: scsi host2: ahci May 27 17:35:08.184544 kernel: scsi host3: ahci May 27 17:35:08.188538 kernel: scsi host4: ahci May 27 17:35:08.192380 kernel: scsi host5: ahci May 27 17:35:08.192590 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 0 May 27 17:35:08.192603 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 0 May 27 17:35:08.193776 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 27 17:35:08.214055 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 0 May 27 17:35:08.214097 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 0 May 27 17:35:08.214113 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 0 May 27 17:35:08.214145 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 0 May 27 17:35:08.212750 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:08.238247 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 27 17:35:08.252304 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 27 17:35:08.265101 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 27 17:35:08.268958 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 27 17:35:08.277139 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 27 17:35:08.349548 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 17:35:08.383567 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 17:35:08.523566 kernel: ata4: SATA link down (SStatus 0 SControl 300) May 27 17:35:08.523642 kernel: ata1: SATA link down (SStatus 0 SControl 300) May 27 17:35:08.525812 kernel: ata2: SATA link down (SStatus 0 SControl 300) May 27 17:35:08.525832 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) May 27 17:35:08.526521 kernel: ata5: SATA link down (SStatus 0 SControl 300) May 27 17:35:08.527555 kernel: ata6: SATA link down (SStatus 0 SControl 300) May 27 17:35:08.527651 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 May 27 17:35:08.528692 kernel: ata3.00: applying bridge limits May 27 17:35:08.528748 kernel: ata3.00: configured for UDMA/100 May 27 17:35:08.531548 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 May 27 17:35:08.579695 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray May 27 17:35:08.579992 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 27 17:35:08.592539 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 May 27 17:35:08.966472 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 27 17:35:08.968466 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 27 17:35:08.970446 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 27 17:35:08.974235 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 27 17:35:08.975739 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 27 17:35:09.007278 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 27 17:35:09.390544 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 27 17:35:09.391027 disk-uuid[636]: The operation has completed successfully. May 27 17:35:09.432666 systemd[1]: disk-uuid.service: Deactivated successfully. May 27 17:35:09.432912 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 27 17:35:09.473435 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 27 17:35:09.502279 sh[666]: Success May 27 17:35:09.524808 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 27 17:35:09.524903 kernel: device-mapper: uevent: version 1.0.3 May 27 17:35:09.526146 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 27 17:35:09.536556 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 27 17:35:09.578859 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 27 17:35:09.583073 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 27 17:35:09.607102 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 27 17:35:09.614089 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' May 27 17:35:09.614151 kernel: BTRFS: device fsid 7caef027-0915-4c01-a3d5-28eff70f7ebd devid 1 transid 39 /dev/mapper/usr (253:0) scanned by mount (678) May 27 17:35:09.616633 kernel: BTRFS info (device dm-0): first mount of filesystem 7caef027-0915-4c01-a3d5-28eff70f7ebd May 27 17:35:09.616717 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 27 17:35:09.616734 kernel: BTRFS info (device dm-0): using free-space-tree May 27 17:35:09.625371 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 27 17:35:09.627389 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 27 17:35:09.629005 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 27 17:35:09.630186 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 27 17:35:09.632321 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 27 17:35:09.679589 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (711) May 27 17:35:09.682261 kernel: BTRFS info (device vda6): first mount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212 May 27 17:35:09.682338 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 27 17:35:09.682351 kernel: BTRFS info (device vda6): using free-space-tree May 27 17:35:09.694563 kernel: BTRFS info (device vda6): last unmount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212 May 27 17:35:09.696266 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 27 17:35:09.698950 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 27 17:35:09.928786 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 27 17:35:09.935973 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 27 17:35:09.979945 ignition[756]: Ignition 2.21.0 May 27 17:35:09.980390 ignition[756]: Stage: fetch-offline May 27 17:35:09.980438 ignition[756]: no configs at "/usr/lib/ignition/base.d" May 27 17:35:09.980448 ignition[756]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 17:35:09.980579 ignition[756]: parsed url from cmdline: "" May 27 17:35:09.980586 ignition[756]: no config URL provided May 27 17:35:09.980592 ignition[756]: reading system config file "/usr/lib/ignition/user.ign" May 27 17:35:09.980601 ignition[756]: no config at "/usr/lib/ignition/user.ign" May 27 17:35:09.980628 ignition[756]: op(1): [started] loading QEMU firmware config module May 27 17:35:09.980637 ignition[756]: op(1): executing: "modprobe" "qemu_fw_cfg" May 27 17:35:09.990805 ignition[756]: op(1): [finished] loading QEMU firmware config module May 27 17:35:09.992464 ignition[756]: parsing config with SHA512: ad10f60fd8f5886c745fe1733a2d88b3c3e445ff867c03eec6a58ed52da351cf2e94912280c1a88535c0fb38198270905c9179eb2b3c53f44e2cf624d4522067 May 27 17:35:10.002470 unknown[756]: fetched base config from "system" May 27 17:35:10.002486 unknown[756]: fetched user config from "qemu" May 27 17:35:10.003125 ignition[756]: fetch-offline: fetch-offline passed May 27 17:35:10.003257 ignition[756]: Ignition finished successfully May 27 17:35:10.008906 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 27 17:35:10.014339 systemd-networkd[852]: lo: Link UP May 27 17:35:10.014358 systemd-networkd[852]: lo: Gained carrier May 27 17:35:10.016305 systemd-networkd[852]: Enumeration completed May 27 17:35:10.016464 systemd[1]: Started systemd-networkd.service - Network Configuration. May 27 17:35:10.016782 systemd-networkd[852]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 17:35:10.016788 systemd-networkd[852]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 27 17:35:10.016884 systemd[1]: Reached target network.target - Network. May 27 17:35:10.018242 systemd-networkd[852]: eth0: Link UP May 27 17:35:10.018248 systemd-networkd[852]: eth0: Gained carrier May 27 17:35:10.018261 systemd-networkd[852]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 17:35:10.018964 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 27 17:35:10.020011 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 27 17:35:10.038603 systemd-networkd[852]: eth0: DHCPv4 address 10.0.0.10/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 27 17:35:10.058240 ignition[859]: Ignition 2.21.0 May 27 17:35:10.058256 ignition[859]: Stage: kargs May 27 17:35:10.058456 ignition[859]: no configs at "/usr/lib/ignition/base.d" May 27 17:35:10.058472 ignition[859]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 17:35:10.061645 ignition[859]: kargs: kargs passed May 27 17:35:10.061703 ignition[859]: Ignition finished successfully May 27 17:35:10.067180 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 27 17:35:10.070347 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 27 17:35:10.106344 ignition[868]: Ignition 2.21.0 May 27 17:35:10.106401 ignition[868]: Stage: disks May 27 17:35:10.106607 ignition[868]: no configs at "/usr/lib/ignition/base.d" May 27 17:35:10.106628 ignition[868]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 17:35:10.109185 ignition[868]: disks: disks passed May 27 17:35:10.109274 ignition[868]: Ignition finished successfully May 27 17:35:10.112690 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 27 17:35:10.114951 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 27 17:35:10.115124 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 27 17:35:10.117947 systemd[1]: Reached target local-fs.target - Local File Systems. May 27 17:35:10.118023 systemd[1]: Reached target sysinit.target - System Initialization. May 27 17:35:10.120539 systemd[1]: Reached target basic.target - Basic System. May 27 17:35:10.127887 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 27 17:35:10.196306 systemd-resolved[263]: Detected conflict on linux IN A 10.0.0.10 May 27 17:35:10.196325 systemd-resolved[263]: Hostname conflict, changing published hostname from 'linux' to 'linux4'. May 27 17:35:10.200688 systemd-fsck[878]: ROOT: clean, 15/553520 files, 52789/553472 blocks May 27 17:35:10.208930 systemd-resolved[263]: Detected conflict on linux4 IN A 10.0.0.10 May 27 17:35:10.208956 systemd-resolved[263]: Hostname conflict, changing published hostname from 'linux4' to 'linux14'. May 27 17:35:10.215241 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 27 17:35:10.218286 systemd[1]: Mounting sysroot.mount - /sysroot... May 27 17:35:10.446528 kernel: EXT4-fs (vda9): mounted filesystem bf93e767-f532-4480-b210-a196f7ac181e r/w with ordered data mode. Quota mode: none. May 27 17:35:10.447456 systemd[1]: Mounted sysroot.mount - /sysroot. May 27 17:35:10.448307 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 27 17:35:10.452601 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 27 17:35:10.456308 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 27 17:35:10.458574 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 27 17:35:10.458633 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 27 17:35:10.458662 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 27 17:35:10.477463 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 27 17:35:10.479552 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 27 17:35:10.483056 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (886) May 27 17:35:10.483083 kernel: BTRFS info (device vda6): first mount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212 May 27 17:35:10.485309 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 27 17:35:10.485379 kernel: BTRFS info (device vda6): using free-space-tree May 27 17:35:10.492076 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 27 17:35:10.528989 initrd-setup-root[910]: cut: /sysroot/etc/passwd: No such file or directory May 27 17:35:10.533870 initrd-setup-root[917]: cut: /sysroot/etc/group: No such file or directory May 27 17:35:10.539726 initrd-setup-root[924]: cut: /sysroot/etc/shadow: No such file or directory May 27 17:35:10.545602 initrd-setup-root[931]: cut: /sysroot/etc/gshadow: No such file or directory May 27 17:35:10.655556 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 27 17:35:10.658793 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 27 17:35:10.659821 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 27 17:35:10.688168 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 27 17:35:10.691602 kernel: BTRFS info (device vda6): last unmount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212 May 27 17:35:10.708726 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 27 17:35:10.760374 ignition[1000]: INFO : Ignition 2.21.0 May 27 17:35:10.760374 ignition[1000]: INFO : Stage: mount May 27 17:35:10.762728 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" May 27 17:35:10.762728 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 17:35:10.762728 ignition[1000]: INFO : mount: mount passed May 27 17:35:10.762728 ignition[1000]: INFO : Ignition finished successfully May 27 17:35:10.769283 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 27 17:35:10.770542 systemd[1]: Starting ignition-files.service - Ignition (files)... May 27 17:35:10.799747 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 27 17:35:10.824535 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (1012) May 27 17:35:10.826676 kernel: BTRFS info (device vda6): first mount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212 May 27 17:35:10.826711 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 27 17:35:10.826726 kernel: BTRFS info (device vda6): using free-space-tree May 27 17:35:10.831217 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 27 17:35:10.887276 ignition[1029]: INFO : Ignition 2.21.0 May 27 17:35:10.929827 ignition[1029]: INFO : Stage: files May 27 17:35:10.929827 ignition[1029]: INFO : no configs at "/usr/lib/ignition/base.d" May 27 17:35:10.929827 ignition[1029]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 17:35:10.929827 ignition[1029]: DEBUG : files: compiled without relabeling support, skipping May 27 17:35:10.929827 ignition[1029]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 27 17:35:10.929827 ignition[1029]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 27 17:35:10.929827 ignition[1029]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 27 17:35:10.929827 ignition[1029]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 27 17:35:10.929827 ignition[1029]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 27 17:35:10.929827 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 27 17:35:10.929827 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(4): [started] processing unit "etcd-member.service" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(4): [finished] processing unit "etcd-member.service" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(6): [started] processing unit "flannel-docker-opts.service" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(6): op(7): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(6): op(7): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(6): [finished] processing unit "flannel-docker-opts.service" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(8): [started] processing unit "docker.service" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(8): [finished] processing unit "docker.service" May 27 17:35:10.929827 ignition[1029]: INFO : files: op(9): [started] processing unit "flanneld.service" May 27 17:35:10.895381 unknown[1029]: wrote ssh authorized keys file for user: core May 27 17:35:10.969388 ignition[1029]: INFO : files: op(9): op(a): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(9): op(a): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(9): [finished] processing unit "flanneld.service" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(b): [started] processing unit "coreos-metadata.service" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(b): op(c): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(b): op(c): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(b): [finished] processing unit "coreos-metadata.service" May 27 17:35:10.969388 ignition[1029]: INFO : files: op(d): [started] setting preset to disabled for "coreos-metadata.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(d): op(e): [started] removing enablement symlink(s) for "coreos-metadata.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(d): op(e): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(d): [finished] setting preset to disabled for "coreos-metadata.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(f): [started] setting preset to enabled for "docker.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(f): [finished] setting preset to enabled for "docker.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(10): [started] setting preset to enabled for "etcd-member.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(10): [finished] setting preset to enabled for "etcd-member.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(11): [started] setting preset to enabled for "flanneld.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: op(11): [finished] setting preset to enabled for "flanneld.service" May 27 17:35:10.985868 ignition[1029]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" May 27 17:35:10.985868 ignition[1029]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" May 27 17:35:10.985868 ignition[1029]: INFO : files: files passed May 27 17:35:10.985868 ignition[1029]: INFO : Ignition finished successfully May 27 17:35:10.986013 systemd[1]: Finished ignition-files.service - Ignition (files). May 27 17:35:10.991823 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 27 17:35:10.994728 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 27 17:35:11.033634 systemd[1]: ignition-quench.service: Deactivated successfully. May 27 17:35:11.034453 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 27 17:35:11.040351 initrd-setup-root-after-ignition[1058]: grep: /sysroot/oem/oem-release: No such file or directory May 27 17:35:11.045149 initrd-setup-root-after-ignition[1060]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 27 17:35:11.045149 initrd-setup-root-after-ignition[1060]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 27 17:35:11.049334 initrd-setup-root-after-ignition[1064]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 27 17:35:11.051850 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 27 17:35:11.055530 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 27 17:35:11.058355 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 27 17:35:11.106679 systemd-networkd[852]: eth0: Gained IPv6LL May 27 17:35:11.120039 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 27 17:35:11.120169 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 27 17:35:11.120656 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 27 17:35:11.121042 systemd[1]: Reached target initrd.target - Initrd Default Target. May 27 17:35:11.121458 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 27 17:35:11.122485 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 27 17:35:11.156751 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 27 17:35:11.158703 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 27 17:35:11.203085 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 27 17:35:11.203393 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 27 17:35:11.205803 systemd[1]: Stopped target timers.target - Timer Units. May 27 17:35:11.208016 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 27 17:35:11.208216 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 27 17:35:11.212954 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 27 17:35:11.214152 systemd[1]: Stopped target basic.target - Basic System. May 27 17:35:11.215315 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 27 17:35:11.215949 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 27 17:35:11.216279 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 27 17:35:11.216740 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 27 17:35:11.217229 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 27 17:35:11.217574 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 27 17:35:11.218080 systemd[1]: Stopped target sysinit.target - System Initialization. May 27 17:35:11.218418 systemd[1]: Stopped target local-fs.target - Local File Systems. May 27 17:35:11.218914 systemd[1]: Stopped target swap.target - Swaps. May 27 17:35:11.219210 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 27 17:35:11.219387 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 27 17:35:11.237540 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 27 17:35:11.237724 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 27 17:35:11.238033 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 27 17:35:11.241973 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 27 17:35:11.245488 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 27 17:35:11.245669 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 27 17:35:11.248890 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 27 17:35:11.249026 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 27 17:35:11.253151 systemd[1]: Stopped target paths.target - Path Units. May 27 17:35:11.253270 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 27 17:35:11.255242 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 27 17:35:11.256890 systemd[1]: Stopped target slices.target - Slice Units. May 27 17:35:11.258251 systemd[1]: Stopped target sockets.target - Socket Units. May 27 17:35:11.260992 systemd[1]: iscsid.socket: Deactivated successfully. May 27 17:35:11.261122 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 27 17:35:11.263018 systemd[1]: iscsiuio.socket: Deactivated successfully. May 27 17:35:11.263124 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 27 17:35:11.265118 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 27 17:35:11.265264 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 27 17:35:11.267188 systemd[1]: ignition-files.service: Deactivated successfully. May 27 17:35:11.267324 systemd[1]: Stopped ignition-files.service - Ignition (files). May 27 17:35:11.271830 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 27 17:35:11.274475 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 27 17:35:11.274674 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 27 17:35:11.276250 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 27 17:35:11.281239 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 27 17:35:11.281391 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 27 17:35:11.281971 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 27 17:35:11.282109 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 27 17:35:11.295999 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 27 17:35:11.296179 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 27 17:35:11.314862 ignition[1084]: INFO : Ignition 2.21.0 May 27 17:35:11.314862 ignition[1084]: INFO : Stage: umount May 27 17:35:11.317162 ignition[1084]: INFO : no configs at "/usr/lib/ignition/base.d" May 27 17:35:11.317162 ignition[1084]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 27 17:35:11.320116 ignition[1084]: INFO : umount: umount passed May 27 17:35:11.320116 ignition[1084]: INFO : Ignition finished successfully May 27 17:35:11.320581 systemd[1]: ignition-mount.service: Deactivated successfully. May 27 17:35:11.320721 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 27 17:35:11.324648 systemd[1]: Stopped target network.target - Network. May 27 17:35:11.325827 systemd[1]: ignition-disks.service: Deactivated successfully. May 27 17:35:11.325939 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 27 17:35:11.326247 systemd[1]: ignition-kargs.service: Deactivated successfully. May 27 17:35:11.326306 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 27 17:35:11.326818 systemd[1]: ignition-setup.service: Deactivated successfully. May 27 17:35:11.326893 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 27 17:35:11.327203 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 27 17:35:11.327258 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 27 17:35:11.327949 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 27 17:35:11.328301 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 27 17:35:11.341638 systemd[1]: systemd-resolved.service: Deactivated successfully. May 27 17:35:11.341889 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 27 17:35:11.347222 systemd[1]: sysroot-boot.service: Deactivated successfully. May 27 17:35:11.347401 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 27 17:35:11.350761 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 27 17:35:11.350907 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 27 17:35:11.352130 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 27 17:35:11.352206 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 17:35:11.356114 systemd[1]: systemd-networkd.service: Deactivated successfully. May 27 17:35:11.356276 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 27 17:35:11.359706 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 27 17:35:11.362715 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 27 17:35:11.362806 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 27 17:35:11.366818 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 27 17:35:11.368778 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 27 17:35:11.368857 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 27 17:35:11.371430 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 27 17:35:11.371492 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 27 17:35:11.375973 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 27 17:35:11.376028 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 27 17:35:11.377193 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 17:35:11.395307 systemd[1]: network-cleanup.service: Deactivated successfully. May 27 17:35:11.395487 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 27 17:35:11.405905 systemd[1]: systemd-udevd.service: Deactivated successfully. May 27 17:35:11.406134 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 17:35:11.409061 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 27 17:35:11.409124 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 27 17:35:11.411520 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 27 17:35:11.411571 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 27 17:35:11.412800 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 27 17:35:11.412919 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 27 17:35:11.418589 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 27 17:35:11.418685 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 27 17:35:11.422979 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 27 17:35:11.423057 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 27 17:35:11.429668 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 27 17:35:11.429852 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 27 17:35:11.429951 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 27 17:35:11.434844 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 27 17:35:11.434942 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 17:35:11.439059 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 27 17:35:11.439119 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:11.459172 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 27 17:35:11.459345 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 27 17:35:11.460123 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 27 17:35:11.465571 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 27 17:35:11.493524 systemd[1]: Switching root. May 27 17:35:11.534170 systemd-journald[219]: Journal stopped May 27 17:35:12.669660 systemd-journald[219]: Received SIGTERM from PID 1 (systemd). May 27 17:35:12.669738 kernel: SELinux: policy capability network_peer_controls=1 May 27 17:35:12.669766 kernel: SELinux: policy capability open_perms=1 May 27 17:35:12.669784 kernel: SELinux: policy capability extended_socket_class=1 May 27 17:35:12.669815 kernel: SELinux: policy capability always_check_network=0 May 27 17:35:12.669831 kernel: SELinux: policy capability cgroup_seclabel=1 May 27 17:35:12.669867 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 27 17:35:12.669882 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 27 17:35:12.669896 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 27 17:35:12.669912 kernel: SELinux: policy capability userspace_initial_context=0 May 27 17:35:12.669927 kernel: audit: type=1403 audit(1748367311.637:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 27 17:35:12.669956 systemd[1]: Successfully loaded SELinux policy in 50.345ms. May 27 17:35:12.669989 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 13.119ms. May 27 17:35:12.670007 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 27 17:35:12.670027 systemd[1]: Detected virtualization kvm. May 27 17:35:12.670043 systemd[1]: Detected architecture x86-64. May 27 17:35:12.670059 systemd[1]: Detected first boot. May 27 17:35:12.670075 systemd[1]: Initializing machine ID from VM UUID. May 27 17:35:12.670091 zram_generator::config[1129]: No configuration found. May 27 17:35:12.670109 kernel: Guest personality initialized and is inactive May 27 17:35:12.670127 kernel: VMCI host device registered (name=vmci, major=10, minor=125) May 27 17:35:12.670142 kernel: Initialized host personality May 27 17:35:12.670157 kernel: NET: Registered PF_VSOCK protocol family May 27 17:35:12.670173 systemd[1]: Populated /etc with preset unit settings. May 27 17:35:12.670190 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 27 17:35:12.670206 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 27 17:35:12.670223 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 27 17:35:12.670248 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 27 17:35:12.670265 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 27 17:35:12.670285 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 27 17:35:12.670301 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 27 17:35:12.670318 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 27 17:35:12.670334 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 27 17:35:12.670358 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 27 17:35:12.670377 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 27 17:35:12.670393 systemd[1]: Created slice user.slice - User and Session Slice. May 27 17:35:12.670409 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 27 17:35:12.670425 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 27 17:35:12.670445 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 27 17:35:12.670462 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 27 17:35:12.670478 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 27 17:35:12.670494 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 27 17:35:12.670526 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 27 17:35:12.670543 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 27 17:35:12.670559 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 27 17:35:12.670580 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 27 17:35:12.670596 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 27 17:35:12.670612 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 27 17:35:12.670649 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 27 17:35:12.670665 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 27 17:35:12.670681 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 27 17:35:12.670697 systemd[1]: Reached target slices.target - Slice Units. May 27 17:35:12.670714 systemd[1]: Reached target swap.target - Swaps. May 27 17:35:12.670730 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 27 17:35:12.670746 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 27 17:35:12.670765 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 27 17:35:12.670782 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 27 17:35:12.670807 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 27 17:35:12.670824 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 27 17:35:12.670840 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 27 17:35:12.670856 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 27 17:35:12.670873 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 27 17:35:12.670888 systemd[1]: Mounting media.mount - External Media Directory... May 27 17:35:12.670912 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 27 17:35:12.670930 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 27 17:35:12.670947 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 27 17:35:12.670963 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 27 17:35:12.670979 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 27 17:35:12.670996 systemd[1]: Reached target machines.target - Containers. May 27 17:35:12.671020 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 27 17:35:12.671037 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 17:35:12.671053 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 27 17:35:12.671073 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 27 17:35:12.671092 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 17:35:12.671110 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 27 17:35:12.671128 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 17:35:12.671146 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 27 17:35:12.671162 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 17:35:12.671178 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 27 17:35:12.671194 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 27 17:35:12.671214 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 27 17:35:12.671230 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 27 17:35:12.671246 systemd[1]: Stopped systemd-fsck-usr.service. May 27 17:35:12.671264 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 27 17:35:12.671280 systemd[1]: Starting systemd-journald.service - Journal Service... May 27 17:35:12.671296 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 27 17:35:12.671312 kernel: loop: module loaded May 27 17:35:12.671328 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 27 17:35:12.671344 kernel: fuse: init (API version 7.41) May 27 17:35:12.671363 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 27 17:35:12.671401 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 27 17:35:12.671447 systemd-journald[1193]: Collecting audit messages is disabled. May 27 17:35:12.671476 systemd-journald[1193]: Journal started May 27 17:35:12.671526 systemd-journald[1193]: Runtime Journal (/run/log/journal/e254593e671d46ffb93c17a30454865c) is 6M, max 48.2M, 42.2M free. May 27 17:35:12.299704 systemd[1]: Queued start job for default target multi-user.target. May 27 17:35:12.313348 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 27 17:35:12.313957 systemd[1]: systemd-journald.service: Deactivated successfully. May 27 17:35:12.683015 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 27 17:35:12.686459 systemd[1]: verity-setup.service: Deactivated successfully. May 27 17:35:12.686487 systemd[1]: Stopped verity-setup.service. May 27 17:35:12.686502 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 27 17:35:12.707590 systemd[1]: Started systemd-journald.service - Journal Service. May 27 17:35:12.736831 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 27 17:35:12.739938 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 27 17:35:12.742294 systemd[1]: Mounted media.mount - External Media Directory. May 27 17:35:12.744544 kernel: ACPI: bus type drm_connector registered May 27 17:35:12.745047 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 27 17:35:12.746672 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 27 17:35:12.757149 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 27 17:35:12.759077 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 27 17:35:12.761273 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 27 17:35:12.761619 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 27 17:35:12.763686 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 17:35:12.764000 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 17:35:12.779738 systemd[1]: modprobe@drm.service: Deactivated successfully. May 27 17:35:12.780110 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 27 17:35:12.782470 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 17:35:12.782912 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 17:35:12.784981 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 27 17:35:12.785317 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 27 17:35:12.787339 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 17:35:12.787715 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 17:35:12.789862 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 27 17:35:12.791777 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 27 17:35:12.794852 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 27 17:35:12.796879 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 27 17:35:12.816966 systemd[1]: Reached target network-pre.target - Preparation for Network. May 27 17:35:12.821296 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 27 17:35:12.826055 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 27 17:35:12.827467 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 27 17:35:12.827537 systemd[1]: Reached target local-fs.target - Local File Systems. May 27 17:35:12.830786 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 27 17:35:12.834687 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 27 17:35:12.838487 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 17:35:12.841761 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 27 17:35:12.846492 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 27 17:35:12.848489 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 17:35:12.852743 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 27 17:35:12.854434 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 17:35:12.858724 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 27 17:35:12.881948 systemd-journald[1193]: Time spent on flushing to /var/log/journal/e254593e671d46ffb93c17a30454865c is 23.986ms for 1019 entries. May 27 17:35:12.881948 systemd-journald[1193]: System Journal (/var/log/journal/e254593e671d46ffb93c17a30454865c) is 8M, max 195.6M, 187.6M free. May 27 17:35:13.064833 systemd-journald[1193]: Received client request to flush runtime journal. May 27 17:35:13.064928 kernel: loop0: detected capacity change from 0 to 113872 May 27 17:35:12.870015 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 27 17:35:12.874539 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 27 17:35:12.916737 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 27 17:35:12.951089 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 27 17:35:12.992728 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 27 17:35:13.000813 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 27 17:35:13.003979 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 27 17:35:13.008135 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 27 17:35:13.023592 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 27 17:35:13.036034 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 27 17:35:13.078266 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 27 17:35:13.097562 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 27 17:35:13.106818 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 27 17:35:13.131018 kernel: loop1: detected capacity change from 0 to 146240 May 27 17:35:13.198573 kernel: loop2: detected capacity change from 0 to 113872 May 27 17:35:13.202241 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 27 17:35:13.227368 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 27 17:35:13.316564 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 27 17:35:13.334487 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. May 27 17:35:13.334531 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. May 27 17:35:13.344272 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 27 17:35:13.355888 kernel: loop3: detected capacity change from 0 to 146240 May 27 17:35:13.382272 (sd-merge)[1267]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 27 17:35:13.384293 (sd-merge)[1267]: Merged extensions into '/usr'. May 27 17:35:13.390683 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 27 17:35:13.397469 systemd[1]: Starting ensure-sysext.service... May 27 17:35:13.408850 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 27 17:35:13.501711 systemd[1]: Reload requested from client PID 1273 ('systemctl') (unit ensure-sysext.service)... May 27 17:35:13.502485 systemd[1]: Reloading... May 27 17:35:13.517817 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 27 17:35:13.517889 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 27 17:35:13.518583 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 27 17:35:13.518966 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 27 17:35:13.520200 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 27 17:35:13.520571 systemd-tmpfiles[1274]: ACLs are not supported, ignoring. May 27 17:35:13.520659 systemd-tmpfiles[1274]: ACLs are not supported, ignoring. May 27 17:35:13.537908 systemd-tmpfiles[1274]: Detected autofs mount point /boot during canonicalization of boot. May 27 17:35:13.537929 systemd-tmpfiles[1274]: Skipping /boot May 27 17:35:13.652074 systemd-tmpfiles[1274]: Detected autofs mount point /boot during canonicalization of boot. May 27 17:35:13.652099 systemd-tmpfiles[1274]: Skipping /boot May 27 17:35:13.661581 zram_generator::config[1301]: No configuration found. May 27 17:35:13.896381 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 27 17:35:14.012781 ldconfig[1237]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 27 17:35:14.012429 systemd[1]: Reloading finished in 509 ms. May 27 17:35:14.074406 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 27 17:35:14.090643 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 27 17:35:14.112743 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 27 17:35:14.118857 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 27 17:35:14.144863 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 27 17:35:14.154657 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 27 17:35:14.158254 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 27 17:35:14.175815 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 27 17:35:14.176101 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 17:35:14.179197 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 17:35:14.183002 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 27 17:35:14.205155 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 17:35:14.206890 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 17:35:14.207060 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 27 17:35:14.210783 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 27 17:35:14.213603 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 27 17:35:14.218841 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 17:35:14.219198 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 17:35:14.225068 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 17:35:14.225412 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 17:35:14.235120 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 27 17:35:14.246939 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 27 17:35:14.247476 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 27 17:35:14.255988 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 27 17:35:14.264162 augenrules[1373]: No rules May 27 17:35:14.264926 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 27 17:35:14.265188 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 27 17:35:14.267191 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 27 17:35:14.272843 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 27 17:35:14.286738 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 27 17:35:14.288759 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 27 17:35:14.288846 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 27 17:35:14.288923 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 27 17:35:14.288994 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 27 17:35:14.290849 systemd[1]: Finished ensure-sysext.service. May 27 17:35:14.293066 systemd[1]: audit-rules.service: Deactivated successfully. May 27 17:35:14.293452 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 27 17:35:14.296142 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 27 17:35:14.296824 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 27 17:35:14.299154 systemd[1]: modprobe@drm.service: Deactivated successfully. May 27 17:35:14.299436 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 27 17:35:14.301234 systemd[1]: modprobe@loop.service: Deactivated successfully. May 27 17:35:14.301709 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 27 17:35:14.313035 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 27 17:35:14.317620 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 27 17:35:14.319935 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 27 17:35:14.351632 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 27 17:35:14.357594 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 27 17:35:14.362447 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 27 17:35:14.396544 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 27 17:35:14.411699 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 27 17:35:14.413829 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 27 17:35:14.421326 systemd-udevd[1394]: Using default interface naming scheme 'v255'. May 27 17:35:14.482024 systemd-resolved[1349]: Positive Trust Anchors: May 27 17:35:14.482902 systemd-resolved[1349]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 27 17:35:14.482960 systemd-resolved[1349]: 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 27 17:35:14.484171 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 27 17:35:14.486654 systemd[1]: Reached target time-set.target - System Time Set. May 27 17:35:14.489222 systemd-resolved[1349]: Defaulting to hostname 'linux'. May 27 17:35:14.491366 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 27 17:35:14.493985 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 27 17:35:14.516187 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 27 17:35:14.518132 systemd[1]: Reached target sysinit.target - System Initialization. May 27 17:35:14.519819 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 27 17:35:14.521602 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 27 17:35:14.524320 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. May 27 17:35:14.526020 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 27 17:35:14.531700 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 27 17:35:14.533280 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 27 17:35:14.535095 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 27 17:35:14.535347 systemd[1]: Reached target paths.target - Path Units. May 27 17:35:14.536984 systemd[1]: Reached target timers.target - Timer Units. May 27 17:35:14.542770 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 27 17:35:14.552074 systemd[1]: Starting docker.socket - Docker Socket for the API... May 27 17:35:14.566297 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 27 17:35:14.569100 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 27 17:35:14.572073 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 27 17:35:14.586185 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 27 17:35:14.593371 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 27 17:35:14.600867 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 27 17:35:14.602983 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 27 17:35:14.612179 systemd[1]: Reached target sockets.target - Socket Units. May 27 17:35:14.614670 systemd[1]: Reached target basic.target - Basic System. May 27 17:35:14.616696 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 27 17:35:14.616740 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 27 17:35:14.618868 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 27 17:35:14.627625 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 27 17:35:14.631367 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 27 17:35:14.634458 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 27 17:35:14.636083 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 27 17:35:14.643561 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... May 27 17:35:14.646917 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 27 17:35:14.650687 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 27 17:35:14.651290 jq[1429]: false May 27 17:35:14.657070 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 27 17:35:14.668381 systemd[1]: Starting systemd-logind.service - User Login Management... May 27 17:35:14.671413 oslogin_cache_refresh[1432]: Refreshing passwd entry cache May 27 17:35:14.696198 google_oslogin_nss_cache[1432]: oslogin_cache_refresh[1432]: Refreshing passwd entry cache May 27 17:35:14.696198 google_oslogin_nss_cache[1432]: oslogin_cache_refresh[1432]: Failure getting users, quitting May 27 17:35:14.696198 google_oslogin_nss_cache[1432]: oslogin_cache_refresh[1432]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 27 17:35:14.696198 google_oslogin_nss_cache[1432]: oslogin_cache_refresh[1432]: Refreshing group entry cache May 27 17:35:14.696198 google_oslogin_nss_cache[1432]: oslogin_cache_refresh[1432]: Failure getting groups, quitting May 27 17:35:14.696198 google_oslogin_nss_cache[1432]: oslogin_cache_refresh[1432]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 27 17:35:14.671185 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 27 17:35:14.676820 oslogin_cache_refresh[1432]: Failure getting users, quitting May 27 17:35:14.672176 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 27 17:35:14.676896 oslogin_cache_refresh[1432]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 27 17:35:14.677632 systemd[1]: Starting update-engine.service - Update Engine... May 27 17:35:14.677009 oslogin_cache_refresh[1432]: Refreshing group entry cache May 27 17:35:14.682723 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 27 17:35:14.677905 oslogin_cache_refresh[1432]: Failure getting groups, quitting May 27 17:35:14.688590 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 27 17:35:14.677917 oslogin_cache_refresh[1432]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 27 17:35:14.696132 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 27 17:35:14.696622 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 27 17:35:14.697127 systemd[1]: google-oslogin-cache.service: Deactivated successfully. May 27 17:35:14.697742 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. May 27 17:35:14.700435 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 27 17:35:14.701926 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 27 17:35:14.713287 systemd[1]: motdgen.service: Deactivated successfully. May 27 17:35:14.713814 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 27 17:35:14.717938 jq[1440]: true May 27 17:35:14.725180 extend-filesystems[1430]: Found loop2 May 27 17:35:14.729701 extend-filesystems[1430]: Found loop3 May 27 17:35:14.734912 extend-filesystems[1430]: Found sr0 May 27 17:35:14.734912 extend-filesystems[1430]: Found vda May 27 17:35:14.734912 extend-filesystems[1430]: Found vda1 May 27 17:35:14.734912 extend-filesystems[1430]: Found vda2 May 27 17:35:14.734912 extend-filesystems[1430]: Found vda3 May 27 17:35:14.734912 extend-filesystems[1430]: Found usr May 27 17:35:14.734912 extend-filesystems[1430]: Found vda4 May 27 17:35:14.734912 extend-filesystems[1430]: Found vda6 May 27 17:35:14.734912 extend-filesystems[1430]: Found vda7 May 27 17:35:14.734912 extend-filesystems[1430]: Found vda9 May 27 17:35:14.750558 systemd[1]: extend-filesystems.service: Deactivated successfully. May 27 17:35:14.752675 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 27 17:35:14.760622 update_engine[1439]: I20250527 17:35:14.759977 1439 main.cc:92] Flatcar Update Engine starting May 27 17:35:14.772460 jq[1452]: true May 27 17:35:14.802868 update_engine[1439]: I20250527 17:35:14.802093 1439 update_check_scheduler.cc:74] Next update check in 4m30s May 27 17:35:14.788451 dbus-daemon[1425]: [system] SELinux support is enabled May 27 17:35:14.872244 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 27 17:35:14.886558 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 27 17:35:14.886601 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 27 17:35:14.890396 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 27 17:35:14.890428 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 27 17:35:14.892093 systemd[1]: Started update-engine.service - Update Engine. May 27 17:35:14.911966 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 27 17:35:14.935533 sshd_keygen[1459]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 27 17:35:15.012645 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 27 17:35:15.019124 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 27 17:35:15.022430 systemd-logind[1437]: New seat seat0. May 27 17:35:15.028963 systemd[1]: Starting issuegen.service - Generate /run/issue... May 27 17:35:15.036922 systemd[1]: Started systemd-logind.service - User Login Management. May 27 17:35:15.128054 systemd[1]: issuegen.service: Deactivated successfully. May 27 17:35:15.129591 systemd[1]: Finished issuegen.service - Generate /run/issue. May 27 17:35:15.195874 systemd-networkd[1423]: lo: Link UP May 27 17:35:15.202360 kernel: mousedev: PS/2 mouse device common for all mice May 27 17:35:15.195886 systemd-networkd[1423]: lo: Gained carrier May 27 17:35:15.204841 systemd-networkd[1423]: Enumeration completed May 27 17:35:15.212377 bash[1489]: Updated "/home/core/.ssh/authorized_keys" May 27 17:35:15.204965 systemd[1]: Started systemd-networkd.service - Network Configuration. May 27 17:35:15.207117 systemd[1]: Reached target network.target - Network. May 27 17:35:15.214825 systemd-networkd[1423]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 17:35:15.214834 systemd-networkd[1423]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 27 17:35:15.216037 systemd[1]: Starting containerd.service - containerd container runtime... May 27 17:35:15.219803 systemd-networkd[1423]: eth0: Link UP May 27 17:35:15.220652 systemd-networkd[1423]: eth0: Gained carrier May 27 17:35:15.220738 systemd-networkd[1423]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 27 17:35:15.227149 locksmithd[1462]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 27 17:35:15.228873 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 27 17:35:15.234591 systemd-networkd[1423]: eth0: DHCPv4 address 10.0.0.10/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 27 17:35:15.238727 systemd-timesyncd[1391]: Network configuration changed, trying to establish connection. May 27 17:35:15.241274 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 27 17:35:16.607944 systemd-timesyncd[1391]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 27 17:35:16.608042 systemd-timesyncd[1391]: Initial clock synchronization to Tue 2025-05-27 17:35:16.607747 UTC. May 27 17:35:16.608104 systemd-resolved[1349]: Clock change detected. Flushing caches. May 27 17:35:16.608432 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 27 17:35:16.611904 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 27 17:35:16.626959 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 27 17:35:16.674821 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 May 27 17:35:16.674949 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device May 27 17:35:16.675361 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt May 27 17:35:16.680641 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD May 27 17:35:16.688718 kernel: ACPI: button: Power Button [PWRF] May 27 17:35:16.691295 (ntainerd)[1519]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 27 17:35:16.720032 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 27 17:35:16.722529 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 27 17:35:16.729253 systemd[1]: Started getty@tty1.service - Getty on tty1. May 27 17:35:16.736228 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 27 17:35:16.737753 systemd[1]: Reached target getty.target - Login Prompts. May 27 17:35:16.768926 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 27 17:35:16.805227 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 27 17:35:16.882994 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 27 17:35:16.909801 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 17:35:16.931851 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 27 17:35:16.932281 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:16.945850 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 27 17:35:17.009353 systemd-logind[1437]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) May 27 17:35:17.022844 systemd-logind[1437]: Watching system buttons on /dev/input/event2 (Power Button) May 27 17:35:17.040715 kernel: kvm_amd: TSC scaling supported May 27 17:35:17.040833 kernel: kvm_amd: Nested Virtualization enabled May 27 17:35:17.040896 kernel: kvm_amd: Nested Paging enabled May 27 17:35:17.040929 kernel: kvm_amd: LBR virtualization supported May 27 17:35:17.041109 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported May 27 17:35:17.041769 kernel: kvm_amd: Virtual GIF supported May 27 17:35:17.078732 kernel: EDAC MC: Ver: 3.0.0 May 27 17:35:17.108357 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 27 17:35:17.248771 containerd[1519]: time="2025-05-27T17:35:17Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 27 17:35:17.249813 containerd[1519]: time="2025-05-27T17:35:17.249752262Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 27 17:35:17.267489 containerd[1519]: time="2025-05-27T17:35:17.267378217Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="15.238µs" May 27 17:35:17.267489 containerd[1519]: time="2025-05-27T17:35:17.267438410Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 27 17:35:17.267489 containerd[1519]: time="2025-05-27T17:35:17.267459500Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 27 17:35:17.267776 containerd[1519]: time="2025-05-27T17:35:17.267745827Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 27 17:35:17.267776 containerd[1519]: time="2025-05-27T17:35:17.267766936Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 27 17:35:17.267869 containerd[1519]: time="2025-05-27T17:35:17.267799367Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 27 17:35:17.267955 containerd[1519]: time="2025-05-27T17:35:17.267923860Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 27 17:35:17.267955 containerd[1519]: time="2025-05-27T17:35:17.267942345Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 27 17:35:17.268367 containerd[1519]: time="2025-05-27T17:35:17.268329080Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 27 17:35:17.268367 containerd[1519]: time="2025-05-27T17:35:17.268357834Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 17:35:17.268418 containerd[1519]: time="2025-05-27T17:35:17.268374806Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 27 17:35:17.268418 containerd[1519]: time="2025-05-27T17:35:17.268387089Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 27 17:35:17.268580 containerd[1519]: time="2025-05-27T17:35:17.268546288Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 27 17:35:17.268975 containerd[1519]: time="2025-05-27T17:35:17.268930328Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 27 17:35:17.269013 containerd[1519]: time="2025-05-27T17:35:17.268979660Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 27 17:35:17.269013 containerd[1519]: time="2025-05-27T17:35:17.268994278Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 27 17:35:17.269074 containerd[1519]: time="2025-05-27T17:35:17.269041667Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 27 17:35:17.270209 containerd[1519]: time="2025-05-27T17:35:17.269942997Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 27 17:35:17.270209 containerd[1519]: time="2025-05-27T17:35:17.270057241Z" level=info msg="metadata content store policy set" policy=shared May 27 17:35:17.278287 containerd[1519]: time="2025-05-27T17:35:17.278177450Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 27 17:35:17.278287 containerd[1519]: time="2025-05-27T17:35:17.278285282Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 27 17:35:17.278287 containerd[1519]: time="2025-05-27T17:35:17.278303235Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278316931Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278330737Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278347939Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278361084Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278373467Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278388826Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278410847Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278430444Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 27 17:35:17.278458 containerd[1519]: time="2025-05-27T17:35:17.278453066Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 27 17:35:17.278770 containerd[1519]: time="2025-05-27T17:35:17.278731829Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 27 17:35:17.278770 containerd[1519]: time="2025-05-27T17:35:17.278766534Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 27 17:35:17.278814 containerd[1519]: time="2025-05-27T17:35:17.278782324Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 27 17:35:17.278814 containerd[1519]: time="2025-05-27T17:35:17.278793966Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 27 17:35:17.278814 containerd[1519]: time="2025-05-27T17:35:17.278804135Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 27 17:35:17.278911 containerd[1519]: time="2025-05-27T17:35:17.278815055Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 27 17:35:17.278911 containerd[1519]: time="2025-05-27T17:35:17.278828831Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 27 17:35:17.278911 containerd[1519]: time="2025-05-27T17:35:17.278839641Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 27 17:35:17.278911 containerd[1519]: time="2025-05-27T17:35:17.278852355Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 27 17:35:17.278911 containerd[1519]: time="2025-05-27T17:35:17.278863626Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 27 17:35:17.278911 containerd[1519]: time="2025-05-27T17:35:17.278873836Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 27 17:35:17.279060 containerd[1519]: time="2025-05-27T17:35:17.278982830Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 27 17:35:17.279060 containerd[1519]: time="2025-05-27T17:35:17.279005773Z" level=info msg="Start snapshots syncer" May 27 17:35:17.279060 containerd[1519]: time="2025-05-27T17:35:17.279040328Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 27 17:35:17.279382 containerd[1519]: time="2025-05-27T17:35:17.279323018Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 27 17:35:17.279505 containerd[1519]: time="2025-05-27T17:35:17.279399391Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 27 17:35:17.279557 containerd[1519]: time="2025-05-27T17:35:17.279519216Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 27 17:35:17.279796 containerd[1519]: time="2025-05-27T17:35:17.279757693Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 27 17:35:17.279823 containerd[1519]: time="2025-05-27T17:35:17.279795714Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 27 17:35:17.279823 containerd[1519]: time="2025-05-27T17:35:17.279809861Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 27 17:35:17.279877 containerd[1519]: time="2025-05-27T17:35:17.279822535Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 27 17:35:17.279877 containerd[1519]: time="2025-05-27T17:35:17.279836641Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 27 17:35:17.279877 containerd[1519]: time="2025-05-27T17:35:17.279851259Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 27 17:35:17.279877 containerd[1519]: time="2025-05-27T17:35:17.279864894Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 27 17:35:17.279956 containerd[1519]: time="2025-05-27T17:35:17.279906833Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 27 17:35:17.279956 containerd[1519]: time="2025-05-27T17:35:17.279923795Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 27 17:35:17.279956 containerd[1519]: time="2025-05-27T17:35:17.279937951Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.279977235Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.279996421Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.280010728Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.280023762Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.280033611Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.280055121Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 27 17:35:17.280084 containerd[1519]: time="2025-05-27T17:35:17.280067264Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 27 17:35:17.280213 containerd[1519]: time="2025-05-27T17:35:17.280090207Z" level=info msg="runtime interface created" May 27 17:35:17.280213 containerd[1519]: time="2025-05-27T17:35:17.280096589Z" level=info msg="created NRI interface" May 27 17:35:17.280213 containerd[1519]: time="2025-05-27T17:35:17.280114542Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 27 17:35:17.280213 containerd[1519]: time="2025-05-27T17:35:17.280129771Z" level=info msg="Connect containerd service" May 27 17:35:17.280213 containerd[1519]: time="2025-05-27T17:35:17.280153876Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 27 17:35:17.281185 containerd[1519]: time="2025-05-27T17:35:17.281129937Z" 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 27 17:35:17.571502 containerd[1519]: time="2025-05-27T17:35:17.571304447Z" level=info msg="Start subscribing containerd event" May 27 17:35:17.571502 containerd[1519]: time="2025-05-27T17:35:17.571420735Z" level=info msg="Start recovering state" May 27 17:35:17.571710 containerd[1519]: time="2025-05-27T17:35:17.571603308Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 27 17:35:17.571710 containerd[1519]: time="2025-05-27T17:35:17.571644906Z" level=info msg="Start event monitor" May 27 17:35:17.571710 containerd[1519]: time="2025-05-27T17:35:17.571674832Z" level=info msg="Start cni network conf syncer for default" May 27 17:35:17.571843 containerd[1519]: time="2025-05-27T17:35:17.571714086Z" level=info msg=serving... address=/run/containerd/containerd.sock May 27 17:35:17.571843 containerd[1519]: time="2025-05-27T17:35:17.571727731Z" level=info msg="Start streaming server" May 27 17:35:17.571843 containerd[1519]: time="2025-05-27T17:35:17.571781722Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 27 17:35:17.571843 containerd[1519]: time="2025-05-27T17:35:17.571795558Z" level=info msg="runtime interface starting up..." May 27 17:35:17.571843 containerd[1519]: time="2025-05-27T17:35:17.571803383Z" level=info msg="starting plugins..." May 27 17:35:17.571843 containerd[1519]: time="2025-05-27T17:35:17.571831546Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 27 17:35:17.572108 containerd[1519]: time="2025-05-27T17:35:17.572087235Z" level=info msg="containerd successfully booted in 0.324174s" May 27 17:35:17.572262 systemd[1]: Started containerd.service - containerd container runtime. May 27 17:35:17.973945 systemd-networkd[1423]: eth0: Gained IPv6LL May 27 17:35:17.977374 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 27 17:35:17.979251 systemd[1]: Reached target network-online.target - Network is Online. May 27 17:35:17.982047 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 27 17:35:17.984532 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 27 17:35:18.025826 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 27 17:35:18.049378 systemd[1]: coreos-metadata.service: Deactivated successfully. May 27 17:35:18.049776 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 27 17:35:18.053637 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... May 27 17:35:18.055316 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 27 17:35:18.070366 (-wrapper)[1582]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS May 27 17:35:18.322911 systemd[1]: Starting docker.service - Docker Application Container Engine... May 27 17:35:18.354229 (dockerd)[1594]: 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 27 17:35:19.004761 dockerd[1594]: time="2025-05-27T17:35:19.004645974Z" level=info msg="Starting up" May 27 17:35:19.006065 dockerd[1594]: time="2025-05-27T17:35:19.006035029Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 27 17:35:19.119227 dockerd[1594]: time="2025-05-27T17:35:19.118811485Z" level=info msg="Loading containers: start." May 27 17:35:19.136728 kernel: Initializing XFRM netlink socket May 27 17:35:19.447661 systemd-networkd[1423]: docker0: Link UP May 27 17:35:19.452890 dockerd[1594]: time="2025-05-27T17:35:19.452827895Z" level=info msg="Loading containers: done." May 27 17:35:19.472903 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3252568249-merged.mount: Deactivated successfully. May 27 17:35:19.474555 dockerd[1594]: time="2025-05-27T17:35:19.474466215Z" 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 27 17:35:19.474692 dockerd[1594]: time="2025-05-27T17:35:19.474617459Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 27 17:35:19.474821 dockerd[1594]: time="2025-05-27T17:35:19.474795202Z" level=info msg="Initializing buildkit" May 27 17:35:19.511264 dockerd[1594]: time="2025-05-27T17:35:19.511205354Z" level=info msg="Completed buildkit initialization" May 27 17:35:19.517944 dockerd[1594]: time="2025-05-27T17:35:19.517902864Z" level=info msg="Daemon has completed initialization" May 27 17:35:19.518090 dockerd[1594]: time="2025-05-27T17:35:19.518016507Z" level=info msg="API listen on /run/docker.sock" May 27 17:35:19.518177 systemd[1]: Started docker.service - Docker Application Container Engine. May 27 17:35:19.521328 etcd-wrapper[1586]: Error response from daemon: No such container: etcd-member May 27 17:35:19.545462 etcd-wrapper[1785]: Error response from daemon: No such container: etcd-member May 27 17:35:19.590400 etcd-wrapper[1805]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally May 27 17:35:21.081233 etcd-wrapper[1805]: v3.5.0: Pulling from coreos/etcd May 27 17:35:21.402146 etcd-wrapper[1805]: 1813d21adc01: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 6e96907ab677: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 444ed0ea8673: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 0fd2df5633f0: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 8cc22b9456bb: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 7ac70aecd290: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 4b376c64dfe4: Pulling fs layer May 27 17:35:21.402146 etcd-wrapper[1805]: 8cc22b9456bb: Waiting May 27 17:35:21.402146 etcd-wrapper[1805]: 7ac70aecd290: Waiting May 27 17:35:21.402146 etcd-wrapper[1805]: 4b376c64dfe4: Waiting May 27 17:35:21.402146 etcd-wrapper[1805]: 0fd2df5633f0: Waiting May 27 17:35:21.723133 etcd-wrapper[1805]: 6e96907ab677: Verifying Checksum May 27 17:35:21.723133 etcd-wrapper[1805]: 6e96907ab677: Download complete May 27 17:35:21.725928 etcd-wrapper[1805]: 444ed0ea8673: Verifying Checksum May 27 17:35:21.725928 etcd-wrapper[1805]: 444ed0ea8673: Download complete May 27 17:35:21.826872 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 27 17:35:21.830220 systemd[1]: Started sshd@0-10.0.0.10:22-10.0.0.1:58744.service - OpenSSH per-connection server daemon (10.0.0.1:58744). May 27 17:35:21.955402 etcd-wrapper[1805]: 1813d21adc01: Verifying Checksum May 27 17:35:21.955402 etcd-wrapper[1805]: 1813d21adc01: Download complete May 27 17:35:21.965008 sshd[1821]: Accepted publickey for core from 10.0.0.1 port 58744 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:21.967514 sshd-session[1821]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:21.974111 etcd-wrapper[1805]: 8cc22b9456bb: Verifying Checksum May 27 17:35:21.974111 etcd-wrapper[1805]: 8cc22b9456bb: Download complete May 27 17:35:21.978392 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 27 17:35:21.980115 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 27 17:35:21.992017 systemd-logind[1437]: New session 1 of user core. May 27 17:35:22.017569 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 27 17:35:22.021198 systemd[1]: Starting user@500.service - User Manager for UID 500... May 27 17:35:22.037767 etcd-wrapper[1805]: 0fd2df5633f0: Verifying Checksum May 27 17:35:22.037767 etcd-wrapper[1805]: 0fd2df5633f0: Download complete May 27 17:35:22.066623 (systemd)[1835]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 27 17:35:22.070663 systemd-logind[1437]: New session c1 of user core. May 27 17:35:22.237443 etcd-wrapper[1805]: 7ac70aecd290: Verifying Checksum May 27 17:35:22.237443 etcd-wrapper[1805]: 7ac70aecd290: Download complete May 27 17:35:22.356762 systemd[1835]: Queued start job for default target default.target. May 27 17:35:22.365730 systemd[1835]: Created slice app.slice - User Application Slice. May 27 17:35:22.365770 systemd[1835]: Reached target paths.target - Paths. May 27 17:35:22.365841 systemd[1835]: Reached target timers.target - Timers. May 27 17:35:22.370008 systemd[1835]: Starting dbus.socket - D-Bus User Message Bus Socket... May 27 17:35:22.377172 etcd-wrapper[1805]: 4b376c64dfe4: Verifying Checksum May 27 17:35:22.377172 etcd-wrapper[1805]: 4b376c64dfe4: Download complete May 27 17:35:22.388115 systemd[1835]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 27 17:35:22.388467 systemd[1835]: Reached target sockets.target - Sockets. May 27 17:35:22.388637 systemd[1835]: Reached target basic.target - Basic System. May 27 17:35:22.388824 systemd[1835]: Reached target default.target - Main User Target. May 27 17:35:22.388873 systemd[1835]: Startup finished in 306ms. May 27 17:35:22.389273 systemd[1]: Started user@500.service - User Manager for UID 500. May 27 17:35:22.397301 systemd[1]: Started session-1.scope - Session 1 of User core. May 27 17:35:22.463164 systemd[1]: Started sshd@1-10.0.0.10:22-10.0.0.1:58754.service - OpenSSH per-connection server daemon (10.0.0.1:58754). May 27 17:35:22.560001 sshd[1846]: Accepted publickey for core from 10.0.0.1 port 58754 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:22.562550 sshd-session[1846]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:22.569820 systemd-logind[1437]: New session 2 of user core. May 27 17:35:22.577994 systemd[1]: Started session-2.scope - Session 2 of User core. May 27 17:35:22.641996 sshd[1848]: Connection closed by 10.0.0.1 port 58754 May 27 17:35:22.643703 sshd-session[1846]: pam_unix(sshd:session): session closed for user core May 27 17:35:22.654172 systemd[1]: sshd@1-10.0.0.10:22-10.0.0.1:58754.service: Deactivated successfully. May 27 17:35:22.657767 systemd[1]: session-2.scope: Deactivated successfully. May 27 17:35:22.659954 systemd-logind[1437]: Session 2 logged out. Waiting for processes to exit. May 27 17:35:22.665130 systemd[1]: Started sshd@2-10.0.0.10:22-10.0.0.1:58758.service - OpenSSH per-connection server daemon (10.0.0.1:58758). May 27 17:35:22.666509 systemd-logind[1437]: Removed session 2. May 27 17:35:22.748008 sshd[1854]: Accepted publickey for core from 10.0.0.1 port 58758 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:22.750072 sshd-session[1854]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:22.756044 systemd-logind[1437]: New session 3 of user core. May 27 17:35:22.770937 systemd[1]: Started session-3.scope - Session 3 of User core. May 27 17:35:22.832301 sshd[1856]: Connection closed by 10.0.0.1 port 58758 May 27 17:35:22.832706 sshd-session[1854]: pam_unix(sshd:session): session closed for user core May 27 17:35:22.839808 systemd[1]: sshd@2-10.0.0.10:22-10.0.0.1:58758.service: Deactivated successfully. May 27 17:35:22.842837 systemd[1]: session-3.scope: Deactivated successfully. May 27 17:35:22.843821 systemd-logind[1437]: Session 3 logged out. Waiting for processes to exit. May 27 17:35:22.846107 systemd-logind[1437]: Removed session 3. May 27 17:35:23.208428 etcd-wrapper[1805]: 1813d21adc01: Pull complete May 27 17:35:23.466988 systemd[1]: var-lib-docker-overlay2-e37ec80332ea76a499b0a95c7d4bc822a1555201fc6ff547cba25c269728c0cf-merged.mount: Deactivated successfully. May 27 17:35:24.032317 etcd-wrapper[1805]: 6e96907ab677: Pull complete May 27 17:35:24.151325 systemd[1]: var-lib-docker-overlay2-c5ad8a82c03be5e10b23ee5277ea02faf3d1db77102353e89d97f4016ae2e0a2-merged.mount: Deactivated successfully. May 27 17:35:24.330299 etcd-wrapper[1805]: 444ed0ea8673: Pull complete May 27 17:35:24.429371 systemd[1]: var-lib-docker-overlay2-f9d329a152085ee0a2c3d64a790d699233f7b2e803811616a4399d6f4988be67-merged.mount: Deactivated successfully. May 27 17:35:24.640623 etcd-wrapper[1805]: 0fd2df5633f0: Pull complete May 27 17:35:24.666400 systemd[1]: var-lib-docker-overlay2-5194adc32efd89d196426e5af4cbcdf3ae96b88264b315a62ec3ccc830443848-merged.mount: Deactivated successfully. May 27 17:35:24.684638 etcd-wrapper[1805]: 8cc22b9456bb: Pull complete May 27 17:35:24.716602 etcd-wrapper[1805]: 7ac70aecd290: Pull complete May 27 17:35:24.807419 etcd-wrapper[1805]: 4b376c64dfe4: Pull complete May 27 17:35:24.822407 etcd-wrapper[1805]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b May 27 17:35:24.828593 etcd-wrapper[1805]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 May 27 17:35:24.912166 containerd[1519]: time="2025-05-27T17:35:24.912023526Z" level=info msg="connecting to shim e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7" address="unix:///run/containerd/s/c49a0cf8b61ac071959ddbe36427d857f897beaaa92283bb1c594f0b36a88a05" namespace=moby protocol=ttrpc version=3 May 27 17:35:24.949896 systemd[1]: Started docker-e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7.scope - libcontainer container e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7. May 27 17:35:24.969929 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 17:35:25.045418 etcd-wrapper[1805]: {"level":"info","ts":1748367325.0451345,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} May 27 17:35:25.045418 etcd-wrapper[1805]: {"level":"info","ts":1748367325.0452251,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"e254593e671d46ffb93c17a30454865c"} May 27 17:35:25.045418 etcd-wrapper[1805]: {"level":"warn","ts":1748367325.0452545,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} May 27 17:35:25.045418 etcd-wrapper[1805]: {"level":"warn","ts":1748367325.045267,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} May 27 17:35:25.045418 etcd-wrapper[1805]: {"level":"warn","ts":1748367325.0452747,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} May 27 17:35:25.045418 etcd-wrapper[1805]: {"level":"warn","ts":1748367325.04528,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} May 27 17:35:25.046232 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.045Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.10:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.10:2380","--advertise-client-urls=http://10.0.0.10:2379","--discovery=http://10.0.0.1:45585/v2/keys/discovery/6488523790626097413","--enable-v2=true"]} May 27 17:35:25.046232 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.045Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.10:2380"]} May 27 17:35:25.046232 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.045Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} May 27 17:35:25.046361 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.046Z","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":4,"max-cpu-available":4,"member-initialized":false,"name":"e254593e671d46ffb93c17a30454865c","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://10.0.0.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"e254593e671d46ffb93c17a30454865c=http://10.0.0.10:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:45585/v2/keys/discovery/6488523790626097413","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"http://10.0.0.1:45585/v2/keys/discovery/6488523790626097413","discovery-proxy":"","downgrade-check-interval":"5s"} May 27 17:35:25.049348 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.049Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.717196ms"} May 27 17:35:25.052183 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.052Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:45585","peer":"b02a1fd01dee4dda"} May 27 17:35:25.052183 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.052Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:45585","self":"d9ac3718b6bc9a4c"} May 27 17:35:25.052183 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.052Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:45585","found-peers":2,"needed-peers":1} May 27 17:35:25.349673 systemd[1]: var-lib-docker-overlay2-674f6623f67f2e88299529afe21d318c6cab6e5462eb6a733698537f69e948a4-merged.mount: Deactivated successfully. May 27 17:35:25.354964 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.354Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:45585","peer":"bcda29a17517c1c2"} May 27 17:35:25.354964 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.354Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:45585","found-peers":3} May 27 17:35:25.361809 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"d9ac3718b6bc9a4c","cluster-id":"a3a1fbca348fda7d"} May 27 17:35:25.361809 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=()"} May 27 17:35:25.361809 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became follower at term 0"} May 27 17:35:25.361809 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d9ac3718b6bc9a4c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} May 27 17:35:25.361809 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became follower at term 1"} May 27 17:35:25.362154 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674)"} May 27 17:35:25.362154 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650)"} May 27 17:35:25.362154 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650 15684972181509151308)"} May 27 17:35:25.365466 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:25.365Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} May 27 17:35:25.367620 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.367Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} May 27 17:35:25.369136 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.368Z","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 27 17:35:25.370152 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.369Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.370257 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.370Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.371468 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.370Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.371468 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.370Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.371750 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.371Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.371750 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.371Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda","remote-peer-urls":["http://10.0.0.9:2380"]} May 27 17:35:25.371932 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.371Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.371991 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.371Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.371991 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.371Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.372416 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.372Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.372798 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.372Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.375031 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.374Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.375031 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.374Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.375031 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.374Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2","remote-peer-urls":["http://10.0.0.11:2380"]} May 27 17:35:25.375031 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.374Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"d9ac3718b6bc9a4c","local-server-version":"3.5.0","cluster-version":"to_be_decided"} May 27 17:35:25.375031 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.374Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.375031 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.374Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.375600 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.375Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} May 27 17:35:25.375921 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650 15684972181509151308)"} May 27 17:35:25.376047 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.375Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","added-peer-id":"b02a1fd01dee4dda","added-peer-peer-urls":["http://10.0.0.9:2380"]} May 27 17:35:25.376047 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650 15684972181509151308)"} May 27 17:35:25.376452 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.376Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","added-peer-id":"bcda29a17517c1c2","added-peer-peer-urls":["http://10.0.0.11:2380"]} May 27 17:35:25.376452 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650 15684972181509151308)"} May 27 17:35:25.376452 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.376Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","added-peer-id":"d9ac3718b6bc9a4c","added-peer-peer-urls":["http://10.0.0.10:2380"]} May 27 17:35:25.376836 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.376Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.376836 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.376Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.376836 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:25.376Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} May 27 17:35:25.377273 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.377Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.10:2380"} May 27 17:35:25.377273 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.377Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.10:2380"} May 27 17:35:25.377752 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.377Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"bcda29a17517c1c2","stream-type":"stream Message"} May 27 17:35:25.377752 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.377Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"bcda29a17517c1c2"} May 27 17:35:25.377752 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.377Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.378182 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.377Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"b02a1fd01dee4dda","stream-type":"stream MsgApp v2"} May 27 17:35:25.378182 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.378Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.378502 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.378Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"b02a1fd01dee4dda","stream-type":"stream Message"} May 27 17:35:25.378502 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.378Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.379073 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.378Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"bcda29a17517c1c2","stream-type":"stream MsgApp v2"} May 27 17:35:25.379073 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.378Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.379306 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.378Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:25.379530 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.379Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"d9ac3718b6bc9a4c","initial-advertise-peer-urls":["http://10.0.0.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} May 27 17:35:25.380290 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.380Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.380290 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.380Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:25.425663 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.425Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"d9ac3718b6bc9a4c","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} May 27 17:35:25.763068 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c is starting a new election at term 1"} May 27 17:35:25.763068 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became pre-candidate at term 1"} May 27 17:35:25.763068 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c received MsgPreVoteResp from d9ac3718b6bc9a4c at term 1"} May 27 17:35:25.763068 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 1, index: 3] sent MsgPreVote request to b02a1fd01dee4dda at term 1"} May 27 17:35:25.763068 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 1, index: 3] sent MsgPreVote request to bcda29a17517c1c2 at term 1"} May 27 17:35:25.763068 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 1, index: 3, vote: 0] cast MsgPreVote for b02a1fd01dee4dda [logterm: 1, index: 3] at term 1"} May 27 17:35:25.763790 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c received MsgPreVoteResp from bcda29a17517c1c2 at term 1"} May 27 17:35:25.763790 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c has received 2 MsgPreVoteResp votes and 0 vote rejections"} May 27 17:35:25.763790 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became candidate at term 2"} May 27 17:35:25.763790 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c received MsgVoteResp from d9ac3718b6bc9a4c at term 2"} May 27 17:35:25.764026 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 1, index: 3] sent MsgVote request to b02a1fd01dee4dda at term 2"} May 27 17:35:25.764026 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 1, index: 3] sent MsgVote request to bcda29a17517c1c2 at term 2"} May 27 17:35:25.764173 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 1, index: 3, vote: d9ac3718b6bc9a4c] rejected MsgVote from b02a1fd01dee4dda [logterm: 1, index: 3] at term 2"} May 27 17:35:25.765356 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c received MsgVoteResp rejection from b02a1fd01dee4dda at term 2"} May 27 17:35:25.765356 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c has received 1 MsgVoteResp votes and 1 vote rejections"} May 27 17:35:25.765562 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c received MsgVoteResp rejection from bcda29a17517c1c2 at term 2"} May 27 17:35:25.765562 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c has received 1 MsgVoteResp votes and 2 vote rejections"} May 27 17:35:25.765562 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became follower at term 2"} May 27 17:35:25.765816 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9ac3718b6bc9a4c elected leader b02a1fd01dee4dda at term 2"} May 27 17:35:25.768527 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.768Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"d9ac3718b6bc9a4c","local-member-attributes":"{Name:e254593e671d46ffb93c17a30454865c ClientURLs:[http://10.0.0.10:2379]}","request-path":"/0/members/d9ac3718b6bc9a4c/attributes","cluster-id":"a3a1fbca348fda7d","publish-timeout":"7s"} May 27 17:35:25.768527 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.768Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} May 27 17:35:25.769052 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.768Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} May 27 17:35:25.769052 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.768Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} May 27 17:35:25.769255 systemd[1]: Started etcd-member.service - etcd (System Application Container). May 27 17:35:25.770258 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.769Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} May 27 17:35:25.770802 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.770Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","cluster-version":"3.5"} May 27 17:35:25.771058 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:25.770Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} May 27 17:35:25.771617 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... May 27 17:35:25.989368 etcdctl[1945]: { "Network": "10.254.0.0/16", "Backend": {"Type": "udp"} } May 27 17:35:26.044268 flannel-wrapper[1955]: Error response from daemon: No such container: flannel May 27 17:35:26.064920 flannel-wrapper[1963]: Error response from daemon: No such container: flannel May 27 17:35:26.097609 flannel-wrapper[1982]: Unable to find image 'quay.io/coreos/flannel:v0.14.0' locally May 27 17:35:27.219641 flannel-wrapper[1982]: v0.14.0: Pulling from coreos/flannel May 27 17:35:27.587382 flannel-wrapper[1982]: 801bfaa63ef2: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: e4264a7179f6: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: bc75ea45ad2e: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: 78648579d12a: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: 3393447261e4: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: 071b96dd834b: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: 4de2f0468a91: Pulling fs layer May 27 17:35:27.587382 flannel-wrapper[1982]: 78648579d12a: Waiting May 27 17:35:27.587382 flannel-wrapper[1982]: 3393447261e4: Waiting May 27 17:35:27.587382 flannel-wrapper[1982]: 071b96dd834b: Waiting May 27 17:35:27.587382 flannel-wrapper[1982]: 4de2f0468a91: Waiting May 27 17:35:27.865177 flannel-wrapper[1982]: 801bfaa63ef2: Download complete May 27 17:35:27.898160 flannel-wrapper[1982]: bc75ea45ad2e: Verifying Checksum May 27 17:35:27.898289 flannel-wrapper[1982]: bc75ea45ad2e: Download complete May 27 17:35:28.075261 flannel-wrapper[1982]: e4264a7179f6: Verifying Checksum May 27 17:35:28.075261 flannel-wrapper[1982]: e4264a7179f6: Download complete May 27 17:35:28.186356 flannel-wrapper[1982]: 801bfaa63ef2: Pull complete May 27 17:35:28.377484 flannel-wrapper[1982]: 071b96dd834b: Verifying Checksum May 27 17:35:28.377484 flannel-wrapper[1982]: 071b96dd834b: Download complete May 27 17:35:28.395379 flannel-wrapper[1982]: 3393447261e4: Verifying Checksum May 27 17:35:28.395379 flannel-wrapper[1982]: 3393447261e4: Download complete May 27 17:35:28.417672 flannel-wrapper[1982]: 78648579d12a: Verifying Checksum May 27 17:35:28.417672 flannel-wrapper[1982]: 78648579d12a: Download complete May 27 17:35:28.563604 systemd[1]: var-lib-docker-overlay2-3ad3d5ba2ada2dcad8e2bbcbc577585abc1ac05c289bb98cffeea42bade053ee-merged.mount: Deactivated successfully. May 27 17:35:28.635903 flannel-wrapper[1982]: 4de2f0468a91: Verifying Checksum May 27 17:35:28.635903 flannel-wrapper[1982]: 4de2f0468a91: Download complete May 27 17:35:29.147292 flannel-wrapper[1982]: e4264a7179f6: Pull complete May 27 17:35:29.206031 systemd[1]: var-lib-docker-overlay2-d94f19be297677a89293fdb47829d5d2e25b57041344afc97e7eeeeefa8abea3-merged.mount: Deactivated successfully. May 27 17:35:29.240943 flannel-wrapper[1982]: bc75ea45ad2e: Pull complete May 27 17:35:29.792840 systemd[1]: var-lib-docker-overlay2-ae3fb3e9bb556cd4aff29ad06fbb99a6dce9483fe69ee83b9d79df1747e95ec8-merged.mount: Deactivated successfully. May 27 17:35:30.118926 flannel-wrapper[1982]: 78648579d12a: Pull complete May 27 17:35:30.139290 systemd[1]: var-lib-docker-overlay2-7d17a00735d4e30340459d3bcd12615bb72f9847678b06eb0d61f0c7f1bda5d1-merged.mount: Deactivated successfully. May 27 17:35:30.156880 flannel-wrapper[1982]: 3393447261e4: Pull complete May 27 17:35:30.192819 flannel-wrapper[1982]: 071b96dd834b: Pull complete May 27 17:35:30.212480 systemd[1]: var-lib-docker-overlay2-5b924013577f8820eb6f2cf8115fe780a875e61018587620b915c43a4dfa56e3-merged.mount: Deactivated successfully. May 27 17:35:30.229991 flannel-wrapper[1982]: 4de2f0468a91: Pull complete May 27 17:35:30.240931 flannel-wrapper[1982]: Digest: sha256:4a330b2f2e74046e493b2edc30d61fdebbdddaaedcb32d62736f25be8d3c64d5 May 27 17:35:30.245764 flannel-wrapper[1982]: Status: Downloaded newer image for quay.io/coreos/flannel:v0.14.0 May 27 17:35:30.261091 systemd[1]: var-lib-docker-overlay2-63d2b3314fb27991d9ba9dc5a0965462ca4084f647209a7f9fc55cc8b6c79e19\x2dinit-merged.mount: Deactivated successfully. May 27 17:35:30.323888 containerd[1519]: time="2025-05-27T17:35:30.323812312Z" level=info msg="connecting to shim de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e" address="unix:///run/containerd/s/5b0783dadfd70558c2549d5ca54b8aa896209461242e268600bc893d523f9893" namespace=moby protocol=ttrpc version=3 May 27 17:35:30.427032 systemd[1]: Started docker-de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e.scope - libcontainer container de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e. May 27 17:35:30.460537 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 17:35:30.512998 flannel-wrapper[1982]: I0527 17:35:30.512474 1 main.go:520] Determining IP address of default interface May 27 17:35:30.512998 flannel-wrapper[1982]: I0527 17:35:30.512879 1 main.go:533] Using interface with name eth0 and address 10.0.0.10 May 27 17:35:30.513339 flannel-wrapper[1982]: I0527 17:35:30.512970 1 main.go:550] Defaulting external address to interface address (10.0.0.10) May 27 17:35:30.513339 flannel-wrapper[1982]: I0527 17:35:30.513070 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: None May 27 17:35:30.513339 flannel-wrapper[1982]: I0527 17:35:30.513076 1 main.go:257] Installing signal handlers May 27 17:35:30.516224 flannel-wrapper[1982]: I0527 17:35:30.515851 1 main.go:392] Found network config - Backend type: udp May 27 17:35:30.523750 flannel-wrapper[1982]: I0527 17:35:30.523416 1 local_manager.go:234] Picking subnet in range 10.254.1.0 ... 10.254.255.0 May 27 17:35:30.528493 flannel-wrapper[1982]: I0527 17:35:30.528151 1 local_manager.go:220] Allocated lease (10.254.22.0/24) to current node (10.0.0.10) May 27 17:35:30.536730 kernel: tun: Universal TUN/TAP device driver, 1.6 May 27 17:35:30.539100 systemd-networkd[1423]: flannel0: Link UP May 27 17:35:30.539853 flannel-wrapper[1982]: I0527 17:35:30.538184 1 main.go:357] Current network or subnet (10.254.0.0/16, 10.254.22.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 27 17:35:30.539115 systemd-networkd[1423]: flannel0: Gained carrier May 27 17:35:30.539330 systemd-networkd[1423]: flannel0: Gained IPv6LL May 27 17:35:30.562881 flannel-wrapper[1982]: I0527 17:35:30.562538 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN May 27 17:35:30.564473 flannel-wrapper[1982]: I0527 17:35:30.564030 1 iptables.go:172] Deleting iptables rule: -s 0.0.0.0/0 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully May 27 17:35:30.565632 flannel-wrapper[1982]: I0527 17:35:30.565398 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j RETURN May 27 17:35:30.567230 flannel-wrapper[1982]: I0527 17:35:30.566973 1 iptables.go:172] Deleting iptables rule: ! -s 0.0.0.0/0 -d 0.0.0.0/0 -j MASQUERADE --random-fully May 27 17:35:30.568653 flannel-wrapper[1982]: I0527 17:35:30.568406 1 main.go:307] Setting up masking rules May 27 17:35:30.570718 flannel-wrapper[1982]: I0527 17:35:30.570230 1 main.go:315] Changing default FORWARD chain policy to ACCEPT May 27 17:35:30.570718 flannel-wrapper[1982]: I0527 17:35:30.570365 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env May 27 17:35:30.570718 flannel-wrapper[1982]: I0527 17:35:30.570373 1 main.go:327] Running backend. May 27 17:35:30.570909 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). May 27 17:35:30.571613 systemd[1]: Reached target multi-user.target - Multi-User System. May 27 17:35:30.573020 flannel-wrapper[1982]: I0527 17:35:30.571023 1 udp_network_amd64.go:100] Watching for new subnet leases May 27 17:35:30.574594 flannel-wrapper[1982]: I0527 17:35:30.574278 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules May 27 17:35:30.574594 flannel-wrapper[1982]: I0527 17:35:30.574316 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -j ACCEPT May 27 17:35:30.575550 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... May 27 17:35:30.577792 flannel-wrapper[1982]: I0527 17:35:30.576644 1 iptables.go:172] Deleting iptables rule: -d 10.254.0.0/16 -j ACCEPT May 27 17:35:30.578617 flannel-wrapper[1982]: I0527 17:35:30.577971 1 iptables.go:148] Some iptables rules are missing; deleting and recreating rules May 27 17:35:30.578617 flannel-wrapper[1982]: I0527 17:35:30.578014 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN May 27 17:35:30.578617 flannel-wrapper[1982]: I0527 17:35:30.578316 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -j ACCEPT May 27 17:35:30.581047 flannel-wrapper[1982]: I0527 17:35:30.580633 1 main.go:439] Waiting for 22h59m59.943567549s to renew lease May 27 17:35:30.581268 flannel-wrapper[1982]: I0527 17:35:30.581015 1 udp_network_amd64.go:196] Subnet added: 10.254.61.0/24 May 27 17:35:30.581268 flannel-wrapper[1982]: I0527 17:35:30.581185 1 udp_network_amd64.go:196] Subnet added: 10.254.81.0/24 May 27 17:35:30.581432 flannel-wrapper[1982]: I0527 17:35:30.581302 1 iptables.go:172] Deleting iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully May 27 17:35:30.583052 flannel-wrapper[1982]: I0527 17:35:30.582792 1 iptables.go:160] Adding iptables rule: -d 10.254.0.0/16 -j ACCEPT May 27 17:35:30.583743 flannel-wrapper[1982]: I0527 17:35:30.583547 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.22.0/24 -j RETURN May 27 17:35:30.587466 flannel-wrapper[1982]: I0527 17:35:30.586914 1 iptables.go:172] Deleting iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully May 27 17:35:30.588549 flannel-wrapper[1982]: I0527 17:35:30.588403 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 -d 10.254.0.0/16 -j RETURN May 27 17:35:30.591116 sh[2123]: + for try in 1 2 3 4 5 6 May 27 17:35:30.591544 sh[2123]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i May 27 17:35:30.591839 flannel-wrapper[1982]: I0527 17:35:30.591557 1 iptables.go:160] Adding iptables rule: -s 10.254.0.0/16 ! -d 224.0.0.0/4 -j MASQUERADE --random-fully May 27 17:35:30.594542 flannel-wrapper[1982]: I0527 17:35:30.594303 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.22.0/24 -j RETURN May 27 17:35:30.597967 flannel-wrapper[1982]: I0527 17:35:30.597504 1 iptables.go:160] Adding iptables rule: ! -s 10.254.0.0/16 -d 10.254.0.0/16 -j MASQUERADE --random-fully May 27 17:35:30.623057 sh[2141]: Error response from daemon: No such container: flannel-docker-opts May 27 17:35:30.640906 sh[2152]: Error response from daemon: No such container: flannel-docker-opts May 27 17:35:30.756575 containerd[1519]: time="2025-05-27T17:35:30.756410808Z" level=info msg="connecting to shim 819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685" address="unix:///run/containerd/s/10f84cedd122d5603252a4d2c21636bc2891d39f78b622978deb93f9790e1ecd" namespace=moby protocol=ttrpc version=3 May 27 17:35:30.799029 systemd[1]: Started docker-819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685.scope - libcontainer container 819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685. May 27 17:35:30.824026 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 17:35:30.858814 systemd[1]: docker-819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685.scope: Deactivated successfully. May 27 17:35:30.876814 containerd[1519]: time="2025-05-27T17:35:30.876747603Z" level=info msg="shim disconnected" id=819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685 namespace=moby May 27 17:35:30.876944 containerd[1519]: time="2025-05-27T17:35:30.876823485Z" level=warning msg="cleaning up after shim disconnected" id=819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685 namespace=moby May 27 17:35:30.876944 containerd[1519]: time="2025-05-27T17:35:30.876835998Z" level=info msg="cleaning up dead shim" namespace=moby May 27 17:35:30.877747 dockerd[1594]: time="2025-05-27T17:35:30.877624978Z" level=info msg="ignoring event" container=819762bded8dabea5e81f74e0f9536af42a6104d732e77e610f041da48fa9685 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 27 17:35:30.906224 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [term: 2] received a MsgVote message with higher term from bcda29a17517c1c2 [term: 3]"} May 27 17:35:30.906224 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became follower at term 3"} May 27 17:35:30.906224 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 2, index: 30, vote: 0] cast MsgVote for bcda29a17517c1c2 [logterm: 2, index: 30] at term 3"} May 27 17:35:30.906224 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9ac3718b6bc9a4c lost leader b02a1fd01dee4dda at term 3"} May 27 17:35:30.907745 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9ac3718b6bc9a4c elected leader bcda29a17517c1c2 at term 3"} May 27 17:35:30.933892 dockerd[1594]: time="2025-05-27T17:35:30.933759029Z" level=info msg="Processing signal 'terminated'" May 27 17:35:30.933798 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 27 17:35:30.943721 flannel-wrapper[1982]: I0527 17:35:30.942829 1 main.go:376] shutdownHandler sent cancel signal... May 27 17:35:30.943721 flannel-wrapper[1982]: I0527 17:35:30.943021 1 watch.go:174] context canceled, close receiver chan May 27 17:35:30.943721 flannel-wrapper[1982]: I0527 17:35:30.943042 1 main.go:432] Stopped monitoring lease May 27 17:35:30.943721 flannel-wrapper[1982]: I0527 17:35:30.943049 1 main.go:345] Waiting for all goroutines to exit May 27 17:35:30.943721 flannel-wrapper[1982]: I0527 17:35:30.943056 1 watch.go:40] context canceled, close receiver chan May 27 17:35:30.943721 flannel-wrapper[1982]: I0527 17:35:30.943075 1 udp_network_amd64.go:114] evts chan closed May 27 17:35:30.943784 systemd-networkd[1423]: flannel0: Link DOWN May 27 17:35:30.943799 systemd-networkd[1423]: flannel0: Lost carrier May 27 17:35:30.946121 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.945Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} May 27 17:35:30.946590 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.945Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"e254593e671d46ffb93c17a30454865c","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"]} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.946Z","caller":"etcdserver/server.go:1429","msg":"skipped leadership transfer; local server is not leader","local-member-id":"d9ac3718b6bc9a4c","current-leader-member-id":"bcda29a17517c1c2"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.946Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda","error":"context canceled"} May 27 17:35:30.948002 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"b02a1fd01dee4dda","error":"failed to read b02a1fd01dee4dda on stream MsgApp v2 (context canceled)"} May 27 17:35:30.948397 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948397 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda","error":"context canceled"} May 27 17:35:30.948397 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948397 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:30.948397 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.947Z","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.949120 etcd-wrapper[1805]: WARNING: 2025/05/27 17:35:30 [core] grpc: addrConn.createTransport failed to connect to {0.0.0.0:2379 0.0.0.0:2379 0 }. Err: connection error: desc = "transport: Error while dialing dial tcp 0.0.0.0:2379: operation was canceled". Reconnecting... May 27 17:35:30.949120 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.948Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.949120 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.948Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.949666 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.949666 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.949666 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.949922 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2","error":"context canceled"} May 27 17:35:30.949922 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"bcda29a17517c1c2","error":"failed to read bcda29a17517c1c2 on stream MsgApp v2 (context canceled)"} May 27 17:35:30.950098 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.950098 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2","error":"context canceled"} May 27 17:35:30.950098 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.950371 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.949Z","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:30.950371 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.950Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id-stream-handler":"d9ac3718b6bc9a4c","remote-peer-id-from":"b02a1fd01dee4dda","cluster-id":"a3a1fbca348fda7d"} May 27 17:35:30.950504 etcd-wrapper[1805]: {"level":"warn","ts":"2025-05-27T17:35:30.950Z","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id-stream-handler":"d9ac3718b6bc9a4c","remote-peer-id-from":"b02a1fd01dee4dda","cluster-id":"a3a1fbca348fda7d"} May 27 17:35:30.951223 flannel-wrapper[1982]: I0527 17:35:30.950829 1 main.go:348] Exiting cleanly... May 27 17:35:30.951914 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:30.951Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"10.0.0.10:2380"} May 27 17:35:30.954568 systemd[1]: docker-de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e.scope: Deactivated successfully. May 27 17:35:30.975612 containerd[1519]: time="2025-05-27T17:35:30.975558488Z" level=info msg="shim disconnected" id=de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e namespace=moby May 27 17:35:30.975943 containerd[1519]: time="2025-05-27T17:35:30.975782458Z" level=warning msg="cleaning up after shim disconnected" id=de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e namespace=moby May 27 17:35:30.975943 containerd[1519]: time="2025-05-27T17:35:30.975796445Z" level=info msg="cleaning up dead shim" namespace=moby May 27 17:35:30.976005 dockerd[1594]: time="2025-05-27T17:35:30.975861757Z" level=info msg="ignoring event" container=de6d6b8c5b0cc198626147d863a3ca073b560cbd4c6aba9b6e81f0b091a9216e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 27 17:35:31.227767 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:31.227Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"10.0.0.10:2380"} May 27 17:35:31.227767 etcd-wrapper[1805]: {"level":"info","ts":"2025-05-27T17:35:31.227Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"e254593e671d46ffb93c17a30454865c","data-dir":"/var/lib/etcd","advertise-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"]} May 27 17:35:31.230085 systemd[1]: docker-e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7.scope: Deactivated successfully. May 27 17:35:31.245655 dockerd[1594]: time="2025-05-27T17:35:31.245596436Z" level=info msg="ignoring event" container=e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 27 17:35:31.245830 containerd[1519]: time="2025-05-27T17:35:31.245636962Z" level=info msg="shim disconnected" id=e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7 namespace=moby May 27 17:35:31.245830 containerd[1519]: time="2025-05-27T17:35:31.245692726Z" level=warning msg="cleaning up after shim disconnected" id=e17d99bbd42100b51e841f9600c725165f751c46b3c6ad92e53a430f659ca4d7 namespace=moby May 27 17:35:31.245830 containerd[1519]: time="2025-05-27T17:35:31.245701092Z" level=info msg="cleaning up dead shim" namespace=moby May 27 17:35:31.268375 systemd[1]: var-lib-docker-overlay2-899f2634c64f950009440e8b8fd7a27b823b992f3267757ab62f0d3ffb5bbac8-merged.mount: Deactivated successfully. May 27 17:35:31.278303 dockerd[1594]: time="2025-05-27T17:35:31.278247899Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby May 27 17:35:31.279424 dockerd[1594]: time="2025-05-27T17:35:31.279380834Z" level=info msg="Daemon shutdown complete" May 27 17:35:31.279513 dockerd[1594]: time="2025-05-27T17:35:31.279490910Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby May 27 17:35:31.477990 systemd[1]: docker.service: Deactivated successfully. May 27 17:35:31.478581 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 27 17:35:31.478669 systemd[1]: docker.service: Consumed 6.030s CPU time, 331.7M memory peak. May 27 17:35:31.479419 systemd[1]: docker.socket: Deactivated successfully. May 27 17:35:31.480109 systemd[1]: Closed docker.socket - Docker Socket for the API. May 27 17:35:31.480378 docker[2322]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? May 27 17:35:31.481827 docker[2292]: Cannot connect to the Docker daemon at unix:///var/run/docker.sock. Is the docker daemon running? May 27 17:35:31.480427 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 27 17:35:31.482704 systemd[1]: Starting docker.socket - Docker Socket for the API... May 27 17:35:31.483237 systemd[1]: etcd-member.service: Control process exited, code=exited, status=1/FAILURE May 27 17:35:31.490524 systemd[1]: flanneld.service: Control process exited, code=exited, status=1/FAILURE May 27 17:35:31.491672 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 27 17:35:31.495098 systemd[1]: Starting docker.service - Docker Application Container Engine... May 27 17:35:31.501063 (dockerd)[2337]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS May 27 17:35:31.546446 dockerd[2337]: time="2025-05-27T17:35:31.546346470Z" level=info msg="Starting up" May 27 17:35:31.547313 dockerd[2337]: time="2025-05-27T17:35:31.547279850Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 27 17:35:31.573541 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport4107970971-merged.mount: Deactivated successfully. May 27 17:35:31.586300 dockerd[2337]: time="2025-05-27T17:35:31.586250344Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 27 17:35:31.612643 dockerd[2337]: time="2025-05-27T17:35:31.612570173Z" level=info msg="Loading containers: start." May 27 17:35:32.394928 dockerd[2337]: time="2025-05-27T17:35:32.394869162Z" level=info msg="Loading containers: done." May 27 17:35:32.407174 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2299087807-merged.mount: Deactivated successfully. May 27 17:35:32.497808 dockerd[2337]: time="2025-05-27T17:35:32.497665262Z" 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 27 17:35:32.497922 dockerd[2337]: time="2025-05-27T17:35:32.497906344Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 27 17:35:32.498008 dockerd[2337]: time="2025-05-27T17:35:32.497985783Z" level=info msg="Initializing buildkit" May 27 17:35:32.514663 dockerd[2337]: time="2025-05-27T17:35:32.514616842Z" level=info msg="Completed buildkit initialization" May 27 17:35:32.523329 dockerd[2337]: time="2025-05-27T17:35:32.523261193Z" level=info msg="Daemon has completed initialization" May 27 17:35:32.523474 dockerd[2337]: time="2025-05-27T17:35:32.523351352Z" level=info msg="API listen on /run/docker.sock" May 27 17:35:32.523560 systemd[1]: Started docker.service - Docker Application Container Engine. May 27 17:35:32.524804 sh[2135]: Restarted Docker to apply Flannel options May 27 17:35:32.525670 sh[2123]: + break May 27 17:35:32.525670 sh[2123]: + '[' 1 '!=' fail ']' May 27 17:35:32.527264 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). May 27 17:35:32.527519 systemd[1]: Startup finished in 3.746s (kernel) + 4.960s (initrd) + 19.576s (userspace) = 28.282s. May 27 17:35:32.618169 docker[2333]: etcd-member May 27 17:35:32.618528 docker[2334]: flannel May 27 17:35:32.620908 systemd[1]: flanneld.service: Failed with result 'exit-code'. May 27 17:35:32.621791 systemd[1]: etcd-member.service: Failed with result 'exit-code'. May 27 17:35:32.856054 systemd[1]: Started sshd@3-10.0.0.10:22-10.0.0.1:33504.service - OpenSSH per-connection server daemon (10.0.0.1:33504). May 27 17:35:32.925475 sshd[2572]: Accepted publickey for core from 10.0.0.1 port 33504 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:32.927150 sshd-session[2572]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:32.932083 systemd-logind[1437]: New session 4 of user core. May 27 17:35:32.941823 systemd[1]: Started session-4.scope - Session 4 of User core. May 27 17:35:32.995949 sshd[2574]: Connection closed by 10.0.0.1 port 33504 May 27 17:35:32.996314 sshd-session[2572]: pam_unix(sshd:session): session closed for user core May 27 17:35:33.005498 systemd[1]: sshd@3-10.0.0.10:22-10.0.0.1:33504.service: Deactivated successfully. May 27 17:35:33.007314 systemd[1]: session-4.scope: Deactivated successfully. May 27 17:35:33.008132 systemd-logind[1437]: Session 4 logged out. Waiting for processes to exit. May 27 17:35:33.011074 systemd[1]: Started sshd@4-10.0.0.10:22-10.0.0.1:45348.service - OpenSSH per-connection server daemon (10.0.0.1:45348). May 27 17:35:33.011586 systemd-logind[1437]: Removed session 4. May 27 17:35:33.069119 sshd[2580]: Accepted publickey for core from 10.0.0.1 port 45348 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:33.070571 sshd-session[2580]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:33.074932 systemd-logind[1437]: New session 5 of user core. May 27 17:35:33.089840 systemd[1]: Started session-5.scope - Session 5 of User core. May 27 17:35:33.139533 sshd[2582]: Connection closed by 10.0.0.1 port 45348 May 27 17:35:33.139804 sshd-session[2580]: pam_unix(sshd:session): session closed for user core May 27 17:35:33.152797 systemd[1]: sshd@4-10.0.0.10:22-10.0.0.1:45348.service: Deactivated successfully. May 27 17:35:33.154655 systemd[1]: session-5.scope: Deactivated successfully. May 27 17:35:33.155614 systemd-logind[1437]: Session 5 logged out. Waiting for processes to exit. May 27 17:35:33.158392 systemd[1]: Started sshd@5-10.0.0.10:22-10.0.0.1:45364.service - OpenSSH per-connection server daemon (10.0.0.1:45364). May 27 17:35:33.159226 systemd-logind[1437]: Removed session 5. May 27 17:35:33.216497 sshd[2588]: Accepted publickey for core from 10.0.0.1 port 45364 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:33.218244 sshd-session[2588]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:33.223371 systemd-logind[1437]: New session 6 of user core. May 27 17:35:33.232841 systemd[1]: Started session-6.scope - Session 6 of User core. May 27 17:35:33.287425 sshd[2590]: Connection closed by 10.0.0.1 port 45364 May 27 17:35:33.287828 sshd-session[2588]: pam_unix(sshd:session): session closed for user core May 27 17:35:33.306388 systemd[1]: sshd@5-10.0.0.10:22-10.0.0.1:45364.service: Deactivated successfully. May 27 17:35:33.308240 systemd[1]: session-6.scope: Deactivated successfully. May 27 17:35:33.308986 systemd-logind[1437]: Session 6 logged out. Waiting for processes to exit. May 27 17:35:33.312219 systemd[1]: Started sshd@6-10.0.0.10:22-10.0.0.1:45366.service - OpenSSH per-connection server daemon (10.0.0.1:45366). May 27 17:35:33.313159 systemd-logind[1437]: Removed session 6. May 27 17:35:33.370840 sshd[2596]: Accepted publickey for core from 10.0.0.1 port 45366 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:33.372302 sshd-session[2596]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:33.376775 systemd-logind[1437]: New session 7 of user core. May 27 17:35:33.387806 systemd[1]: Started session-7.scope - Session 7 of User core. May 27 17:35:33.445935 sudo[2599]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 27 17:35:33.446236 sudo[2599]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 17:35:33.467174 sudo[2599]: pam_unix(sudo:session): session closed for user root May 27 17:35:33.469467 sshd[2598]: Connection closed by 10.0.0.1 port 45366 May 27 17:35:33.469986 sshd-session[2596]: pam_unix(sshd:session): session closed for user core May 27 17:35:33.487472 systemd[1]: sshd@6-10.0.0.10:22-10.0.0.1:45366.service: Deactivated successfully. May 27 17:35:33.489300 systemd[1]: session-7.scope: Deactivated successfully. May 27 17:35:33.490228 systemd-logind[1437]: Session 7 logged out. Waiting for processes to exit. May 27 17:35:33.493257 systemd[1]: Started sshd@7-10.0.0.10:22-10.0.0.1:45372.service - OpenSSH per-connection server daemon (10.0.0.1:45372). May 27 17:35:33.493881 systemd-logind[1437]: Removed session 7. May 27 17:35:33.565140 sshd[2605]: Accepted publickey for core from 10.0.0.1 port 45372 ssh2: RSA SHA256:Sdu3hc/K/GsFAoVLDVpDFh1tw++0J1r4WpeL8cs/qlY May 27 17:35:33.566962 sshd-session[2605]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 27 17:35:33.572375 systemd-logind[1437]: New session 8 of user core. May 27 17:35:33.586859 systemd[1]: Started session-8.scope - Session 8 of User core. May 27 17:35:33.642340 sudo[2609]: 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 27 17:35:33.642761 sudo[2609]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 17:35:33.735074 sudo[2609]: pam_unix(sudo:session): session closed for user root May 27 17:35:33.741996 sudo[2608]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 27 17:35:33.742324 sudo[2608]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 27 17:35:33.752965 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 27 17:35:33.803201 augenrules[2631]: No rules May 27 17:35:33.805219 systemd[1]: audit-rules.service: Deactivated successfully. May 27 17:35:33.805565 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 27 17:35:33.806746 sudo[2608]: pam_unix(sudo:session): session closed for user root May 27 17:35:33.808248 sshd[2607]: Connection closed by 10.0.0.1 port 45372 May 27 17:35:33.808602 sshd-session[2605]: pam_unix(sshd:session): session closed for user core May 27 17:35:33.812999 systemd[1]: sshd@7-10.0.0.10:22-10.0.0.1:45372.service: Deactivated successfully. May 27 17:35:33.814915 systemd[1]: session-8.scope: Deactivated successfully. May 27 17:35:33.815595 systemd-logind[1437]: Session 8 logged out. Waiting for processes to exit. May 27 17:35:33.816956 systemd-logind[1437]: Removed session 8. May 27 17:35:42.656245 systemd[1]: flanneld.service: Scheduled restart job, restart counter is at 1. May 27 17:35:42.657291 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. May 27 17:35:42.659741 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 27 17:35:42.661110 systemd[1]: Stopping flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... May 27 17:35:42.697513 docker[2640]: flannel-docker-opts May 27 17:35:42.720524 systemd[1]: coreos-metadata.service: Deactivated successfully. May 27 17:35:42.720895 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 27 17:35:42.744040 docker[2652]: flannel-docker-opts May 27 17:35:42.747496 systemd[1]: flannel-docker-opts.service: Deactivated successfully. May 27 17:35:42.747904 systemd[1]: Stopped flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). May 27 17:35:42.748474 systemd[1]: Stopped flanneld.service - flannel - Network fabric for containers (System Application Container). May 27 17:35:42.750411 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... May 27 17:35:42.765117 (-wrapper)[2664]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS May 27 17:35:42.793323 etcd-wrapper[2668]: Error response from daemon: No such container: etcd-member May 27 17:35:42.813819 etcd-wrapper[2676]: Error response from daemon: No such container: etcd-member May 27 17:35:42.875640 systemd[1]: var-lib-docker-overlay2-a47422cbd95d5d97eaceb0387de9983ac62a8470b98c3e09e394fd1c046de08a\x2dinit-merged.mount: Deactivated successfully. May 27 17:35:42.931355 containerd[1519]: time="2025-05-27T17:35:42.931165038Z" level=info msg="connecting to shim 4f924a95c976314dfe339ad3a92723466f84c6383818669f1a354075386eab69" address="unix:///run/containerd/s/7bc4170fb6b1d3fbb821f011a130fa7468de7d207fc3b09f0f5d33e568073b91" namespace=moby protocol=ttrpc version=3 May 27 17:35:42.974984 systemd[1]: Started docker-4f924a95c976314dfe339ad3a92723466f84c6383818669f1a354075386eab69.scope - libcontainer container 4f924a95c976314dfe339ad3a92723466f84c6383818669f1a354075386eab69. May 27 17:35:42.989627 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"info","ts":1748367343.05275,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"info","ts":1748367343.0528345,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"e254593e671d46ffb93c17a30454865c"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"warn","ts":1748367343.0528643,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"warn","ts":1748367343.0528846,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"warn","ts":1748367343.0528917,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"warn","ts":1748367343.052897,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.052Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.10:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.10:2380","--advertise-client-urls=http://10.0.0.10:2379","--discovery=http://10.0.0.1:45585/v2/keys/discovery/6488523790626097413","--enable-v2=true"]} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.053Z","caller":"etcdmain/etcd.go:115","msg":"server has been already initialized","data-dir":"/var/lib/etcd","dir-type":"member"} May 27 17:35:43.053406 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.053Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.10:2380"]} May 27 17:35:43.054591 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.053Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} May 27 17:35:43.054591 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.053Z","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":4,"max-cpu-available":4,"member-initialized":true,"name":"e254593e671d46ffb93c17a30454865c","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://10.0.0.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"","initial-cluster-state":"new","initial-cluster-token":"","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"http://10.0.0.1:45585/v2/keys/discovery/6488523790626097413","discovery-proxy":"","downgrade-check-interval":"5s"} May 27 17:35:43.054591 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.054Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"214.382µs"} May 27 17:35:43.054591 etcd-wrapper[2697]: {"level":"warn","ts":"2025-05-27T17:35:43.054Z","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 27 17:35:43.054591 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.054Z","caller":"etcdserver/server.go:526","msg":"No snapshot found. Recovering WAL from scratch!"} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","caller":"etcdserver/raft.go:483","msg":"restarting local member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","commit-index":31} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=()"} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became follower at term 3"} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d9ac3718b6bc9a4c [peers: [], term: 3, commit: 31, applied: 0, lastindex: 32, lastterm: 3]"} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","recovered-remote-peer-id":"b02a1fd01dee4dda","recovered-remote-peer-urls":["http://10.0.0.9:2380"]} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","recovered-remote-peer-id":"bcda29a17517c1c2","recovered-remote-peer-urls":["http://10.0.0.11:2380"]} May 27 17:35:43.055637 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","caller":"membership/cluster.go:276","msg":"recovered/added member from store","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","recovered-remote-peer-id":"d9ac3718b6bc9a4c","recovered-remote-peer-urls":["http://10.0.0.10:2380"]} May 27 17:35:43.056025 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.055Z","caller":"membership/cluster.go:285","msg":"set cluster version from store","cluster-version":"3.5"} May 27 17:35:43.057445 etcd-wrapper[2697]: {"level":"warn","ts":"2025-05-27T17:35:43.057Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} May 27 17:35:43.058766 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.058Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} May 27 17:35:43.059321 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.059Z","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 27 17:35:43.059884 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.059Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.060038 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.059Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.061108 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.060Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.061359 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.061Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.061888 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.061Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.061888 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.061Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.062732 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.061Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda","remote-peer-urls":["http://10.0.0.9:2380"]} May 27 17:35:43.062732 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.062Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.062732 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.062Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.062732 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.061Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.063035 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.062Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.063853 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.063Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.064459 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.064Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.064700 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.064Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.064925 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.064Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.064925 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.064Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2","remote-peer-urls":["http://10.0.0.11:2380"]} May 27 17:35:43.065138 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.064Z","caller":"etcdserver/server.go:834","msg":"starting etcd server","local-member-id":"d9ac3718b6bc9a4c","local-server-version":"3.5.0","cluster-id":"a3a1fbca348fda7d","cluster-version":"3.5"} May 27 17:35:43.065138 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.064Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} May 27 17:35:43.065774 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674)"} May 27 17:35:43.066248 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","added-peer-id":"b02a1fd01dee4dda","added-peer-peer-urls":["http://10.0.0.9:2380"]} May 27 17:35:43.066248 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650)"} May 27 17:35:43.066248 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","added-peer-id":"bcda29a17517c1c2","added-peer-peer-urls":["http://10.0.0.11:2380"]} May 27 17:35:43.066248 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c switched to configuration voters=(12693993478412979674 13608234997484339650 15684972181509151308)"} May 27 17:35:43.066248 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","added-peer-id":"d9ac3718b6bc9a4c","added-peer-peer-urls":["http://10.0.0.10:2380"]} May 27 17:35:43.066491 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"bcda29a17517c1c2"} May 27 17:35:43.066491 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.065Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.066491 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.066Z","caller":"membership/cluster.go:523","msg":"updated cluster version","cluster-id":"a3a1fbca348fda7d","local-member-id":"d9ac3718b6bc9a4c","from":"3.5","to":"3.5"} May 27 17:35:43.066491 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.066Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.066759 etcd-wrapper[2697]: {"level":"warn","ts":"2025-05-27T17:35:43.066Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} May 27 17:35:43.066759 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.066Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"d9ac3718b6bc9a4c","initial-advertise-peer-urls":["http://10.0.0.10:2380"],"listen-peer-urls":["http://10.0.0.10:2380"],"advertise-client-urls":["http://10.0.0.10:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} May 27 17:35:43.066759 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.066Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.10:2380"} May 27 17:35:43.066890 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.066Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.10:2380"} May 27 17:35:43.102873 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.102Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"bcda29a17517c1c2","stream-type":"stream MsgApp v2"} May 27 17:35:43.102873 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.102Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.102873 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.102Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"bcda29a17517c1c2","stream-type":"stream Message"} May 27 17:35:43.102873 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.102Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"bcda29a17517c1c2"} May 27 17:35:43.416387 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.416Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"b02a1fd01dee4dda","stream-type":"stream Message"} May 27 17:35:43.416387 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.416Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.416387 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.416Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.416387 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.416Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"d9ac3718b6bc9a4c","to":"b02a1fd01dee4dda","stream-type":"stream MsgApp v2"} May 27 17:35:43.416387 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.416Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.418127 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.417Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"d9ac3718b6bc9a4c","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} May 27 17:35:43.455727 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 3, index: 32, vote: bcda29a17517c1c2] cast MsgPreVote for bcda29a17517c1c2 [logterm: 3, index: 32] at term 3"} May 27 17:35:43.459402 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [term: 3] received a MsgVote message with higher term from bcda29a17517c1c2 [term: 4]"} May 27 17:35:43.459402 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c became follower at term 4"} May 27 17:35:43.459402 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9ac3718b6bc9a4c [logterm: 3, index: 32, vote: 0] cast MsgVote for bcda29a17517c1c2 [logterm: 3, index: 32] at term 4"} May 27 17:35:43.464557 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.464Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.464639 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.464Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"d9ac3718b6bc9a4c","remote-peer-id":"b02a1fd01dee4dda"} May 27 17:35:43.466498 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9ac3718b6bc9a4c elected leader bcda29a17517c1c2 at term 4"} May 27 17:35:43.471393 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.470Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"d9ac3718b6bc9a4c","local-member-attributes":"{Name:e254593e671d46ffb93c17a30454865c ClientURLs:[http://10.0.0.10:2379]}","request-path":"/0/members/d9ac3718b6bc9a4c/attributes","cluster-id":"a3a1fbca348fda7d","publish-timeout":"7s"} May 27 17:35:43.471393 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.470Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} May 27 17:35:43.471393 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.471Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} May 27 17:35:43.471393 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.471Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} May 27 17:35:43.471537 systemd[1]: Started etcd-member.service - etcd (System Application Container). May 27 17:35:43.472542 etcd-wrapper[2697]: {"level":"info","ts":"2025-05-27T17:35:43.472Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} May 27 17:35:43.473524 systemd[1]: Starting flanneld.service - flannel - Network fabric for containers (System Application Container)... May 27 17:35:43.533134 etcdctl[2762]: { "Network": "10.254.0.0/16", "Backend": {"Type": "udp"} } May 27 17:35:43.578045 flannel-wrapper[2771]: Error response from daemon: No such container: flannel May 27 17:35:43.593105 flannel-wrapper[2779]: Error response from daemon: No such container: flannel May 27 17:35:43.683146 containerd[1519]: time="2025-05-27T17:35:43.682994156Z" level=info msg="connecting to shim 09496a8ea55b04aeef92fe0a862c2255bc4eabe1eead84462ab6fbe3ae126b11" address="unix:///run/containerd/s/eb0769c58407924670771429b97f3a922934bbfa6f0b2806f227c9c9cb52dcb9" namespace=moby protocol=ttrpc version=3 May 27 17:35:43.720006 systemd[1]: Started docker-09496a8ea55b04aeef92fe0a862c2255bc4eabe1eead84462ab6fbe3ae126b11.scope - libcontainer container 09496a8ea55b04aeef92fe0a862c2255bc4eabe1eead84462ab6fbe3ae126b11. May 27 17:35:43.746008 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 17:35:43.795535 flannel-wrapper[2797]: I0527 17:35:43.795065 1 main.go:520] Determining IP address of default interface May 27 17:35:43.795992 flannel-wrapper[2797]: I0527 17:35:43.795492 1 main.go:533] Using interface with name eth0 and address 10.0.0.10 May 27 17:35:43.795992 flannel-wrapper[2797]: I0527 17:35:43.795517 1 main.go:550] Defaulting external address to interface address (10.0.0.10) May 27 17:35:43.795992 flannel-wrapper[2797]: I0527 17:35:43.795672 1 main.go:254] Created subnet manager: Etcd Local Manager with Previous Subnet: 10.254.22.0/24 May 27 17:35:43.795992 flannel-wrapper[2797]: I0527 17:35:43.795702 1 main.go:257] Installing signal handlers May 27 17:35:43.800966 flannel-wrapper[2797]: I0527 17:35:43.800772 1 main.go:392] Found network config - Backend type: udp May 27 17:35:43.808269 flannel-wrapper[2797]: I0527 17:35:43.807810 1 local_manager.go:147] Found lease (10.254.22.0/24) for current IP (10.0.0.10), reusing May 27 17:35:43.812721 flannel-wrapper[2797]: I0527 17:35:43.811194 1 main.go:307] Setting up masking rules May 27 17:35:43.812075 systemd-networkd[1423]: flannel0: Link UP May 27 17:35:43.812082 systemd-networkd[1423]: flannel0: Gained carrier May 27 17:35:43.812333 systemd-networkd[1423]: flannel0: Gained IPv6LL May 27 17:35:43.833005 flannel-wrapper[2797]: I0527 17:35:43.832541 1 main.go:315] Changing default FORWARD chain policy to ACCEPT May 27 17:35:43.833144 flannel-wrapper[2797]: I0527 17:35:43.832737 1 main.go:323] Wrote subnet file to /run/flannel/subnet.env May 27 17:35:43.833144 flannel-wrapper[2797]: I0527 17:35:43.832913 1 main.go:327] Running backend. May 27 17:35:43.833230 systemd[1]: Started flanneld.service - flannel - Network fabric for containers (System Application Container). May 27 17:35:43.835100 flannel-wrapper[2797]: I0527 17:35:43.833068 1 udp_network_amd64.go:100] Watching for new subnet leases May 27 17:35:43.835651 systemd[1]: Starting flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container)... May 27 17:35:43.844415 flannel-wrapper[2797]: I0527 17:35:43.843509 1 main.go:439] Waiting for 22h59m59.964690663s to renew lease May 27 17:35:43.844415 flannel-wrapper[2797]: I0527 17:35:43.844033 1 udp_network_amd64.go:196] Subnet added: 10.254.61.0/24 May 27 17:35:43.844610 flannel-wrapper[2797]: I0527 17:35:43.844432 1 udp_network_amd64.go:196] Subnet added: 10.254.81.0/24 May 27 17:35:43.852001 sh[2888]: + for try in 1 2 3 4 5 6 May 27 17:35:43.852001 sh[2888]: + /usr/lib/coreos/flannel-wrapper -d /run/flannel/flannel_docker_opts.env -i May 27 17:35:43.879442 sh[2899]: Error response from daemon: No such container: flannel-docker-opts May 27 17:35:43.898894 sh[2907]: Error response from daemon: No such container: flannel-docker-opts May 27 17:35:43.939788 systemd[1]: var-lib-docker-overlay2-1ed4ce1fabd4c7ffd725ce940822e03d2ca2bed736eb24252c550d84af56b7de\x2dinit-merged.mount: Deactivated successfully. May 27 17:35:43.990227 containerd[1519]: time="2025-05-27T17:35:43.990163749Z" level=info msg="connecting to shim f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908" address="unix:///run/containerd/s/7369e13f99fa2b663e78e2536172f264c67a3b40839951f8afa7543ffe1a90be" namespace=moby protocol=ttrpc version=3 May 27 17:35:44.023892 systemd[1]: Started docker-f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908.scope - libcontainer container f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908. May 27 17:35:44.048950 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 27 17:35:44.078402 systemd[1]: docker-f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908.scope: Deactivated successfully. May 27 17:35:44.097257 containerd[1519]: time="2025-05-27T17:35:44.097157610Z" level=info msg="shim disconnected" id=f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908 namespace=moby May 27 17:35:44.097257 containerd[1519]: time="2025-05-27T17:35:44.097200561Z" level=warning msg="cleaning up after shim disconnected" id=f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908 namespace=moby May 27 17:35:44.097257 containerd[1519]: time="2025-05-27T17:35:44.097212433Z" level=info msg="cleaning up dead shim" namespace=moby May 27 17:35:44.097618 dockerd[2337]: time="2025-05-27T17:35:44.097532754Z" level=info msg="ignoring event" container=f3a04e39c9b19897a350886304f4fdf5925599383802719cecc28f3732d5f908 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 27 17:35:44.132589 sh[2888]: + break May 27 17:35:44.132835 sh[2888]: + '[' 1 '!=' fail ']' May 27 17:35:44.134801 systemd[1]: Finished flannel-docker-opts.service - flannel docker export service - Network fabric for containers (System Application Container). May 27 17:36:01.256930 update_engine[1439]: I20250527 17:36:01.256786 1439 update_attempter.cc:509] Updating boot flags...