Aug 13 07:16:54.965763 kernel: Linux version 6.6.100-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Aug 12 22:14:58 -00 2025 Aug 13 07:16:54.965785 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=8b1c4c6202e70eaa8c6477427259ab5e403c8f1de8515605304942a21d23450a Aug 13 07:16:54.965797 kernel: BIOS-provided physical RAM map: Aug 13 07:16:54.965803 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Aug 13 07:16:54.965809 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Aug 13 07:16:54.965816 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Aug 13 07:16:54.965823 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Aug 13 07:16:54.965829 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Aug 13 07:16:54.965835 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Aug 13 07:16:54.965844 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Aug 13 07:16:54.965850 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Aug 13 07:16:54.965857 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Aug 13 07:16:54.965868 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Aug 13 07:16:54.965876 kernel: NX (Execute Disable) protection: active Aug 13 07:16:54.965887 kernel: APIC: Static calls initialized Aug 13 07:16:54.965903 kernel: SMBIOS 2.8 present. Aug 13 07:16:54.965911 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Aug 13 07:16:54.965918 kernel: Hypervisor detected: KVM Aug 13 07:16:54.965925 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Aug 13 07:16:54.965931 kernel: kvm-clock: using sched offset of 3468300092 cycles Aug 13 07:16:54.965938 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Aug 13 07:16:54.965945 kernel: tsc: Detected 2794.750 MHz processor Aug 13 07:16:54.965952 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Aug 13 07:16:54.965960 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Aug 13 07:16:54.965966 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Aug 13 07:16:54.965976 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Aug 13 07:16:54.965983 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Aug 13 07:16:54.965990 kernel: Using GB pages for direct mapping Aug 13 07:16:54.965997 kernel: ACPI: Early table checksum verification disabled Aug 13 07:16:54.966004 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Aug 13 07:16:54.966012 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966019 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966026 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966035 kernel: ACPI: FACS 0x000000009CFE0000 000040 Aug 13 07:16:54.966042 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966049 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966056 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966063 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:16:54.966070 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Aug 13 07:16:54.966077 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Aug 13 07:16:54.966087 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Aug 13 07:16:54.966097 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Aug 13 07:16:54.966104 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Aug 13 07:16:54.966111 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Aug 13 07:16:54.966118 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Aug 13 07:16:54.966125 kernel: No NUMA configuration found Aug 13 07:16:54.966133 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Aug 13 07:16:54.966140 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Aug 13 07:16:54.966149 kernel: Zone ranges: Aug 13 07:16:54.966157 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Aug 13 07:16:54.966164 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Aug 13 07:16:54.966171 kernel: Normal empty Aug 13 07:16:54.966178 kernel: Movable zone start for each node Aug 13 07:16:54.966185 kernel: Early memory node ranges Aug 13 07:16:54.966192 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Aug 13 07:16:54.966199 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Aug 13 07:16:54.966206 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Aug 13 07:16:54.966216 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Aug 13 07:16:54.966225 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Aug 13 07:16:54.966233 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Aug 13 07:16:54.966240 kernel: ACPI: PM-Timer IO Port: 0x608 Aug 13 07:16:54.966247 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Aug 13 07:16:54.966255 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Aug 13 07:16:54.966262 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Aug 13 07:16:54.966269 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Aug 13 07:16:54.966276 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Aug 13 07:16:54.966286 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Aug 13 07:16:54.966293 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Aug 13 07:16:54.966300 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Aug 13 07:16:54.966307 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Aug 13 07:16:54.966314 kernel: TSC deadline timer available Aug 13 07:16:54.966322 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Aug 13 07:16:54.966329 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Aug 13 07:16:54.966336 kernel: kvm-guest: KVM setup pv remote TLB flush Aug 13 07:16:54.966345 kernel: kvm-guest: setup PV sched yield Aug 13 07:16:54.966354 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Aug 13 07:16:54.966362 kernel: Booting paravirtualized kernel on KVM Aug 13 07:16:54.966369 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Aug 13 07:16:54.966376 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Aug 13 07:16:54.966384 kernel: percpu: Embedded 58 pages/cpu s197096 r8192 d32280 u524288 Aug 13 07:16:54.966391 kernel: pcpu-alloc: s197096 r8192 d32280 u524288 alloc=1*2097152 Aug 13 07:16:54.966398 kernel: pcpu-alloc: [0] 0 1 2 3 Aug 13 07:16:54.966405 kernel: kvm-guest: PV spinlocks enabled Aug 13 07:16:54.966412 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Aug 13 07:16:54.966423 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=8b1c4c6202e70eaa8c6477427259ab5e403c8f1de8515605304942a21d23450a Aug 13 07:16:54.966430 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 13 07:16:54.966437 kernel: random: crng init done Aug 13 07:16:54.966445 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 13 07:16:54.966452 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 13 07:16:54.966459 kernel: Fallback order for Node 0: 0 Aug 13 07:16:54.966466 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 Aug 13 07:16:54.966473 kernel: Policy zone: DMA32 Aug 13 07:16:54.966483 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 13 07:16:54.966491 kernel: Memory: 2434592K/2571752K available (12288K kernel code, 2295K rwdata, 22748K rodata, 42876K init, 2316K bss, 136900K reserved, 0K cma-reserved) Aug 13 07:16:54.966498 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 13 07:16:54.966505 kernel: ftrace: allocating 37968 entries in 149 pages Aug 13 07:16:54.966512 kernel: ftrace: allocated 149 pages with 4 groups Aug 13 07:16:54.966519 kernel: Dynamic Preempt: voluntary Aug 13 07:16:54.966526 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 13 07:16:54.966534 kernel: rcu: RCU event tracing is enabled. Aug 13 07:16:54.966542 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 13 07:16:54.966576 kernel: Trampoline variant of Tasks RCU enabled. Aug 13 07:16:54.966584 kernel: Rude variant of Tasks RCU enabled. Aug 13 07:16:54.966591 kernel: Tracing variant of Tasks RCU enabled. Aug 13 07:16:54.966599 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 13 07:16:54.966608 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 13 07:16:54.966615 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Aug 13 07:16:54.966623 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 13 07:16:54.966630 kernel: Console: colour VGA+ 80x25 Aug 13 07:16:54.966637 kernel: printk: console [ttyS0] enabled Aug 13 07:16:54.966644 kernel: ACPI: Core revision 20230628 Aug 13 07:16:54.966655 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Aug 13 07:16:54.966662 kernel: APIC: Switch to symmetric I/O mode setup Aug 13 07:16:54.966669 kernel: x2apic enabled Aug 13 07:16:54.966685 kernel: APIC: Switched APIC routing to: physical x2apic Aug 13 07:16:54.966692 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Aug 13 07:16:54.966699 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Aug 13 07:16:54.966707 kernel: kvm-guest: setup PV IPIs Aug 13 07:16:54.966725 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Aug 13 07:16:54.966732 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Aug 13 07:16:54.966740 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Aug 13 07:16:54.966747 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Aug 13 07:16:54.966757 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Aug 13 07:16:54.966765 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Aug 13 07:16:54.966772 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Aug 13 07:16:54.966780 kernel: Spectre V2 : Mitigation: Retpolines Aug 13 07:16:54.966787 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Aug 13 07:16:54.966798 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Aug 13 07:16:54.966808 kernel: RETBleed: Mitigation: untrained return thunk Aug 13 07:16:54.966818 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Aug 13 07:16:54.966828 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Aug 13 07:16:54.966835 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Aug 13 07:16:54.966843 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Aug 13 07:16:54.966851 kernel: x86/bugs: return thunk changed Aug 13 07:16:54.966858 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Aug 13 07:16:54.966869 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Aug 13 07:16:54.966876 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Aug 13 07:16:54.966884 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Aug 13 07:16:54.966891 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Aug 13 07:16:54.966899 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Aug 13 07:16:54.966906 kernel: Freeing SMP alternatives memory: 32K Aug 13 07:16:54.966914 kernel: pid_max: default: 32768 minimum: 301 Aug 13 07:16:54.966921 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Aug 13 07:16:54.966929 kernel: landlock: Up and running. Aug 13 07:16:54.966939 kernel: SELinux: Initializing. Aug 13 07:16:54.966947 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 07:16:54.966954 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 07:16:54.966962 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Aug 13 07:16:54.966969 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 13 07:16:54.966977 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 13 07:16:54.966985 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 13 07:16:54.966992 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Aug 13 07:16:54.967002 kernel: ... version: 0 Aug 13 07:16:54.967012 kernel: ... bit width: 48 Aug 13 07:16:54.967020 kernel: ... generic registers: 6 Aug 13 07:16:54.967027 kernel: ... value mask: 0000ffffffffffff Aug 13 07:16:54.967035 kernel: ... max period: 00007fffffffffff Aug 13 07:16:54.967042 kernel: ... fixed-purpose events: 0 Aug 13 07:16:54.967050 kernel: ... event mask: 000000000000003f Aug 13 07:16:54.967057 kernel: signal: max sigframe size: 1776 Aug 13 07:16:54.967064 kernel: rcu: Hierarchical SRCU implementation. Aug 13 07:16:54.967072 kernel: rcu: Max phase no-delay instances is 400. Aug 13 07:16:54.967082 kernel: smp: Bringing up secondary CPUs ... Aug 13 07:16:54.967090 kernel: smpboot: x86: Booting SMP configuration: Aug 13 07:16:54.967097 kernel: .... node #0, CPUs: #1 #2 #3 Aug 13 07:16:54.967104 kernel: smp: Brought up 1 node, 4 CPUs Aug 13 07:16:54.967112 kernel: smpboot: Max logical packages: 1 Aug 13 07:16:54.967119 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Aug 13 07:16:54.967127 kernel: devtmpfs: initialized Aug 13 07:16:54.967134 kernel: x86/mm: Memory block size: 128MB Aug 13 07:16:54.967142 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 13 07:16:54.967150 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 13 07:16:54.967160 kernel: pinctrl core: initialized pinctrl subsystem Aug 13 07:16:54.967167 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 13 07:16:54.967175 kernel: audit: initializing netlink subsys (disabled) Aug 13 07:16:54.967182 kernel: audit: type=2000 audit(1755069413.720:1): state=initialized audit_enabled=0 res=1 Aug 13 07:16:54.967190 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 13 07:16:54.967197 kernel: thermal_sys: Registered thermal governor 'user_space' Aug 13 07:16:54.967205 kernel: cpuidle: using governor menu Aug 13 07:16:54.967212 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 13 07:16:54.967223 kernel: dca service started, version 1.12.1 Aug 13 07:16:54.967231 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Aug 13 07:16:54.967238 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Aug 13 07:16:54.967246 kernel: PCI: Using configuration type 1 for base access Aug 13 07:16:54.967253 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Aug 13 07:16:54.967261 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 13 07:16:54.967269 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Aug 13 07:16:54.967276 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 13 07:16:54.967284 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Aug 13 07:16:54.967294 kernel: ACPI: Added _OSI(Module Device) Aug 13 07:16:54.967301 kernel: ACPI: Added _OSI(Processor Device) Aug 13 07:16:54.967309 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 13 07:16:54.967316 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 13 07:16:54.967324 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Aug 13 07:16:54.967331 kernel: ACPI: Interpreter enabled Aug 13 07:16:54.967339 kernel: ACPI: PM: (supports S0 S3 S5) Aug 13 07:16:54.967346 kernel: ACPI: Using IOAPIC for interrupt routing Aug 13 07:16:54.967354 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Aug 13 07:16:54.967361 kernel: PCI: Using E820 reservations for host bridge windows Aug 13 07:16:54.967372 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Aug 13 07:16:54.967379 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 13 07:16:54.967618 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 13 07:16:54.967771 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Aug 13 07:16:54.967897 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Aug 13 07:16:54.967907 kernel: PCI host bridge to bus 0000:00 Aug 13 07:16:54.968052 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Aug 13 07:16:54.968176 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Aug 13 07:16:54.968290 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Aug 13 07:16:54.968403 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Aug 13 07:16:54.968517 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Aug 13 07:16:54.968684 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Aug 13 07:16:54.968801 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 13 07:16:54.968974 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Aug 13 07:16:54.969118 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Aug 13 07:16:54.969260 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Aug 13 07:16:54.969388 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Aug 13 07:16:54.969513 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Aug 13 07:16:54.969669 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Aug 13 07:16:54.969830 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Aug 13 07:16:54.969963 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Aug 13 07:16:54.970088 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Aug 13 07:16:54.970213 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Aug 13 07:16:54.970357 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Aug 13 07:16:54.970484 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Aug 13 07:16:54.970629 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Aug 13 07:16:54.970797 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Aug 13 07:16:54.970983 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Aug 13 07:16:54.971129 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Aug 13 07:16:54.971265 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Aug 13 07:16:54.971404 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Aug 13 07:16:54.971537 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Aug 13 07:16:54.971712 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Aug 13 07:16:54.971849 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Aug 13 07:16:54.971993 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Aug 13 07:16:54.972120 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Aug 13 07:16:54.972245 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Aug 13 07:16:54.972381 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Aug 13 07:16:54.972507 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Aug 13 07:16:54.972517 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Aug 13 07:16:54.972529 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Aug 13 07:16:54.972537 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Aug 13 07:16:54.972545 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Aug 13 07:16:54.972602 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Aug 13 07:16:54.972610 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Aug 13 07:16:54.972618 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Aug 13 07:16:54.972625 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Aug 13 07:16:54.972633 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Aug 13 07:16:54.972640 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Aug 13 07:16:54.972652 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Aug 13 07:16:54.972659 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Aug 13 07:16:54.972667 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Aug 13 07:16:54.972683 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Aug 13 07:16:54.972691 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Aug 13 07:16:54.972699 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Aug 13 07:16:54.972706 kernel: iommu: Default domain type: Translated Aug 13 07:16:54.972714 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Aug 13 07:16:54.972722 kernel: PCI: Using ACPI for IRQ routing Aug 13 07:16:54.972732 kernel: PCI: pci_cache_line_size set to 64 bytes Aug 13 07:16:54.972739 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Aug 13 07:16:54.972747 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Aug 13 07:16:54.972876 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Aug 13 07:16:54.972999 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Aug 13 07:16:54.973123 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Aug 13 07:16:54.973133 kernel: vgaarb: loaded Aug 13 07:16:54.973141 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Aug 13 07:16:54.973152 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Aug 13 07:16:54.973160 kernel: clocksource: Switched to clocksource kvm-clock Aug 13 07:16:54.973168 kernel: VFS: Disk quotas dquot_6.6.0 Aug 13 07:16:54.973175 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 13 07:16:54.973183 kernel: pnp: PnP ACPI init Aug 13 07:16:54.973335 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Aug 13 07:16:54.973347 kernel: pnp: PnP ACPI: found 6 devices Aug 13 07:16:54.973355 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Aug 13 07:16:54.973362 kernel: NET: Registered PF_INET protocol family Aug 13 07:16:54.973374 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 13 07:16:54.973382 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 13 07:16:54.973390 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 13 07:16:54.973397 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 13 07:16:54.973405 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 13 07:16:54.973412 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 13 07:16:54.973420 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 07:16:54.973428 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 07:16:54.973438 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 13 07:16:54.973445 kernel: NET: Registered PF_XDP protocol family Aug 13 07:16:54.973575 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Aug 13 07:16:54.973701 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Aug 13 07:16:54.973816 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Aug 13 07:16:54.973932 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Aug 13 07:16:54.974044 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Aug 13 07:16:54.974155 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Aug 13 07:16:54.974165 kernel: PCI: CLS 0 bytes, default 64 Aug 13 07:16:54.974178 kernel: Initialise system trusted keyrings Aug 13 07:16:54.974186 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 13 07:16:54.974193 kernel: Key type asymmetric registered Aug 13 07:16:54.974201 kernel: Asymmetric key parser 'x509' registered Aug 13 07:16:54.974208 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Aug 13 07:16:54.974216 kernel: io scheduler mq-deadline registered Aug 13 07:16:54.974224 kernel: io scheduler kyber registered Aug 13 07:16:54.974231 kernel: io scheduler bfq registered Aug 13 07:16:54.974239 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Aug 13 07:16:54.974249 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Aug 13 07:16:54.974257 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Aug 13 07:16:54.974265 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Aug 13 07:16:54.974273 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 13 07:16:54.974280 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Aug 13 07:16:54.974288 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Aug 13 07:16:54.974296 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Aug 13 07:16:54.974303 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Aug 13 07:16:54.974446 kernel: rtc_cmos 00:04: RTC can wake from S4 Aug 13 07:16:54.974461 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Aug 13 07:16:54.974619 kernel: rtc_cmos 00:04: registered as rtc0 Aug 13 07:16:54.974750 kernel: rtc_cmos 00:04: setting system clock to 2025-08-13T07:16:54 UTC (1755069414) Aug 13 07:16:54.974871 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Aug 13 07:16:54.974881 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Aug 13 07:16:54.974888 kernel: NET: Registered PF_INET6 protocol family Aug 13 07:16:54.974896 kernel: Segment Routing with IPv6 Aug 13 07:16:54.974904 kernel: In-situ OAM (IOAM) with IPv6 Aug 13 07:16:54.974916 kernel: NET: Registered PF_PACKET protocol family Aug 13 07:16:54.974924 kernel: Key type dns_resolver registered Aug 13 07:16:54.974931 kernel: IPI shorthand broadcast: enabled Aug 13 07:16:54.974939 kernel: sched_clock: Marking stable (1023003141, 136441377)->(1175325004, -15880486) Aug 13 07:16:54.974946 kernel: registered taskstats version 1 Aug 13 07:16:54.974954 kernel: Loading compiled-in X.509 certificates Aug 13 07:16:54.974962 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.100-flatcar: 264e720147fa8df9744bb9dc1c08171c0cb20041' Aug 13 07:16:54.974969 kernel: Key type .fscrypt registered Aug 13 07:16:54.974977 kernel: Key type fscrypt-provisioning registered Aug 13 07:16:54.974987 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 13 07:16:54.974995 kernel: ima: Allocated hash algorithm: sha1 Aug 13 07:16:54.975002 kernel: ima: No architecture policies found Aug 13 07:16:54.975010 kernel: clk: Disabling unused clocks Aug 13 07:16:54.975017 kernel: Freeing unused kernel image (initmem) memory: 42876K Aug 13 07:16:54.975025 kernel: Write protecting the kernel read-only data: 36864k Aug 13 07:16:54.975032 kernel: Freeing unused kernel image (rodata/data gap) memory: 1828K Aug 13 07:16:54.975040 kernel: Run /init as init process Aug 13 07:16:54.975047 kernel: with arguments: Aug 13 07:16:54.975058 kernel: /init Aug 13 07:16:54.975065 kernel: with environment: Aug 13 07:16:54.975072 kernel: HOME=/ Aug 13 07:16:54.975080 kernel: TERM=linux Aug 13 07:16:54.975087 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 13 07:16:54.975097 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 13 07:16:54.975107 systemd[1]: Detected virtualization kvm. Aug 13 07:16:54.975118 systemd[1]: Detected architecture x86-64. Aug 13 07:16:54.975126 systemd[1]: Running in initrd. Aug 13 07:16:54.975134 systemd[1]: No hostname configured, using default hostname. Aug 13 07:16:54.975142 systemd[1]: Hostname set to . Aug 13 07:16:54.975150 systemd[1]: Initializing machine ID from VM UUID. Aug 13 07:16:54.975158 systemd[1]: Queued start job for default target initrd.target. Aug 13 07:16:54.975166 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:16:54.975174 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:16:54.975186 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 13 07:16:54.975194 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 07:16:54.975215 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 13 07:16:54.975227 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 13 07:16:54.975237 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 13 07:16:54.975248 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 13 07:16:54.975256 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:16:54.975265 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:16:54.975273 systemd[1]: Reached target paths.target - Path Units. Aug 13 07:16:54.975282 systemd[1]: Reached target slices.target - Slice Units. Aug 13 07:16:54.975290 systemd[1]: Reached target swap.target - Swaps. Aug 13 07:16:54.975298 systemd[1]: Reached target timers.target - Timer Units. Aug 13 07:16:54.975307 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 07:16:54.975315 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 07:16:54.975326 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 13 07:16:54.975334 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 13 07:16:54.975343 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:16:54.975351 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 07:16:54.975360 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:16:54.975368 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 07:16:54.975376 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 13 07:16:54.975396 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 07:16:54.975416 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 13 07:16:54.975433 systemd[1]: Starting systemd-fsck-usr.service... Aug 13 07:16:54.975442 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 07:16:54.975450 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 07:16:54.975459 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:16:54.975467 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 13 07:16:54.975475 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:16:54.975483 systemd[1]: Finished systemd-fsck-usr.service. Aug 13 07:16:54.975516 systemd-journald[192]: Collecting audit messages is disabled. Aug 13 07:16:54.975538 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 07:16:54.975547 systemd-journald[192]: Journal started Aug 13 07:16:54.975582 systemd-journald[192]: Runtime Journal (/run/log/journal/606da99390804e0b9d7efa2810f1b871) is 6.0M, max 48.4M, 42.3M free. Aug 13 07:16:54.961649 systemd-modules-load[193]: Inserted module 'overlay' Aug 13 07:16:54.998286 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 13 07:16:54.998304 kernel: Bridge firewalling registered Aug 13 07:16:54.998315 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 07:16:54.989290 systemd-modules-load[193]: Inserted module 'br_netfilter' Aug 13 07:16:55.002955 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 07:16:55.004344 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:16:55.009983 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 07:16:55.023747 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:16:55.024636 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 07:16:55.025942 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 07:16:55.029748 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 07:16:55.039133 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:16:55.044136 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:16:55.048297 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:16:55.054706 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 07:16:55.055947 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:16:55.058018 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 13 07:16:55.075538 dracut-cmdline[231]: dracut-dracut-053 Aug 13 07:16:55.079064 dracut-cmdline[231]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=8b1c4c6202e70eaa8c6477427259ab5e403c8f1de8515605304942a21d23450a Aug 13 07:16:55.088813 systemd-resolved[228]: Positive Trust Anchors: Aug 13 07:16:55.088828 systemd-resolved[228]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 07:16:55.088859 systemd-resolved[228]: 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 Aug 13 07:16:55.091419 systemd-resolved[228]: Defaulting to hostname 'linux'. Aug 13 07:16:55.092564 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 07:16:55.098178 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:16:55.173592 kernel: SCSI subsystem initialized Aug 13 07:16:55.183587 kernel: Loading iSCSI transport class v2.0-870. Aug 13 07:16:55.195583 kernel: iscsi: registered transport (tcp) Aug 13 07:16:55.217582 kernel: iscsi: registered transport (qla4xxx) Aug 13 07:16:55.217616 kernel: QLogic iSCSI HBA Driver Aug 13 07:16:55.267909 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 13 07:16:55.283769 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 13 07:16:55.338958 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 13 07:16:55.339010 kernel: device-mapper: uevent: version 1.0.3 Aug 13 07:16:55.340051 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 13 07:16:55.382584 kernel: raid6: avx2x4 gen() 30553 MB/s Aug 13 07:16:55.440577 kernel: raid6: avx2x2 gen() 31089 MB/s Aug 13 07:16:55.457622 kernel: raid6: avx2x1 gen() 26053 MB/s Aug 13 07:16:55.457652 kernel: raid6: using algorithm avx2x2 gen() 31089 MB/s Aug 13 07:16:55.475645 kernel: raid6: .... xor() 19848 MB/s, rmw enabled Aug 13 07:16:55.475674 kernel: raid6: using avx2x2 recovery algorithm Aug 13 07:16:55.496583 kernel: xor: automatically using best checksumming function avx Aug 13 07:16:55.677605 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 13 07:16:55.691482 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 13 07:16:55.707776 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:16:55.719760 systemd-udevd[414]: Using default interface naming scheme 'v255'. Aug 13 07:16:55.735470 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:16:55.738965 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 13 07:16:55.759828 dracut-pre-trigger[427]: rd.md=0: removing MD RAID activation Aug 13 07:16:55.794234 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 07:16:55.802722 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 07:16:55.872483 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:16:55.881803 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 13 07:16:55.898271 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 13 07:16:55.901756 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 07:16:55.904313 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:16:55.907008 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 07:16:55.914082 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Aug 13 07:16:55.922318 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 13 07:16:55.932749 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:16:55.932765 kernel: cryptd: max_cpu_qlen set to 1000 Aug 13 07:16:55.914787 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 13 07:16:55.934160 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 13 07:16:55.939575 kernel: AVX2 version of gcm_enc/dec engaged. Aug 13 07:16:55.939597 kernel: AES CTR mode by8 optimization enabled Aug 13 07:16:55.958981 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 07:16:55.976592 kernel: libata version 3.00 loaded. Aug 13 07:16:55.978016 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:16:55.984581 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (474) Aug 13 07:16:55.984659 kernel: BTRFS: device fsid 6f4baebc-7e60-4ee7-93a9-8bedb08a33ad devid 1 transid 37 /dev/vda3 scanned by (udev-worker) (468) Aug 13 07:16:55.985842 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:16:55.988362 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:16:55.988569 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:16:55.988956 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:16:55.995288 kernel: ahci 0000:00:1f.2: version 3.0 Aug 13 07:16:55.995535 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Aug 13 07:16:55.997582 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Aug 13 07:16:55.997787 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Aug 13 07:16:56.002766 kernel: scsi host0: ahci Aug 13 07:16:56.002381 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:16:56.005232 kernel: scsi host1: ahci Aug 13 07:16:56.005407 kernel: scsi host2: ahci Aug 13 07:16:56.006011 kernel: scsi host3: ahci Aug 13 07:16:56.014669 kernel: scsi host4: ahci Aug 13 07:16:56.014914 kernel: scsi host5: ahci Aug 13 07:16:56.015167 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Aug 13 07:16:56.015185 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Aug 13 07:16:56.015196 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Aug 13 07:16:56.015206 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Aug 13 07:16:56.019237 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Aug 13 07:16:56.019261 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Aug 13 07:16:56.025547 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 13 07:16:56.058944 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 13 07:16:56.114604 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 13 07:16:56.117241 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:16:56.122878 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 13 07:16:56.122955 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 13 07:16:56.133695 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 13 07:16:56.135509 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:16:56.156795 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:16:56.324591 kernel: ata1: SATA link down (SStatus 0 SControl 300) Aug 13 07:16:56.332582 kernel: ata4: SATA link down (SStatus 0 SControl 300) Aug 13 07:16:56.332606 kernel: ata6: SATA link down (SStatus 0 SControl 300) Aug 13 07:16:56.333596 kernel: ata2: SATA link down (SStatus 0 SControl 300) Aug 13 07:16:56.333706 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Aug 13 07:16:56.334585 kernel: ata5: SATA link down (SStatus 0 SControl 300) Aug 13 07:16:56.335589 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Aug 13 07:16:56.336691 kernel: ata3.00: applying bridge limits Aug 13 07:16:56.336707 kernel: ata3.00: configured for UDMA/100 Aug 13 07:16:56.337593 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Aug 13 07:16:56.379600 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Aug 13 07:16:56.379973 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Aug 13 07:16:56.393583 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Aug 13 07:16:56.437601 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:16:56.646611 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:16:57.814217 disk-uuid[579]: The operation has completed successfully. Aug 13 07:16:57.815793 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:16:57.848949 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 13 07:16:57.849096 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 13 07:16:57.868764 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 13 07:16:57.872265 sh[593]: Success Aug 13 07:16:57.885606 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Aug 13 07:16:57.919608 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 13 07:16:57.929158 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 13 07:16:57.931872 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 13 07:16:57.945428 kernel: BTRFS info (device dm-0): first mount of filesystem 6f4baebc-7e60-4ee7-93a9-8bedb08a33ad Aug 13 07:16:57.945480 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:16:57.945494 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 13 07:16:57.945505 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 13 07:16:57.946168 kernel: BTRFS info (device dm-0): using free space tree Aug 13 07:16:57.951649 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 13 07:16:57.953482 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 13 07:16:57.961706 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 13 07:16:57.964126 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 13 07:16:57.974019 kernel: BTRFS info (device vda6): first mount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:16:57.974050 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:16:57.974061 kernel: BTRFS info (device vda6): using free space tree Aug 13 07:16:57.977805 kernel: BTRFS info (device vda6): auto enabling async discard Aug 13 07:16:57.987830 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 13 07:16:57.989290 kernel: BTRFS info (device vda6): last unmount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:16:58.082528 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 07:16:58.105715 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 07:16:58.121213 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 13 07:16:58.140824 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 13 07:16:58.144226 systemd-networkd[771]: lo: Link UP Aug 13 07:16:58.144240 systemd-networkd[771]: lo: Gained carrier Aug 13 07:16:58.145934 systemd-networkd[771]: Enumeration completed Aug 13 07:16:58.146089 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 07:16:58.146747 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:16:58.146751 systemd-networkd[771]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:16:58.150045 systemd-networkd[771]: eth0: Link UP Aug 13 07:16:58.150049 systemd-networkd[771]: eth0: Gained carrier Aug 13 07:16:58.150060 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:16:58.151149 systemd[1]: Reached target network.target - Network. Aug 13 07:16:58.204722 systemd-networkd[771]: eth0: DHCPv4 address 10.0.0.151/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 13 07:16:58.322122 ignition[774]: Ignition 2.19.0 Aug 13 07:16:58.322136 ignition[774]: Stage: fetch-offline Aug 13 07:16:58.322214 ignition[774]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:16:58.322230 ignition[774]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:16:58.322363 ignition[774]: parsed url from cmdline: "" Aug 13 07:16:58.322368 ignition[774]: no config URL provided Aug 13 07:16:58.322376 ignition[774]: reading system config file "/usr/lib/ignition/user.ign" Aug 13 07:16:58.322393 ignition[774]: no config at "/usr/lib/ignition/user.ign" Aug 13 07:16:58.322430 ignition[774]: op(1): [started] loading QEMU firmware config module Aug 13 07:16:58.322437 ignition[774]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 13 07:16:58.331917 ignition[774]: op(1): [finished] loading QEMU firmware config module Aug 13 07:16:58.333291 ignition[774]: parsing config with SHA512: 28db601d65fac8ecace6aaad4f470123fd69f3398ba9a84cb9560c8c701bbd3740557bb638cc3a65afc68793832442aa1b87d0cfcd076a473e55bc40ad020602 Aug 13 07:16:58.339253 unknown[774]: fetched base config from "system" Aug 13 07:16:58.339368 unknown[774]: fetched user config from "qemu" Aug 13 07:16:58.339538 ignition[774]: fetch-offline: fetch-offline passed Aug 13 07:16:58.339660 ignition[774]: Ignition finished successfully Aug 13 07:16:58.344690 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 07:16:58.344950 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 13 07:16:58.353811 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 13 07:16:58.379829 ignition[785]: Ignition 2.19.0 Aug 13 07:16:58.379842 ignition[785]: Stage: kargs Aug 13 07:16:58.380021 ignition[785]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:16:58.380034 ignition[785]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:16:58.380638 ignition[785]: kargs: kargs passed Aug 13 07:16:58.380687 ignition[785]: Ignition finished successfully Aug 13 07:16:58.388033 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 13 07:16:58.400729 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 13 07:16:58.414303 ignition[793]: Ignition 2.19.0 Aug 13 07:16:58.414315 ignition[793]: Stage: disks Aug 13 07:16:58.414485 ignition[793]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:16:58.414497 ignition[793]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:16:58.417925 ignition[793]: disks: disks passed Aug 13 07:16:58.417976 ignition[793]: Ignition finished successfully Aug 13 07:16:58.420810 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 13 07:16:58.422026 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 13 07:16:58.423767 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 13 07:16:58.423830 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 07:16:58.424146 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 07:16:58.424475 systemd[1]: Reached target basic.target - Basic System. Aug 13 07:16:58.444741 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 13 07:16:58.460615 systemd-fsck[803]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 13 07:16:58.471230 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 13 07:16:58.476727 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 13 07:16:58.563589 kernel: EXT4-fs (vda9): mounted filesystem 98cc0201-e9ec-4d2c-8a62-5b521bf9317d r/w with ordered data mode. Quota mode: none. Aug 13 07:16:58.564312 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 13 07:16:58.565779 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 13 07:16:58.581655 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 07:16:58.583536 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 13 07:16:58.584726 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 13 07:16:58.584765 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 13 07:16:58.595281 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (811) Aug 13 07:16:58.595302 kernel: BTRFS info (device vda6): first mount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:16:58.595313 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:16:58.595323 kernel: BTRFS info (device vda6): using free space tree Aug 13 07:16:58.584786 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 07:16:58.597716 kernel: BTRFS info (device vda6): auto enabling async discard Aug 13 07:16:58.591080 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 13 07:16:58.596211 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 13 07:16:58.601412 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 07:16:58.637164 initrd-setup-root[835]: cut: /sysroot/etc/passwd: No such file or directory Aug 13 07:16:58.641879 initrd-setup-root[842]: cut: /sysroot/etc/group: No such file or directory Aug 13 07:16:58.645728 initrd-setup-root[849]: cut: /sysroot/etc/shadow: No such file or directory Aug 13 07:16:58.650407 initrd-setup-root[856]: cut: /sysroot/etc/gshadow: No such file or directory Aug 13 07:16:58.736854 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 13 07:16:58.745782 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 13 07:16:58.747568 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 13 07:16:58.754582 kernel: BTRFS info (device vda6): last unmount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:16:58.772363 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 13 07:16:58.863528 ignition[924]: INFO : Ignition 2.19.0 Aug 13 07:16:58.863528 ignition[924]: INFO : Stage: mount Aug 13 07:16:58.865438 ignition[924]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:16:58.865438 ignition[924]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:16:58.865438 ignition[924]: INFO : mount: mount passed Aug 13 07:16:58.865438 ignition[924]: INFO : Ignition finished successfully Aug 13 07:16:58.869517 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 13 07:16:58.882694 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 13 07:16:58.943957 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 13 07:16:58.980737 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 07:16:58.987587 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (936) Aug 13 07:16:58.991025 kernel: BTRFS info (device vda6): first mount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:16:58.991047 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:16:58.991066 kernel: BTRFS info (device vda6): using free space tree Aug 13 07:16:58.994590 kernel: BTRFS info (device vda6): auto enabling async discard Aug 13 07:16:58.995534 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 07:16:59.024346 ignition[953]: INFO : Ignition 2.19.0 Aug 13 07:16:59.024346 ignition[953]: INFO : Stage: files Aug 13 07:16:59.025994 ignition[953]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:16:59.025994 ignition[953]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:16:59.025994 ignition[953]: DEBUG : files: compiled without relabeling support, skipping Aug 13 07:16:59.029704 ignition[953]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 13 07:16:59.029704 ignition[953]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 13 07:16:59.033095 ignition[953]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 13 07:16:59.034519 ignition[953]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 13 07:16:59.036177 unknown[953]: wrote ssh authorized keys file for user: core Aug 13 07:16:59.065169 ignition[953]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 13 07:16:59.066601 ignition[953]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 07:16:59.068422 ignition[953]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(4): [started] processing unit "etcd-member.service" Aug 13 07:16:59.068422 ignition[953]: 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" Aug 13 07:16:59.068422 ignition[953]: 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" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Aug 13 07:16:59.068422 ignition[953]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Aug 13 07:16:59.096362 ignition[953]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 13 07:16:59.108617 ignition[953]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 13 07:16:59.110236 ignition[953]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Aug 13 07:16:59.110236 ignition[953]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Aug 13 07:16:59.112904 ignition[953]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Aug 13 07:16:59.114366 ignition[953]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 13 07:16:59.116068 ignition[953]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 13 07:16:59.117676 ignition[953]: INFO : files: files passed Aug 13 07:16:59.118411 ignition[953]: INFO : Ignition finished successfully Aug 13 07:16:59.121531 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 13 07:16:59.129828 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 13 07:16:59.132923 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 13 07:16:59.135587 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 13 07:16:59.136547 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 13 07:16:59.143187 initrd-setup-root-after-ignition[982]: grep: /sysroot/oem/oem-release: No such file or directory Aug 13 07:16:59.147403 initrd-setup-root-after-ignition[984]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:16:59.147403 initrd-setup-root-after-ignition[984]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:16:59.150473 initrd-setup-root-after-ignition[988]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:16:59.153389 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 07:16:59.154936 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 13 07:16:59.163763 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 13 07:16:59.189025 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 13 07:16:59.189151 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 13 07:16:59.190253 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 13 07:16:59.192306 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 13 07:16:59.195097 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 13 07:16:59.195881 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 13 07:16:59.215141 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 07:16:59.227711 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 13 07:16:59.239276 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:16:59.239415 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:16:59.241520 systemd[1]: Stopped target timers.target - Timer Units. Aug 13 07:16:59.243645 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 13 07:16:59.243751 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 07:16:59.248331 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 13 07:16:59.248460 systemd[1]: Stopped target basic.target - Basic System. Aug 13 07:16:59.250390 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 13 07:16:59.252030 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 07:16:59.252339 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 13 07:16:59.252833 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 13 07:16:59.257843 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 07:16:59.258163 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 13 07:16:59.261815 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 13 07:16:59.262115 systemd[1]: Stopped target swap.target - Swaps. Aug 13 07:16:59.262406 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 13 07:16:59.262520 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 13 07:16:59.269410 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:16:59.269543 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:16:59.271455 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 13 07:16:59.273545 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:16:59.274494 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 13 07:16:59.274641 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 13 07:16:59.275290 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 13 07:16:59.275397 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 07:16:59.279686 systemd[1]: Stopped target paths.target - Path Units. Aug 13 07:16:59.281580 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 13 07:16:59.286681 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:16:59.289469 systemd[1]: Stopped target slices.target - Slice Units. Aug 13 07:16:59.291304 systemd[1]: Stopped target sockets.target - Socket Units. Aug 13 07:16:59.293186 systemd[1]: iscsid.socket: Deactivated successfully. Aug 13 07:16:59.294077 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 07:16:59.296023 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 13 07:16:59.296908 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 07:16:59.298960 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 13 07:16:59.300156 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 07:16:59.302677 systemd[1]: ignition-files.service: Deactivated successfully. Aug 13 07:16:59.303655 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 13 07:16:59.315719 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 13 07:16:59.317576 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 13 07:16:59.318606 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:16:59.321787 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 13 07:16:59.323604 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 13 07:16:59.324644 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:16:59.327065 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 13 07:16:59.328239 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 07:16:59.331219 ignition[1008]: INFO : Ignition 2.19.0 Aug 13 07:16:59.331219 ignition[1008]: INFO : Stage: umount Aug 13 07:16:59.331219 ignition[1008]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:16:59.331219 ignition[1008]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:16:59.335122 ignition[1008]: INFO : umount: umount passed Aug 13 07:16:59.335122 ignition[1008]: INFO : Ignition finished successfully Aug 13 07:16:59.337415 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 13 07:16:59.338397 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 13 07:16:59.342263 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 13 07:16:59.343246 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 13 07:16:59.346295 systemd[1]: Stopped target network.target - Network. Aug 13 07:16:59.348027 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 13 07:16:59.348097 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 13 07:16:59.351181 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 13 07:16:59.351238 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 13 07:16:59.354021 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 13 07:16:59.354936 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 13 07:16:59.356935 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 13 07:16:59.356997 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 13 07:16:59.360139 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 13 07:16:59.362327 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 13 07:16:59.363597 systemd-networkd[771]: eth0: DHCPv6 lease lost Aug 13 07:16:59.366411 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 13 07:16:59.367857 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 13 07:16:59.368894 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 13 07:16:59.371501 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 13 07:16:59.371640 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 13 07:16:59.374428 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 13 07:16:59.375497 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 13 07:16:59.380540 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 13 07:16:59.380617 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:16:59.383613 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 13 07:16:59.383674 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 13 07:16:59.392749 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 13 07:16:59.393685 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 13 07:16:59.393766 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 07:16:59.395910 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 13 07:16:59.395963 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:16:59.398042 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 13 07:16:59.398096 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 13 07:16:59.399301 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 13 07:16:59.399364 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:16:59.399884 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:16:59.412706 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 13 07:16:59.412851 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 13 07:16:59.426617 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 13 07:16:59.426838 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:16:59.430318 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 13 07:16:59.430383 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 13 07:16:59.430799 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 13 07:16:59.430838 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:16:59.431088 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 13 07:16:59.431148 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 13 07:16:59.431879 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 13 07:16:59.431932 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 13 07:16:59.432540 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 07:16:59.432684 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:16:59.444870 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 13 07:16:59.445932 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 13 07:16:59.445999 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:16:59.448247 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:16:59.448304 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:16:59.462082 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 13 07:16:59.462211 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 13 07:16:59.463411 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 13 07:16:59.484687 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 13 07:16:59.494546 systemd[1]: Switching root. Aug 13 07:16:59.532284 systemd-journald[192]: Journal stopped Aug 13 07:17:00.617878 systemd-journald[192]: Received SIGTERM from PID 1 (systemd). Aug 13 07:17:00.617954 kernel: SELinux: policy capability network_peer_controls=1 Aug 13 07:17:00.617979 kernel: SELinux: policy capability open_perms=1 Aug 13 07:17:00.617997 kernel: SELinux: policy capability extended_socket_class=1 Aug 13 07:17:00.618009 kernel: SELinux: policy capability always_check_network=0 Aug 13 07:17:00.618020 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 13 07:17:00.618032 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 13 07:17:00.618047 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 13 07:17:00.618059 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 13 07:17:00.618070 kernel: audit: type=1403 audit(1755069419.647:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 13 07:17:00.618082 systemd[1]: Successfully loaded SELinux policy in 40.654ms. Aug 13 07:17:00.618104 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 15.852ms. Aug 13 07:17:00.618117 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 13 07:17:00.618130 systemd[1]: Detected virtualization kvm. Aug 13 07:17:00.618147 systemd[1]: Detected architecture x86-64. Aug 13 07:17:00.618159 systemd[1]: Detected first boot. Aug 13 07:17:00.618174 systemd[1]: Initializing machine ID from VM UUID. Aug 13 07:17:00.618186 zram_generator::config[1054]: No configuration found. Aug 13 07:17:00.618200 systemd[1]: Populated /etc with preset unit settings. Aug 13 07:17:00.618212 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 13 07:17:00.618224 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 13 07:17:00.618236 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 13 07:17:00.618248 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 13 07:17:00.618260 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 13 07:17:00.618280 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 13 07:17:00.618292 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 13 07:17:00.618305 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 13 07:17:00.618319 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 13 07:17:00.618332 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 13 07:17:00.618346 systemd[1]: Created slice user.slice - User and Session Slice. Aug 13 07:17:00.618358 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:17:00.618370 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:17:00.618382 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 13 07:17:00.618394 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 13 07:17:00.618407 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 13 07:17:00.618419 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 07:17:00.618432 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Aug 13 07:17:00.618443 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:17:00.618458 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 13 07:17:00.618470 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 13 07:17:00.618482 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 13 07:17:00.618494 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 13 07:17:00.618506 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:17:00.618527 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 07:17:00.618545 systemd[1]: Reached target slices.target - Slice Units. Aug 13 07:17:00.618581 systemd[1]: Reached target swap.target - Swaps. Aug 13 07:17:00.618597 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 13 07:17:00.618609 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 13 07:17:00.618621 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:17:00.618633 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 07:17:00.618645 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:17:00.618657 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 13 07:17:00.618668 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 13 07:17:00.618680 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 13 07:17:00.618692 systemd[1]: Mounting media.mount - External Media Directory... Aug 13 07:17:00.618707 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:17:00.618719 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 13 07:17:00.618730 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 13 07:17:00.618743 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 13 07:17:00.618755 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). Aug 13 07:17:00.618768 systemd[1]: Reached target machines.target - Containers. Aug 13 07:17:00.618780 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 13 07:17:00.618792 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:17:00.618807 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 07:17:00.618819 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 13 07:17:00.618831 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:17:00.618848 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 07:17:00.618860 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:17:00.619884 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 13 07:17:00.619907 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:17:00.619920 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 13 07:17:00.619932 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 13 07:17:00.619950 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 13 07:17:00.619963 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 13 07:17:00.619975 systemd[1]: Stopped systemd-fsck-usr.service. Aug 13 07:17:00.619987 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 07:17:00.619999 kernel: fuse: init (API version 7.39) Aug 13 07:17:00.620010 kernel: loop: module loaded Aug 13 07:17:00.620021 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 07:17:00.620034 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 13 07:17:00.620046 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 13 07:17:00.620061 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 07:17:00.620073 systemd[1]: verity-setup.service: Deactivated successfully. Aug 13 07:17:00.620085 systemd[1]: Stopped verity-setup.service. Aug 13 07:17:00.620097 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:17:00.620109 kernel: ACPI: bus type drm_connector registered Aug 13 07:17:00.620140 systemd-journald[1124]: Collecting audit messages is disabled. Aug 13 07:17:00.620173 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 13 07:17:00.620189 systemd-journald[1124]: Journal started Aug 13 07:17:00.620210 systemd-journald[1124]: Runtime Journal (/run/log/journal/606da99390804e0b9d7efa2810f1b871) is 6.0M, max 48.4M, 42.3M free. Aug 13 07:17:00.269783 systemd[1]: Queued start job for default target multi-user.target. Aug 13 07:17:00.289150 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 13 07:17:00.289665 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 13 07:17:00.621621 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 07:17:00.623773 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 13 07:17:00.625177 systemd[1]: Mounted media.mount - External Media Directory. Aug 13 07:17:00.626436 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 13 07:17:00.627761 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 13 07:17:00.629021 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 13 07:17:00.630290 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 13 07:17:00.631849 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:17:00.633485 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 13 07:17:00.633717 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 13 07:17:00.635353 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:17:00.635548 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:17:00.637135 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 07:17:00.637313 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 07:17:00.638763 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:17:00.638947 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:17:00.640585 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 13 07:17:00.640769 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 13 07:17:00.642249 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:17:00.642427 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:17:00.643858 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 07:17:00.645359 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 13 07:17:00.647173 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 13 07:17:00.664851 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 13 07:17:00.673658 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 13 07:17:00.676209 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 13 07:17:00.677449 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 13 07:17:00.677586 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 07:17:00.679726 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 13 07:17:00.682268 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 13 07:17:00.686458 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 13 07:17:00.687788 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:17:00.689534 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 13 07:17:00.695460 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 13 07:17:00.697461 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 07:17:00.700885 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 13 07:17:00.703708 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 07:17:00.705027 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 07:17:00.708845 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 13 07:17:00.712033 systemd-journald[1124]: Time spent on flushing to /var/log/journal/606da99390804e0b9d7efa2810f1b871 is 125.124ms for 921 entries. Aug 13 07:17:00.712033 systemd-journald[1124]: System Journal (/var/log/journal/606da99390804e0b9d7efa2810f1b871) is 8.0M, max 195.6M, 187.6M free. Aug 13 07:17:00.861855 systemd-journald[1124]: Received client request to flush runtime journal. Aug 13 07:17:00.861900 kernel: loop0: detected capacity change from 0 to 142488 Aug 13 07:17:00.861917 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 13 07:17:00.712042 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 13 07:17:00.717487 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 13 07:17:00.718930 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 13 07:17:00.720619 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 13 07:17:00.750650 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:17:00.847844 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 13 07:17:00.850404 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 13 07:17:00.851967 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:17:00.854829 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 13 07:17:00.861797 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 13 07:17:00.863651 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 13 07:17:00.886878 udevadm[1178]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 13 07:17:00.896586 kernel: loop1: detected capacity change from 0 to 140768 Aug 13 07:17:00.911162 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 13 07:17:00.925744 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 07:17:00.928503 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 13 07:17:00.929877 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 13 07:17:00.937598 kernel: loop2: detected capacity change from 0 to 142488 Aug 13 07:17:00.952588 kernel: loop3: detected capacity change from 0 to 140768 Aug 13 07:17:00.958380 systemd-tmpfiles[1187]: ACLs are not supported, ignoring. Aug 13 07:17:00.958406 systemd-tmpfiles[1187]: ACLs are not supported, ignoring. Aug 13 07:17:00.962199 (sd-merge)[1190]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 13 07:17:00.962934 (sd-merge)[1190]: Merged extensions into '/usr'. Aug 13 07:17:00.969276 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 13 07:17:00.971195 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:17:01.000434 systemd[1]: Starting ensure-sysext.service... Aug 13 07:17:01.005159 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 07:17:01.016832 systemd[1]: Reloading requested from client PID 1193 ('systemctl') (unit ensure-sysext.service)... Aug 13 07:17:01.017061 systemd[1]: Reloading... Aug 13 07:17:01.034709 systemd-tmpfiles[1194]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 13 07:17:01.035130 systemd-tmpfiles[1194]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 13 07:17:01.037000 systemd-tmpfiles[1194]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 13 07:17:01.037491 systemd-tmpfiles[1194]: ACLs are not supported, ignoring. Aug 13 07:17:01.037667 systemd-tmpfiles[1194]: ACLs are not supported, ignoring. Aug 13 07:17:01.043850 systemd-tmpfiles[1194]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 07:17:01.043862 systemd-tmpfiles[1194]: Skipping /boot Aug 13 07:17:01.063362 systemd-tmpfiles[1194]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 07:17:01.063380 systemd-tmpfiles[1194]: Skipping /boot Aug 13 07:17:01.113600 zram_generator::config[1221]: No configuration found. Aug 13 07:17:01.299766 ldconfig[1163]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 13 07:17:01.302352 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. Aug 13 07:17:01.353162 systemd[1]: Reloading finished in 335 ms. Aug 13 07:17:01.388484 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 13 07:17:01.391484 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:17:01.409075 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 13 07:17:01.414745 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 13 07:17:01.420305 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 13 07:17:01.424541 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 07:17:01.428226 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 13 07:17:01.433250 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:17:01.433968 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:17:01.435529 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:17:01.445841 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:17:01.450296 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:17:01.451466 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:17:01.451608 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:17:01.452754 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:17:01.453315 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:17:01.455245 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:17:01.455536 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:17:01.618401 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 13 07:17:01.620372 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 13 07:17:01.622484 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:17:01.622719 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:17:01.631519 augenrules[1289]: No rules Aug 13 07:17:01.633227 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 13 07:17:01.634812 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 13 07:17:01.639916 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:17:01.640224 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:17:01.645917 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:17:01.648821 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 07:17:01.651236 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:17:01.656753 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:17:01.659818 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:17:01.663848 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 13 07:17:01.664887 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). Aug 13 07:17:01.664931 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:17:01.665966 systemd[1]: Finished ensure-sysext.service. Aug 13 07:17:01.667450 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:17:01.667736 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:17:01.670660 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 07:17:01.670920 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 07:17:01.672452 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:17:01.672754 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:17:01.674508 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:17:01.674791 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:17:01.681764 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 07:17:01.681860 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 07:17:01.696891 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 13 07:17:01.878430 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 13 07:17:01.953364 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 13 07:17:01.954833 systemd[1]: Reached target time-set.target - System Time Set. Aug 13 07:17:01.962766 systemd-resolved[1266]: Positive Trust Anchors: Aug 13 07:17:01.962789 systemd-resolved[1266]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 07:17:01.962823 systemd-resolved[1266]: 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 Aug 13 07:17:02.006204 systemd-resolved[1266]: Defaulting to hostname 'linux'. Aug 13 07:17:02.008406 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 07:17:02.009713 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:17:02.074985 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 13 07:17:02.085161 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:17:02.087963 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 13 07:17:02.105165 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 13 07:17:02.115608 systemd-udevd[1315]: Using default interface naming scheme 'v255'. Aug 13 07:17:02.134702 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:17:02.144936 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 07:17:02.213579 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1332) Aug 13 07:17:02.218595 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Aug 13 07:17:02.257367 systemd-networkd[1322]: lo: Link UP Aug 13 07:17:02.257379 systemd-networkd[1322]: lo: Gained carrier Aug 13 07:17:02.259858 systemd-networkd[1322]: Enumeration completed Aug 13 07:17:02.259980 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 07:17:02.261807 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:17:02.261820 systemd-networkd[1322]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:17:02.262246 systemd[1]: Reached target network.target - Network. Aug 13 07:17:02.264240 systemd-networkd[1322]: eth0: Link UP Aug 13 07:17:02.264259 systemd-networkd[1322]: eth0: Gained carrier Aug 13 07:17:02.264287 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:17:02.271869 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 13 07:17:02.281738 systemd-networkd[1322]: eth0: DHCPv4 address 10.0.0.151/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 13 07:17:02.285947 systemd-timesyncd[1306]: Network configuration changed, trying to establish connection. Aug 13 07:17:02.287231 systemd-timesyncd[1306]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 13 07:17:02.287312 systemd-timesyncd[1306]: Initial clock synchronization to Wed 2025-08-13 07:17:02.410036 UTC. Aug 13 07:17:02.296943 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 13 07:17:02.297309 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:17:02.306578 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Aug 13 07:17:02.311590 kernel: ACPI: button: Power Button [PWRF] Aug 13 07:17:02.311655 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Aug 13 07:17:02.312966 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Aug 13 07:17:02.313264 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Aug 13 07:17:02.315878 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 13 07:17:02.326589 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Aug 13 07:17:02.345550 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 13 07:17:02.506745 kernel: mousedev: PS/2 mouse device common for all mice Aug 13 07:17:02.506580 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:17:02.522826 kernel: kvm_amd: TSC scaling supported Aug 13 07:17:02.522920 kernel: kvm_amd: Nested Virtualization enabled Aug 13 07:17:02.522941 kernel: kvm_amd: Nested Paging enabled Aug 13 07:17:02.523973 kernel: kvm_amd: LBR virtualization supported Aug 13 07:17:02.524069 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Aug 13 07:17:02.524609 kernel: kvm_amd: Virtual GIF supported Aug 13 07:17:02.551771 kernel: EDAC MC: Ver: 3.0.0 Aug 13 07:17:02.583068 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 13 07:17:02.619626 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 13 07:17:02.621379 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:17:02.630662 lvm[1362]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 07:17:02.671189 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 13 07:17:02.673247 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:17:02.674630 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 07:17:02.675982 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 13 07:17:02.677508 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 13 07:17:02.679219 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 13 07:17:02.680680 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 13 07:17:02.682232 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 13 07:17:02.683756 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 13 07:17:02.683785 systemd[1]: Reached target paths.target - Path Units. Aug 13 07:17:02.684876 systemd[1]: Reached target timers.target - Timer Units. Aug 13 07:17:02.686987 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 13 07:17:02.689954 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 13 07:17:02.700307 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 13 07:17:02.703211 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 13 07:17:02.705068 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 13 07:17:02.706473 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 07:17:02.707644 systemd[1]: Reached target basic.target - Basic System. Aug 13 07:17:02.708820 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 13 07:17:02.708846 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 13 07:17:02.709922 systemd[1]: Starting containerd.service - containerd container runtime... Aug 13 07:17:02.712300 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 13 07:17:02.716902 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 13 07:17:02.721279 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 13 07:17:02.722785 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). Aug 13 07:17:02.724848 jq[1370]: false Aug 13 07:17:02.725856 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 13 07:17:02.726261 lvm[1367]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 07:17:02.730737 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 13 07:17:02.734739 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 13 07:17:02.742650 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 13 07:17:02.744615 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 13 07:17:02.745770 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 13 07:17:02.746800 systemd[1]: Starting update-engine.service - Update Engine... Aug 13 07:17:02.750762 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 13 07:17:02.753161 extend-filesystems[1371]: Found loop2 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found loop3 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found sr0 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda1 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda2 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda3 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found usr Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda4 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda6 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda7 Aug 13 07:17:02.804860 extend-filesystems[1371]: Found vda9 Aug 13 07:17:02.804860 extend-filesystems[1371]: Checking size of /dev/vda9 Aug 13 07:17:02.817112 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 13 07:17:02.818364 jq[1381]: true Aug 13 07:17:02.820264 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 13 07:17:02.820479 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 13 07:17:02.820834 systemd[1]: motdgen.service: Deactivated successfully. Aug 13 07:17:02.821032 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 13 07:17:02.822624 dbus-daemon[1369]: [system] SELinux support is enabled Aug 13 07:17:02.823824 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 13 07:17:02.824086 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 13 07:17:02.825704 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 13 07:17:02.829499 update_engine[1378]: I20250813 07:17:02.829386 1378 main.cc:92] Flatcar Update Engine starting Aug 13 07:17:02.830575 extend-filesystems[1371]: Old size kept for /dev/vda9 Aug 13 07:17:02.830944 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 13 07:17:02.831249 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 13 07:17:02.833583 update_engine[1378]: I20250813 07:17:02.832475 1378 update_check_scheduler.cc:74] Next update check in 3m10s Aug 13 07:17:02.884641 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1323) Aug 13 07:17:02.894764 (ntainerd)[1394]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 13 07:17:02.897680 jq[1392]: true Aug 13 07:17:02.919732 systemd-logind[1376]: Watching system buttons on /dev/input/event1 (Power Button) Aug 13 07:17:02.919763 systemd-logind[1376]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Aug 13 07:17:02.921226 systemd[1]: Started update-engine.service - Update Engine. Aug 13 07:17:02.923492 systemd-logind[1376]: New seat seat0. Aug 13 07:17:02.927245 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). Aug 13 07:17:02.927288 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 13 07:17:02.932169 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). Aug 13 07:17:02.932197 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 13 07:17:02.940765 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 13 07:17:02.983909 systemd[1]: Started systemd-logind.service - User Login Management. Aug 13 07:17:03.021466 bash[1419]: Updated "/home/core/.ssh/authorized_keys" Aug 13 07:17:03.024687 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 13 07:17:03.120527 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 13 07:17:03.135374 locksmithd[1418]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 13 07:17:03.210901 sshd_keygen[1387]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 13 07:17:03.250678 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 13 07:17:03.262873 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 13 07:17:03.272865 systemd[1]: issuegen.service: Deactivated successfully. Aug 13 07:17:03.273139 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 13 07:17:03.297043 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 13 07:17:03.326733 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 13 07:17:03.343010 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 13 07:17:03.345874 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Aug 13 07:17:03.347475 systemd[1]: Reached target getty.target - Login Prompts. Aug 13 07:17:03.443902 containerd[1394]: time="2025-08-13T07:17:03.443769924Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Aug 13 07:17:03.477765 containerd[1394]: time="2025-08-13T07:17:03.477699273Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.480886 containerd[1394]: time="2025-08-13T07:17:03.480787031Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.100-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:17:03.480886 containerd[1394]: time="2025-08-13T07:17:03.480854279Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 13 07:17:03.480886 containerd[1394]: time="2025-08-13T07:17:03.480885010Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 13 07:17:03.481303 containerd[1394]: time="2025-08-13T07:17:03.481255990Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 13 07:17:03.481303 containerd[1394]: time="2025-08-13T07:17:03.481297615Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.481504 containerd[1394]: time="2025-08-13T07:17:03.481465588Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:17:03.481504 containerd[1394]: time="2025-08-13T07:17:03.481495927Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.481941 containerd[1394]: time="2025-08-13T07:17:03.481891086Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:17:03.481941 containerd[1394]: time="2025-08-13T07:17:03.481926078Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.482011 containerd[1394]: time="2025-08-13T07:17:03.481941736Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:17:03.482011 containerd[1394]: time="2025-08-13T07:17:03.481962544Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.482148 containerd[1394]: time="2025-08-13T07:17:03.482106338Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.482501 containerd[1394]: time="2025-08-13T07:17:03.482463901Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:17:03.482660 containerd[1394]: time="2025-08-13T07:17:03.482629007Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:17:03.482660 containerd[1394]: time="2025-08-13T07:17:03.482648563Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 13 07:17:03.482839 containerd[1394]: time="2025-08-13T07:17:03.482799515Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 13 07:17:03.482937 containerd[1394]: time="2025-08-13T07:17:03.482908499Z" level=info msg="metadata content store policy set" policy=shared Aug 13 07:17:03.489390 containerd[1394]: time="2025-08-13T07:17:03.489350250Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 13 07:17:03.489457 containerd[1394]: time="2025-08-13T07:17:03.489436185Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 13 07:17:03.489495 containerd[1394]: time="2025-08-13T07:17:03.489471823Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 13 07:17:03.489542 containerd[1394]: time="2025-08-13T07:17:03.489497467Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 13 07:17:03.489583 containerd[1394]: time="2025-08-13T07:17:03.489539566Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 13 07:17:03.489783 containerd[1394]: time="2025-08-13T07:17:03.489725602Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 13 07:17:03.492861 containerd[1394]: time="2025-08-13T07:17:03.492788220Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 13 07:17:03.493390 containerd[1394]: time="2025-08-13T07:17:03.493330819Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 13 07:17:03.493449 containerd[1394]: time="2025-08-13T07:17:03.493413594Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 13 07:17:03.493471 containerd[1394]: time="2025-08-13T07:17:03.493446617Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 13 07:17:03.493491 containerd[1394]: time="2025-08-13T07:17:03.493473452Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493543 containerd[1394]: time="2025-08-13T07:17:03.493509636Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493578 containerd[1394]: time="2025-08-13T07:17:03.493542900Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493650 containerd[1394]: time="2025-08-13T07:17:03.493613612Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493685 containerd[1394]: time="2025-08-13T07:17:03.493649885Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493685 containerd[1394]: time="2025-08-13T07:17:03.493674913Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493746 containerd[1394]: time="2025-08-13T07:17:03.493697063Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493784 containerd[1394]: time="2025-08-13T07:17:03.493764403Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 13 07:17:03.493887 containerd[1394]: time="2025-08-13T07:17:03.493836193Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.493975 containerd[1394]: time="2025-08-13T07:17:03.493935617Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494023 containerd[1394]: time="2025-08-13T07:17:03.493993002Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494087 containerd[1394]: time="2025-08-13T07:17:03.494031598Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494162 containerd[1394]: time="2025-08-13T07:17:03.494105579Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494203 containerd[1394]: time="2025-08-13T07:17:03.494165953Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494261 containerd[1394]: time="2025-08-13T07:17:03.494234675Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494286 containerd[1394]: time="2025-08-13T07:17:03.494269778Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494349 containerd[1394]: time="2025-08-13T07:17:03.494319933Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494579 containerd[1394]: time="2025-08-13T07:17:03.494529471Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494654 containerd[1394]: time="2025-08-13T07:17:03.494606684Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494688 containerd[1394]: time="2025-08-13T07:17:03.494660050Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494709 containerd[1394]: time="2025-08-13T07:17:03.494691550Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.494770 containerd[1394]: time="2025-08-13T07:17:03.494720646Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 13 07:17:03.495033 containerd[1394]: time="2025-08-13T07:17:03.494978805Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.495077 containerd[1394]: time="2025-08-13T07:17:03.495045205Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.495165 containerd[1394]: time="2025-08-13T07:17:03.495122710Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 13 07:17:03.495339 containerd[1394]: time="2025-08-13T07:17:03.495299357Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 13 07:17:03.495392 containerd[1394]: time="2025-08-13T07:17:03.495355903Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 13 07:17:03.495392 containerd[1394]: time="2025-08-13T07:17:03.495383263Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 13 07:17:03.495433 containerd[1394]: time="2025-08-13T07:17:03.495405685Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 13 07:17:03.495433 containerd[1394]: time="2025-08-13T07:17:03.495423475Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.495470 containerd[1394]: time="2025-08-13T07:17:03.495449259Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 13 07:17:03.495502 containerd[1394]: time="2025-08-13T07:17:03.495473550Z" level=info msg="NRI interface is disabled by configuration." Aug 13 07:17:03.495502 containerd[1394]: time="2025-08-13T07:17:03.495492731Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 13 07:17:03.496257 containerd[1394]: time="2025-08-13T07:17:03.496131361Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Aug 13 07:17:03.496257 containerd[1394]: time="2025-08-13T07:17:03.496297447Z" level=info msg="Connect containerd service" Aug 13 07:17:03.496653 containerd[1394]: time="2025-08-13T07:17:03.496395780Z" level=info msg="using legacy CRI server" Aug 13 07:17:03.496653 containerd[1394]: time="2025-08-13T07:17:03.496432679Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 13 07:17:03.496708 containerd[1394]: time="2025-08-13T07:17:03.496671456Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 13 07:17:03.497693 containerd[1394]: time="2025-08-13T07:17:03.497654846Z" 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" Aug 13 07:17:03.497954 containerd[1394]: time="2025-08-13T07:17:03.497835430Z" level=info msg="Start subscribing containerd event" Aug 13 07:17:03.498019 containerd[1394]: time="2025-08-13T07:17:03.497980940Z" level=info msg="Start recovering state" Aug 13 07:17:03.498190 containerd[1394]: time="2025-08-13T07:17:03.498078910Z" level=info msg="Start event monitor" Aug 13 07:17:03.498190 containerd[1394]: time="2025-08-13T07:17:03.498115779Z" level=info msg="Start snapshots syncer" Aug 13 07:17:03.498190 containerd[1394]: time="2025-08-13T07:17:03.498133356Z" level=info msg="Start cni network conf syncer for default" Aug 13 07:17:03.498190 containerd[1394]: time="2025-08-13T07:17:03.498141473Z" level=info msg="Start streaming server" Aug 13 07:17:03.498377 containerd[1394]: time="2025-08-13T07:17:03.498348265Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 13 07:17:03.498538 containerd[1394]: time="2025-08-13T07:17:03.498462034Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 13 07:17:03.498953 containerd[1394]: time="2025-08-13T07:17:03.498696045Z" level=info msg="containerd successfully booted in 0.057927s" Aug 13 07:17:03.498826 systemd[1]: Started containerd.service - containerd container runtime. Aug 13 07:17:03.886149 systemd-networkd[1322]: eth0: Gained IPv6LL Aug 13 07:17:03.890210 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 13 07:17:03.892189 systemd[1]: Reached target network-online.target - Network is Online. Aug 13 07:17:03.903783 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 13 07:17:03.906043 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 13 07:17:03.925445 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 13 07:17:03.925729 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 13 07:17:03.928760 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Aug 13 07:17:03.929950 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 13 07:17:03.933430 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 13 07:17:03.936072 (-wrapper)[1462]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Aug 13 07:17:04.137816 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 13 07:17:04.138120 (dockerd)[1474]: 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 Aug 13 07:17:04.862787 dockerd[1474]: time="2025-08-13T07:17:04.862697307Z" level=info msg="Starting up" Aug 13 07:17:05.893345 dockerd[1474]: time="2025-08-13T07:17:05.893223828Z" level=info msg="Loading containers: start." Aug 13 07:17:06.205630 kernel: Initializing XFRM netlink socket Aug 13 07:17:06.302963 systemd-networkd[1322]: docker0: Link UP Aug 13 07:17:06.398020 dockerd[1474]: time="2025-08-13T07:17:06.397950031Z" level=info msg="Loading containers: done." Aug 13 07:17:06.417337 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3257694763-merged.mount: Deactivated successfully. Aug 13 07:17:06.419524 dockerd[1474]: time="2025-08-13T07:17:06.419409658Z" 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 Aug 13 07:17:06.419710 dockerd[1474]: time="2025-08-13T07:17:06.419590220Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Aug 13 07:17:06.419774 dockerd[1474]: time="2025-08-13T07:17:06.419750054Z" level=info msg="Daemon has completed initialization" Aug 13 07:17:06.506103 dockerd[1474]: time="2025-08-13T07:17:06.506001255Z" level=info msg="API listen on /run/docker.sock" Aug 13 07:17:06.506362 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 13 07:17:06.509399 etcd-wrapper[1468]: Error response from daemon: No such container: etcd-member Aug 13 07:17:06.533107 etcd-wrapper[1604]: Error response from daemon: No such container: etcd-member Aug 13 07:17:06.565957 etcd-wrapper[1622]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Aug 13 07:17:08.049465 etcd-wrapper[1622]: v3.5.16: Pulling from coreos/etcd Aug 13 07:17:08.383620 etcd-wrapper[1622]: 804c8aba2cc6: Pulling fs layer Aug 13 07:17:08.383620 etcd-wrapper[1622]: 2ae710cd8bfe: Pulling fs layer Aug 13 07:17:08.383620 etcd-wrapper[1622]: d462aa345367: Pulling fs layer Aug 13 07:17:08.383620 etcd-wrapper[1622]: 0f8b424aa0b9: Pulling fs layer Aug 13 07:17:08.383836 etcd-wrapper[1622]: d557676654e5: Pulling fs layer Aug 13 07:17:08.383836 etcd-wrapper[1622]: c8022d07192e: Pulling fs layer Aug 13 07:17:08.383836 etcd-wrapper[1622]: d858cbc252ad: Pulling fs layer Aug 13 07:17:08.383836 etcd-wrapper[1622]: 1069fc2daed1: Pulling fs layer Aug 13 07:17:08.383933 etcd-wrapper[1622]: b40161cd83fc: Pulling fs layer Aug 13 07:17:08.383933 etcd-wrapper[1622]: 5318d93a3a65: Pulling fs layer Aug 13 07:17:08.383933 etcd-wrapper[1622]: 307c1adadb60: Pulling fs layer Aug 13 07:17:08.383933 etcd-wrapper[1622]: fbb01d9e9dc9: Pulling fs layer Aug 13 07:17:08.383933 etcd-wrapper[1622]: fbfea02ac3cf: Pulling fs layer Aug 13 07:17:08.384041 etcd-wrapper[1622]: 8c26e4bf18e2: Pulling fs layer Aug 13 07:17:08.384041 etcd-wrapper[1622]: 1e59a65f8816: Pulling fs layer Aug 13 07:17:08.384041 etcd-wrapper[1622]: 0f8b424aa0b9: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: ffbd4ca5f0bd: Pulling fs layer Aug 13 07:17:08.384041 etcd-wrapper[1622]: d557676654e5: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: 307c1adadb60: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: fbb01d9e9dc9: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: c8022d07192e: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: fbfea02ac3cf: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: 8c26e4bf18e2: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: d858cbc252ad: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: 1e59a65f8816: Waiting Aug 13 07:17:08.384041 etcd-wrapper[1622]: 1069fc2daed1: Waiting Aug 13 07:17:08.384316 etcd-wrapper[1622]: ffbd4ca5f0bd: Waiting Aug 13 07:17:08.384316 etcd-wrapper[1622]: b40161cd83fc: Waiting Aug 13 07:17:08.384316 etcd-wrapper[1622]: 5318d93a3a65: Waiting Aug 13 07:17:08.612424 etcd-wrapper[1622]: 2ae710cd8bfe: Download complete Aug 13 07:17:08.742545 etcd-wrapper[1622]: d462aa345367: Download complete Aug 13 07:17:08.820579 etcd-wrapper[1622]: 804c8aba2cc6: Download complete Aug 13 07:17:08.875074 etcd-wrapper[1622]: 0f8b424aa0b9: Verifying Checksum Aug 13 07:17:08.875074 etcd-wrapper[1622]: 0f8b424aa0b9: Download complete Aug 13 07:17:08.899289 etcd-wrapper[1622]: 804c8aba2cc6: Pull complete Aug 13 07:17:08.922697 systemd[1]: var-lib-docker-overlay2-3455d59f23acc4df8a42af63508224db88772840b4d195178a0a7f10a8053aaa-merged.mount: Deactivated successfully. Aug 13 07:17:08.940189 etcd-wrapper[1622]: 2ae710cd8bfe: Pull complete Aug 13 07:17:09.024183 etcd-wrapper[1622]: d557676654e5: Verifying Checksum Aug 13 07:17:09.024183 etcd-wrapper[1622]: d557676654e5: Download complete Aug 13 07:17:09.090649 etcd-wrapper[1622]: c8022d07192e: Verifying Checksum Aug 13 07:17:09.090649 etcd-wrapper[1622]: c8022d07192e: Download complete Aug 13 07:17:09.140437 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 13 07:17:09.148863 systemd[1]: Started sshd@0-10.0.0.151:22-10.0.0.1:42666.service - OpenSSH per-connection server daemon (10.0.0.1:42666). Aug 13 07:17:09.181851 etcd-wrapper[1622]: d858cbc252ad: Download complete Aug 13 07:17:09.198440 sshd[1655]: Accepted publickey for core from 10.0.0.1 port 42666 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:09.200870 sshd[1655]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:09.210332 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 13 07:17:09.215893 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 13 07:17:09.217992 systemd-logind[1376]: New session 1 of user core. Aug 13 07:17:09.232527 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 13 07:17:09.239051 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 13 07:17:09.245009 (systemd)[1659]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 13 07:17:09.272304 etcd-wrapper[1622]: 1069fc2daed1: Verifying Checksum Aug 13 07:17:09.272304 etcd-wrapper[1622]: 1069fc2daed1: Download complete Aug 13 07:17:09.310724 etcd-wrapper[1622]: b40161cd83fc: Verifying Checksum Aug 13 07:17:09.310724 etcd-wrapper[1622]: b40161cd83fc: Download complete Aug 13 07:17:09.361080 systemd[1659]: Queued start job for default target default.target. Aug 13 07:17:09.372321 systemd[1659]: Created slice app.slice - User Application Slice. Aug 13 07:17:09.372356 systemd[1659]: Reached target paths.target - Paths. Aug 13 07:17:09.372371 systemd[1659]: Reached target timers.target - Timers. Aug 13 07:17:09.374763 systemd[1659]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 13 07:17:09.387948 systemd[1659]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 13 07:17:09.388093 systemd[1659]: Reached target sockets.target - Sockets. Aug 13 07:17:09.388108 systemd[1659]: Reached target basic.target - Basic System. Aug 13 07:17:09.388149 systemd[1659]: Reached target default.target - Main User Target. Aug 13 07:17:09.388196 systemd[1659]: Startup finished in 135ms. Aug 13 07:17:09.388512 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 13 07:17:09.393772 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 13 07:17:09.398753 etcd-wrapper[1622]: 5318d93a3a65: Download complete Aug 13 07:17:09.459955 systemd[1]: Started sshd@1-10.0.0.151:22-10.0.0.1:42678.service - OpenSSH per-connection server daemon (10.0.0.1:42678). Aug 13 07:17:09.461396 systemd[1]: var-lib-docker-overlay2-dcc7e0d03e66add941e2a6e0d5fb04c164c268117a05681d8e39fd7013d08d7e-merged.mount: Deactivated successfully. Aug 13 07:17:09.496355 sshd[1671]: Accepted publickey for core from 10.0.0.1 port 42678 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:09.499151 sshd[1671]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:09.503689 systemd-logind[1376]: New session 2 of user core. Aug 13 07:17:09.510740 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 13 07:17:09.534575 etcd-wrapper[1622]: d462aa345367: Pull complete Aug 13 07:17:09.564912 etcd-wrapper[1622]: 0f8b424aa0b9: Pull complete Aug 13 07:17:09.570319 sshd[1671]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:09.578426 systemd[1]: sshd@1-10.0.0.151:22-10.0.0.1:42678.service: Deactivated successfully. Aug 13 07:17:09.580408 systemd[1]: session-2.scope: Deactivated successfully. Aug 13 07:17:09.581066 systemd-logind[1376]: Session 2 logged out. Waiting for processes to exit. Aug 13 07:17:09.587921 systemd[1]: Started sshd@2-10.0.0.151:22-10.0.0.1:42684.service - OpenSSH per-connection server daemon (10.0.0.1:42684). Aug 13 07:17:09.588875 systemd-logind[1376]: Removed session 2. Aug 13 07:17:09.593202 etcd-wrapper[1622]: 307c1adadb60: Verifying Checksum Aug 13 07:17:09.593202 etcd-wrapper[1622]: 307c1adadb60: Download complete Aug 13 07:17:09.624409 etcd-wrapper[1622]: d557676654e5: Pull complete Aug 13 07:17:09.628216 sshd[1686]: Accepted publickey for core from 10.0.0.1 port 42684 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:09.630746 sshd[1686]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:09.635223 systemd-logind[1376]: New session 3 of user core. Aug 13 07:17:09.643704 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 13 07:17:09.651325 etcd-wrapper[1622]: c8022d07192e: Pull complete Aug 13 07:17:09.682219 etcd-wrapper[1622]: d858cbc252ad: Pull complete Aug 13 07:17:09.699365 sshd[1686]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:09.703329 systemd[1]: sshd@2-10.0.0.151:22-10.0.0.1:42684.service: Deactivated successfully. Aug 13 07:17:09.705411 systemd[1]: session-3.scope: Deactivated successfully. Aug 13 07:17:09.706177 systemd-logind[1376]: Session 3 logged out. Waiting for processes to exit. Aug 13 07:17:09.707375 systemd-logind[1376]: Removed session 3. Aug 13 07:17:09.733681 etcd-wrapper[1622]: fbfea02ac3cf: Verifying Checksum Aug 13 07:17:09.733860 etcd-wrapper[1622]: fbfea02ac3cf: Download complete Aug 13 07:17:09.759070 etcd-wrapper[1622]: fbb01d9e9dc9: Verifying Checksum Aug 13 07:17:09.759070 etcd-wrapper[1622]: fbb01d9e9dc9: Download complete Aug 13 07:17:09.836604 etcd-wrapper[1622]: 8c26e4bf18e2: Verifying Checksum Aug 13 07:17:09.836604 etcd-wrapper[1622]: 8c26e4bf18e2: Download complete Aug 13 07:17:09.864616 etcd-wrapper[1622]: 1069fc2daed1: Pull complete Aug 13 07:17:09.957619 etcd-wrapper[1622]: 1e59a65f8816: Verifying Checksum Aug 13 07:17:09.957619 etcd-wrapper[1622]: 1e59a65f8816: Download complete Aug 13 07:17:10.065776 etcd-wrapper[1622]: ffbd4ca5f0bd: Verifying Checksum Aug 13 07:17:10.065776 etcd-wrapper[1622]: ffbd4ca5f0bd: Download complete Aug 13 07:17:10.482196 systemd[1]: var-lib-docker-overlay2-0e044351ab3db3a1e48aba6acb1f9961f9ac17b29e4048266fa32e7b9920a147-merged.mount: Deactivated successfully. Aug 13 07:17:10.902258 etcd-wrapper[1622]: b40161cd83fc: Pull complete Aug 13 07:17:10.941734 systemd[1]: var-lib-docker-overlay2-eb4ac42b9a095b81a79bee2abffe9e39ed4e2b28e722d771cd5bd68ca58dd4da-merged.mount: Deactivated successfully. Aug 13 07:17:10.952673 etcd-wrapper[1622]: 5318d93a3a65: Pull complete Aug 13 07:17:10.968443 systemd[1]: var-lib-docker-overlay2-542ec7823e83678216e4fe522cc662a6baf7c8eadf3288f20e2d90ba3e3b0701-merged.mount: Deactivated successfully. Aug 13 07:17:11.145065 etcd-wrapper[1622]: 307c1adadb60: Pull complete Aug 13 07:17:11.389584 etcd-wrapper[1622]: fbb01d9e9dc9: Pull complete Aug 13 07:17:11.574564 etcd-wrapper[1622]: fbfea02ac3cf: Pull complete Aug 13 07:17:11.939376 systemd[1]: var-lib-docker-overlay2-3f2a1097a13eefa400e14951a58dd16f8121dc5721c10c7c5312a1ee53445fe8-merged.mount: Deactivated successfully. Aug 13 07:17:12.536257 etcd-wrapper[1622]: 8c26e4bf18e2: Pull complete Aug 13 07:17:12.554253 systemd[1]: var-lib-docker-overlay2-29659deddd11b7d66173879a4f07e5d71a0da4832b2557eb505378a42e72f1a7-merged.mount: Deactivated successfully. Aug 13 07:17:12.563697 etcd-wrapper[1622]: 1e59a65f8816: Pull complete Aug 13 07:17:12.589060 systemd[1]: var-lib-docker-overlay2-931d46af7580fe8f07014eb60e335f2fc4e6ce29bbee260d4f343309d9de8671-merged.mount: Deactivated successfully. Aug 13 07:17:12.602830 etcd-wrapper[1622]: ffbd4ca5f0bd: Pull complete Aug 13 07:17:12.613609 etcd-wrapper[1622]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Aug 13 07:17:12.617028 etcd-wrapper[1622]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Aug 13 07:17:13.718778 containerd[1394]: time="2025-08-13T07:17:13.718591838Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:17:13.718778 containerd[1394]: time="2025-08-13T07:17:13.718696021Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:17:13.718778 containerd[1394]: time="2025-08-13T07:17:13.718708776Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:17:13.719404 containerd[1394]: time="2025-08-13T07:17:13.718819478Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:17:13.753737 systemd[1]: Started docker-6501aeae1c8d62daedacd3f7d81f8e23bda468ca32422624417dcbbb0b901e85.scope - libcontainer container 6501aeae1c8d62daedacd3f7d81f8e23bda468ca32422624417dcbbb0b901e85. Aug 13 07:17:13.773392 systemd-resolved[1266]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.817948Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.818124Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"606da99390804e0b9d7efa2810f1b871"} Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.818155Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.818183Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.818190Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.818202Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Aug 13 07:17:13.818398 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.818239Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Aug 13 07:17:13.819011 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.818324Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.0.0.151:2379"]} Aug 13 07:17:13.819011 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.818427Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Aug 13 07:17:13.819011 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.818448Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Aug 13 07:17:13.819220 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.819092Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Aug 13 07:17:13.819494 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.819260Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"amd64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"606da99390804e0b9d7efa2810f1b871","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,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.151:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"606da99390804e0b9d7efa2810f1b871=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Aug 13 07:17:13.822649 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.822437Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.688867ms"} Aug 13 07:17:13.826580 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.826365Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Aug 13 07:17:13.826580 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.826441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Aug 13 07:17:13.826687 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.826495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Aug 13 07:17:13.826687 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.826516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Aug 13 07:17:13.826687 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.826535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Aug 13 07:17:13.826756 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.826586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Aug 13 07:17:13.831113 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:17:13.830941Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Aug 13 07:17:13.832001 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.831868Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Aug 13 07:17:13.832991 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.832807Z","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"} Aug 13 07:17:13.833955 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.833673Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Aug 13 07:17:13.834124 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.833775Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Aug 13 07:17:13.834124 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.833870Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Aug 13 07:17:13.834124 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.833924Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Aug 13 07:17:13.834224 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.833933Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Aug 13 07:17:13.834224 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.833980Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Aug 13 07:17:13.835031 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.834612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Aug 13 07:17:13.835363 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.835201Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Aug 13 07:17:13.836197 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.836074Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Aug 13 07:17:13.836197 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.836094Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Aug 13 07:17:13.836297 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:13.836128Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.151:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427410Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Aug 13 07:17:14.427632 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.427424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Aug 13 07:17:14.428384 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428220Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:606da99390804e0b9d7efa2810f1b871 ClientURLs:[http://10.0.0.151:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Aug 13 07:17:14.428384 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428239Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Aug 13 07:17:14.428510 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428296Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Aug 13 07:17:14.428748 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428447Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Aug 13 07:17:14.428748 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428632Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Aug 13 07:17:14.429026 systemd[1]: Started etcd-member.service - etcd (System Application Container). Aug 13 07:17:14.429281 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428896Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Aug 13 07:17:14.429281 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428970Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Aug 13 07:17:14.429281 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428987Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Aug 13 07:17:14.429281 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.428993Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Aug 13 07:17:14.429721 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 13 07:17:14.429926 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:17:14.429463Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Aug 13 07:17:14.429972 systemd[1]: Startup finished in 1.166s (kernel) + 4.924s (initrd) + 14.820s (userspace) = 20.911s. Aug 13 07:17:19.748753 systemd[1]: Started sshd@3-10.0.0.151:22-10.0.0.1:43680.service - OpenSSH per-connection server daemon (10.0.0.1:43680). Aug 13 07:17:19.790343 sshd[1796]: Accepted publickey for core from 10.0.0.1 port 43680 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:19.792309 sshd[1796]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:19.796831 systemd-logind[1376]: New session 4 of user core. Aug 13 07:17:19.807750 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 13 07:17:19.864164 sshd[1796]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:19.876877 systemd[1]: sshd@3-10.0.0.151:22-10.0.0.1:43680.service: Deactivated successfully. Aug 13 07:17:19.878972 systemd[1]: session-4.scope: Deactivated successfully. Aug 13 07:17:19.880660 systemd-logind[1376]: Session 4 logged out. Waiting for processes to exit. Aug 13 07:17:19.895165 systemd[1]: Started sshd@4-10.0.0.151:22-10.0.0.1:43684.service - OpenSSH per-connection server daemon (10.0.0.1:43684). Aug 13 07:17:19.896505 systemd-logind[1376]: Removed session 4. Aug 13 07:17:19.928842 sshd[1803]: Accepted publickey for core from 10.0.0.1 port 43684 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:19.930680 sshd[1803]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:19.934852 systemd-logind[1376]: New session 5 of user core. Aug 13 07:17:19.945701 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 13 07:17:19.996285 sshd[1803]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:20.018608 systemd[1]: sshd@4-10.0.0.151:22-10.0.0.1:43684.service: Deactivated successfully. Aug 13 07:17:20.020680 systemd[1]: session-5.scope: Deactivated successfully. Aug 13 07:17:20.022136 systemd-logind[1376]: Session 5 logged out. Waiting for processes to exit. Aug 13 07:17:20.031885 systemd[1]: Started sshd@5-10.0.0.151:22-10.0.0.1:53944.service - OpenSSH per-connection server daemon (10.0.0.1:53944). Aug 13 07:17:20.032987 systemd-logind[1376]: Removed session 5. Aug 13 07:17:20.071726 sshd[1810]: Accepted publickey for core from 10.0.0.1 port 53944 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:20.073750 sshd[1810]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:20.078346 systemd-logind[1376]: New session 6 of user core. Aug 13 07:17:20.090742 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 13 07:17:20.146700 sshd[1810]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:20.160515 systemd[1]: sshd@5-10.0.0.151:22-10.0.0.1:53944.service: Deactivated successfully. Aug 13 07:17:20.162864 systemd[1]: session-6.scope: Deactivated successfully. Aug 13 07:17:20.164831 systemd-logind[1376]: Session 6 logged out. Waiting for processes to exit. Aug 13 07:17:20.166192 systemd[1]: Started sshd@6-10.0.0.151:22-10.0.0.1:53952.service - OpenSSH per-connection server daemon (10.0.0.1:53952). Aug 13 07:17:20.167172 systemd-logind[1376]: Removed session 6. Aug 13 07:17:20.215020 sshd[1817]: Accepted publickey for core from 10.0.0.1 port 53952 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:20.216744 sshd[1817]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:20.221084 systemd-logind[1376]: New session 7 of user core. Aug 13 07:17:20.234718 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 13 07:17:20.286614 sshd[1817]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:20.302651 systemd[1]: sshd@6-10.0.0.151:22-10.0.0.1:53952.service: Deactivated successfully. Aug 13 07:17:20.304509 systemd[1]: session-7.scope: Deactivated successfully. Aug 13 07:17:20.306146 systemd-logind[1376]: Session 7 logged out. Waiting for processes to exit. Aug 13 07:17:20.307442 systemd[1]: Started sshd@7-10.0.0.151:22-10.0.0.1:53954.service - OpenSSH per-connection server daemon (10.0.0.1:53954). Aug 13 07:17:20.308199 systemd-logind[1376]: Removed session 7. Aug 13 07:17:20.347273 sshd[1826]: Accepted publickey for core from 10.0.0.1 port 53954 ssh2: RSA SHA256:+DcVhnpRDsBWp3H5IUXcw71JLKRCmgP+N/m7GkGrueA Aug 13 07:17:20.349054 sshd[1826]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:17:20.353421 systemd-logind[1376]: New session 8 of user core. Aug 13 07:17:20.362703 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 13 07:17:20.489767 sshd[1826]: pam_unix(sshd:session): session closed for user core Aug 13 07:17:20.494811 systemd[1]: sshd@7-10.0.0.151:22-10.0.0.1:53954.service: Deactivated successfully. Aug 13 07:17:20.497152 systemd[1]: session-8.scope: Deactivated successfully. Aug 13 07:17:20.497860 systemd-logind[1376]: Session 8 logged out. Waiting for processes to exit. Aug 13 07:17:20.499041 systemd-logind[1376]: Removed session 8. Aug 13 07:17:48.527077 update_engine[1378]: I20250813 07:17:48.526932 1378 update_attempter.cc:509] Updating boot flags... Aug 13 07:17:48.580622 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1845) Aug 13 07:17:48.629252 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1849) Aug 13 07:17:48.673460 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1849) Aug 13 07:18:20.552472 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:20.551825Z","caller":"traceutil/trace.go:171","msg":"trace[1268992570] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"114.797113ms","start":"2025-08-13T07:18:20.437001Z","end":"2025-08-13T07:18:20.551798Z","steps":["trace[1268992570] 'process raft request' (duration: 106.801816ms)"],"step_count":1} Aug 13 07:18:21.882287 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:21.881673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.791262ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Aug 13 07:18:21.882287 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:21.881808Z","caller":"traceutil/trace.go:171","msg":"trace[1385362188] transaction","detail":"{read_only:false; response_revision:150; number_of_response:1; }","duration":"225.876471ms","start":"2025-08-13T07:18:21.655917Z","end":"2025-08-13T07:18:21.881794Z","steps":["trace[1385362188] 'process raft request' (duration: 104.503149ms)","trace[1385362188] 'compare' (duration: 120.604433ms)"],"step_count":2} Aug 13 07:18:22.382945 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:22.382440Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.318375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Aug 13 07:18:22.382945 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:22.382520Z","caller":"traceutil/trace.go:171","msg":"trace[1608094783] linearizableReadLoop","detail":"{readStateIndex:165; appliedIndex:164; }","duration":"232.254139ms","start":"2025-08-13T07:18:22.150248Z","end":"2025-08-13T07:18:22.382503Z","steps":["trace[1608094783] 'read index received' (duration: 26.801189ms)","trace[1608094783] 'applied index is now lower than readState.Index' (duration: 205.452409ms)"],"step_count":2} Aug 13 07:18:22.382945 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:22.382582Z","caller":"traceutil/trace.go:171","msg":"trace[1152791014] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"248.453413ms","start":"2025-08-13T07:18:22.134086Z","end":"2025-08-13T07:18:22.382539Z","steps":["trace[1152791014] 'process raft request' (duration: 42.992196ms)","trace[1152791014] 'compare' (duration: 205.208218ms)"],"step_count":2} Aug 13 07:18:22.382945 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:22.382620Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.341803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Aug 13 07:18:22.383269 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:22.382663Z","caller":"traceutil/trace.go:171","msg":"trace[2001930036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:160; }","duration":"232.429155ms","start":"2025-08-13T07:18:22.150225Z","end":"2025-08-13T07:18:22.382655Z","steps":["trace[2001930036] 'agreement among raft nodes before linearized reading' (duration: 232.313717ms)"],"step_count":1} Aug 13 07:18:22.709102 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:22.708713Z","caller":"traceutil/trace.go:171","msg":"trace[721907427] transaction","detail":"{read_only:false; response_revision:163; number_of_response:1; }","duration":"229.825271ms","start":"2025-08-13T07:18:22.478870Z","end":"2025-08-13T07:18:22.708695Z","steps":["trace[721907427] 'process raft request' (duration: 220.018663ms)"],"step_count":1} Aug 13 07:18:22.764723 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:22.764439Z","caller":"traceutil/trace.go:171","msg":"trace[356660273] transaction","detail":"{read_only:false; response_revision:164; number_of_response:1; }","duration":"249.447865ms","start":"2025-08-13T07:18:22.514973Z","end":"2025-08-13T07:18:22.764421Z","steps":["trace[356660273] 'process raft request' (duration: 249.334161ms)"],"step_count":1} Aug 13 07:18:23.017842 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:23.017397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.790066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Aug 13 07:18:23.017842 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:23.017477Z","caller":"traceutil/trace.go:171","msg":"trace[575941615] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"241.561063ms","start":"2025-08-13T07:18:22.775904Z","end":"2025-08-13T07:18:23.017465Z","steps":["trace[575941615] 'process raft request' (duration: 67.644768ms)","trace[575941615] 'compare' (duration: 173.67545ms)"],"step_count":2} Aug 13 07:18:23.177942 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:23.177579Z","caller":"traceutil/trace.go:171","msg":"trace[839483108] transaction","detail":"{read_only:false; response_revision:168; number_of_response:1; }","duration":"129.59424ms","start":"2025-08-13T07:18:23.047947Z","end":"2025-08-13T07:18:23.177541Z","steps":["trace[839483108] 'process raft request' (duration: 90.440782ms)","trace[839483108] 'compare' (duration: 39.034523ms)"],"step_count":2} Aug 13 07:18:23.649897 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:23.649532Z","caller":"traceutil/trace.go:171","msg":"trace[203031770] transaction","detail":"{read_only:false; response_revision:192; number_of_response:1; }","duration":"128.145256ms","start":"2025-08-13T07:18:23.521366Z","end":"2025-08-13T07:18:23.649512Z","steps":["trace[203031770] 'process raft request' (duration: 51.776227ms)","trace[203031770] 'compare' (duration: 76.266788ms)"],"step_count":2} Aug 13 07:18:24.046701 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:24.046169Z","caller":"traceutil/trace.go:171","msg":"trace[290266278] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"156.724459ms","start":"2025-08-13T07:18:23.889425Z","end":"2025-08-13T07:18:24.046149Z","steps":["trace[290266278] 'process raft request' (duration: 76.285685ms)","trace[290266278] 'compare' (duration: 80.331262ms)"],"step_count":2} Aug 13 07:18:25.047058 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.046547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.631136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Aug 13 07:18:25.047058 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.046677Z","caller":"traceutil/trace.go:171","msg":"trace[460418638] linearizableReadLoop","detail":"{readStateIndex:244; appliedIndex:242; }","duration":"388.037801ms","start":"2025-08-13T07:18:24.658628Z","end":"2025-08-13T07:18:25.046666Z","steps":["trace[460418638] 'read index received' (duration: 71.921695ms)","trace[460418638] 'applied index is now lower than readState.Index' (duration: 316.115545ms)"],"step_count":2} Aug 13 07:18:25.047058 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.046735Z","caller":"traceutil/trace.go:171","msg":"trace[923542943] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"409.820435ms","start":"2025-08-13T07:18:24.636910Z","end":"2025-08-13T07:18:25.046730Z","steps":["trace[923542943] 'process raft request' (duration: 136.962363ms)","trace[923542943] 'compare' (duration: 272.537162ms)"],"step_count":2} Aug 13 07:18:25.047708 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.046790Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:24.636891Z","time spent":"409.883339ms","remote":"10.0.0.153:36282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} Aug 13 07:18:25.047708 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.046928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.298954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} Aug 13 07:18:25.047708 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.046954Z","caller":"traceutil/trace.go:171","msg":"trace[816646743] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:237; }","duration":"388.346477ms","start":"2025-08-13T07:18:24.658601Z","end":"2025-08-13T07:18:25.046947Z","steps":["trace[816646743] 'agreement among raft nodes before linearized reading' (duration: 388.272352ms)"],"step_count":1} Aug 13 07:18:25.047708 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.046975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:24.658520Z","time spent":"388.446985ms","remote":"10.0.0.153:36326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} Aug 13 07:18:25.047828 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.046785Z","caller":"traceutil/trace.go:171","msg":"trace[162960101] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"389.046114ms","start":"2025-08-13T07:18:24.657711Z","end":"2025-08-13T07:18:25.046757Z","steps":["trace[162960101] 'process raft request' (duration: 388.922431ms)"],"step_count":1} Aug 13 07:18:25.047828 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.047021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:24.657688Z","time spent":"389.321074ms","remote":"10.0.0.153:36554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":481,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} Aug 13 07:18:25.047828 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.046999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.558586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-localhost\" ","response":"range_response_count:1 size:4935"} Aug 13 07:18:25.047828 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.047104Z","caller":"traceutil/trace.go:171","msg":"trace[916258999] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-localhost; range_end:; response_count:1; response_revision:237; }","duration":"121.69806ms","start":"2025-08-13T07:18:24.925377Z","end":"2025-08-13T07:18:25.047075Z","steps":["trace[916258999] 'agreement among raft nodes before linearized reading' (duration: 121.506223ms)"],"step_count":1} Aug 13 07:18:25.395439 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:25.395095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.198525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Aug 13 07:18:25.395439 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.395174Z","caller":"traceutil/trace.go:171","msg":"trace[200077274] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"253.480429ms","start":"2025-08-13T07:18:25.141679Z","end":"2025-08-13T07:18:25.395159Z","steps":["trace[200077274] 'process raft request' (duration: 11.173782ms)","trace[200077274] 'compare' (duration: 242.091215ms)"],"step_count":2} Aug 13 07:18:25.430807 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.430400Z","caller":"traceutil/trace.go:171","msg":"trace[2019729470] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"284.976164ms","start":"2025-08-13T07:18:25.145401Z","end":"2025-08-13T07:18:25.430377Z","steps":["trace[2019729470] 'process raft request' (duration: 284.858893ms)"],"step_count":1} Aug 13 07:18:25.474983 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:25.474605Z","caller":"traceutil/trace.go:171","msg":"trace[1955959837] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"206.345368ms","start":"2025-08-13T07:18:25.268238Z","end":"2025-08-13T07:18:25.474583Z","steps":["trace[1955959837] 'process raft request' (duration: 206.213268ms)"],"step_count":1} Aug 13 07:18:27.554536 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:27.553785Z","caller":"traceutil/trace.go:171","msg":"trace[172338625] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"145.027993ms","start":"2025-08-13T07:18:27.408728Z","end":"2025-08-13T07:18:27.553756Z","steps":["trace[172338625] 'process raft request' (duration: 60.493782ms)","trace[172338625] 'compare' (duration: 84.31435ms)"],"step_count":2} Aug 13 07:18:29.531885 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.531418Z","caller":"traceutil/trace.go:171","msg":"trace[1652538165] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"100.335578ms","start":"2025-08-13T07:18:29.431017Z","end":"2025-08-13T07:18:29.531352Z","steps":["trace[1652538165] 'process raft request' (duration: 75.959003ms)","trace[1652538165] 'compare' (duration: 24.08776ms)"],"step_count":2} Aug 13 07:18:29.850389 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.849714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.359832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Aug 13 07:18:29.850867 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.849886Z","caller":"traceutil/trace.go:171","msg":"trace[419481831] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:328; }","duration":"291.498178ms","start":"2025-08-13T07:18:29.558376Z","end":"2025-08-13T07:18:29.849874Z","steps":["trace[419481831] 'read index received' (duration: 156.737441ms)","trace[419481831] 'applied index is now lower than readState.Index' (duration: 134.760126ms)"],"step_count":2} Aug 13 07:18:29.850867 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.849933Z","caller":"traceutil/trace.go:171","msg":"trace[1318031063] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"312.689784ms","start":"2025-08-13T07:18:29.537210Z","end":"2025-08-13T07:18:29.849900Z","steps":["trace[1318031063] 'process raft request' (duration: 312.588476ms)"],"step_count":1} Aug 13 07:18:29.850867 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.850037Z","caller":"traceutil/trace.go:171","msg":"trace[1768829308] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"293.241336ms","start":"2025-08-13T07:18:29.556786Z","end":"2025-08-13T07:18:29.850027Z","steps":["trace[1768829308] 'process raft request' (duration: 293.062226ms)"],"step_count":1} Aug 13 07:18:29.850867 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.850032Z","caller":"traceutil/trace.go:171","msg":"trace[1755912765] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"314.570702ms","start":"2025-08-13T07:18:29.535431Z","end":"2025-08-13T07:18:29.850002Z","steps":["trace[1755912765] 'process raft request' (duration: 179.67417ms)","trace[1755912765] 'compare' (duration: 134.264947ms)"],"step_count":2} Aug 13 07:18:29.850867 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.850116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.741733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} Aug 13 07:18:29.851123 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.850145Z","caller":"traceutil/trace.go:171","msg":"trace[1775815552] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:320; }","duration":"291.790801ms","start":"2025-08-13T07:18:29.558340Z","end":"2025-08-13T07:18:29.850130Z","steps":["trace[1775815552] 'agreement among raft nodes before linearized reading' (duration: 291.752335ms)"],"step_count":1} Aug 13 07:18:29.851123 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.850166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.535410Z","time spent":"314.683323ms","remote":"10.0.0.153:36316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2301,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:29.851123 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.850221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.478313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} Aug 13 07:18:29.851251 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.850062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.537192Z","time spent":"312.800652ms","remote":"10.0.0.153:36398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6553,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:29.851251 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.850240Z","caller":"traceutil/trace.go:171","msg":"trace[1713410507] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:320; }","duration":"240.534511ms","start":"2025-08-13T07:18:29.609700Z","end":"2025-08-13T07:18:29.850234Z","steps":["trace[1713410507] 'agreement among raft nodes before linearized reading' (duration: 240.50283ms)"],"step_count":1} Aug 13 07:18:29.851251 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.850340Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.898021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} Aug 13 07:18:29.851251 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:29.850346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.368406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} Aug 13 07:18:29.851362 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.850359Z","caller":"traceutil/trace.go:171","msg":"trace[397856150] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:320; }","duration":"190.940926ms","start":"2025-08-13T07:18:29.659411Z","end":"2025-08-13T07:18:29.850352Z","steps":["trace[397856150] 'agreement among raft nodes before linearized reading' (duration: 190.913071ms)"],"step_count":1} Aug 13 07:18:29.851362 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:29.850370Z","caller":"traceutil/trace.go:171","msg":"trace[1355100916] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:320; }","duration":"140.419706ms","start":"2025-08-13T07:18:29.709943Z","end":"2025-08-13T07:18:29.850363Z","steps":["trace[1355100916] 'agreement among raft nodes before linearized reading' (duration: 140.375038ms)"],"step_count":1} Aug 13 07:18:30.253465 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.252703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.721088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Aug 13 07:18:30.253465 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.252943Z","caller":"traceutil/trace.go:171","msg":"trace[1760367307] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"396.830645ms","start":"2025-08-13T07:18:29.856077Z","end":"2025-08-13T07:18:30.252908Z","steps":["trace[1760367307] 'process raft request' (duration: 256.861551ms)","trace[1760367307] 'compare' (duration: 139.579202ms)"],"step_count":2} Aug 13 07:18:30.253465 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253053Z","caller":"traceutil/trace.go:171","msg":"trace[1637957334] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"393.234001ms","start":"2025-08-13T07:18:29.859813Z","end":"2025-08-13T07:18:30.253047Z","steps":["trace[1637957334] 'process raft request' (duration: 393.129186ms)"],"step_count":1} Aug 13 07:18:30.253465 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.856061Z","time spent":"396.951932ms","remote":"10.0.0.153:36484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1045,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} Aug 13 07:18:30.253817 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253060Z","caller":"traceutil/trace.go:171","msg":"trace[989123258] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"395.451128ms","start":"2025-08-13T07:18:29.857593Z","end":"2025-08-13T07:18:30.253044Z","steps":["trace[989123258] 'process raft request' (duration: 395.31959ms)"],"step_count":1} Aug 13 07:18:30.253817 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.252943Z","caller":"traceutil/trace.go:171","msg":"trace[446732699] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"396.64355ms","start":"2025-08-13T07:18:29.856281Z","end":"2025-08-13T07:18:30.252924Z","steps":["trace[446732699] 'process raft request' (duration: 396.489309ms)"],"step_count":1} Aug 13 07:18:30.253817 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.856268Z","time spent":"396.869631ms","remote":"10.0.0.153:36420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} Aug 13 07:18:30.253817 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.859804Z","time spent":"393.271644ms","remote":"10.0.0.153:36564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:30.254008 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253268Z","caller":"traceutil/trace.go:171","msg":"trace[891352143] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"396.373771ms","start":"2025-08-13T07:18:29.856886Z","end":"2025-08-13T07:18:30.253260Z","steps":["trace[891352143] 'process raft request' (duration: 395.95361ms)"],"step_count":1} Aug 13 07:18:30.254008 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253279Z","caller":"traceutil/trace.go:171","msg":"trace[1914679244] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"392.980244ms","start":"2025-08-13T07:18:29.860292Z","end":"2025-08-13T07:18:30.253273Z","steps":["trace[1914679244] 'process raft request' (duration: 392.683684ms)"],"step_count":1} Aug 13 07:18:30.254008 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253310Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.860283Z","time spent":"393.009862ms","remote":"10.0.0.153:36564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:30.254008 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.856877Z","time spent":"396.411774ms","remote":"10.0.0.153:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4124,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:30.254135 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253502Z","caller":"traceutil/trace.go:171","msg":"trace[12057433] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"393.155406ms","start":"2025-08-13T07:18:29.860337Z","end":"2025-08-13T07:18:30.253492Z","steps":["trace[12057433] 'process raft request' (duration: 392.662222ms)"],"step_count":1} Aug 13 07:18:30.254135 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.857583Z","time spent":"395.600498ms","remote":"10.0.0.153:36698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3620,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} Aug 13 07:18:30.254135 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253465Z","caller":"traceutil/trace.go:171","msg":"trace[894757152] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:332; }","duration":"326.816227ms","start":"2025-08-13T07:18:29.926640Z","end":"2025-08-13T07:18:30.253456Z","steps":["trace[894757152] 'read index received' (duration: 186.324874ms)","trace[894757152] 'applied index is now lower than readState.Index' (duration: 140.490392ms)"],"step_count":2} Aug 13 07:18:30.254135 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.860332Z","time spent":"393.19842ms","remote":"10.0.0.153:36564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:30.254268 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.206556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} Aug 13 07:18:30.254268 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.253934Z","caller":"traceutil/trace.go:171","msg":"trace[1458035708] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:328; }","duration":"395.254831ms","start":"2025-08-13T07:18:29.858673Z","end":"2025-08-13T07:18:30.253927Z","steps":["trace[1458035708] 'agreement among raft nodes before linearized reading' (duration: 395.206908ms)"],"step_count":1} Aug 13 07:18:30.254268 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.253951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.858662Z","time spent":"395.284209ms","remote":"10.0.0.153:36420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} Aug 13 07:18:30.287922 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.287596Z","caller":"traceutil/trace.go:171","msg":"trace[695023304] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"354.627352ms","start":"2025-08-13T07:18:29.932956Z","end":"2025-08-13T07:18:30.287583Z","steps":["trace[695023304] 'process raft request' (duration: 354.47804ms)"],"step_count":1} Aug 13 07:18:30.287922 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.287673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-08-13T07:18:29.932937Z","time spent":"354.691446ms","remote":"10.0.0.153:36398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6343,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Aug 13 07:18:30.933457 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.932849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.312394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} Aug 13 07:18:30.933457 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.932989Z","caller":"traceutil/trace.go:171","msg":"trace[57882986] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:367; }","duration":"298.49973ms","start":"2025-08-13T07:18:30.634477Z","end":"2025-08-13T07:18:30.932976Z","steps":["trace[57882986] 'range keys from in-memory index tree' (duration: 298.243459ms)"],"step_count":1} Aug 13 07:18:30.933457 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:30.932905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.298316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-flannel/flannel\" ","response":"range_response_count:1 size:612"} Aug 13 07:18:30.933457 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.933074Z","caller":"traceutil/trace.go:171","msg":"trace[270188828] range","detail":"{range_begin:/registry/serviceaccounts/kube-flannel/flannel; range_end:; response_count:1; response_revision:367; }","duration":"298.543665ms","start":"2025-08-13T07:18:30.634522Z","end":"2025-08-13T07:18:30.933066Z","steps":["trace[270188828] 'range keys from in-memory index tree' (duration: 298.168933ms)"],"step_count":1} Aug 13 07:18:30.933457 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:30.932931Z","caller":"traceutil/trace.go:171","msg":"trace[675464310] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"188.072877ms","start":"2025-08-13T07:18:30.744833Z","end":"2025-08-13T07:18:30.932906Z","steps":["trace[675464310] 'process raft request' (duration: 133.58037ms)","trace[675464310] 'compare' (duration: 54.374416ms)"],"step_count":2} Aug 13 07:18:31.233347 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:31.232548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.509731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Aug 13 07:18:31.233347 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:31.232680Z","caller":"traceutil/trace.go:171","msg":"trace[514940034] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"160.556071ms","start":"2025-08-13T07:18:31.072113Z","end":"2025-08-13T07:18:31.232669Z","steps":["trace[514940034] 'process raft request' (duration: 160.524258ms)"],"step_count":1} Aug 13 07:18:31.233347 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:31.232785Z","caller":"traceutil/trace.go:171","msg":"trace[616700664] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"295.663764ms","start":"2025-08-13T07:18:30.937087Z","end":"2025-08-13T07:18:31.232751Z","steps":["trace[616700664] 'process raft request' (duration: 172.893975ms)","trace[616700664] 'compare' (duration: 122.420827ms)"],"step_count":2} Aug 13 07:18:34.950159 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:34.949828Z","caller":"traceutil/trace.go:171","msg":"trace[1130744152] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"105.080913ms","start":"2025-08-13T07:18:34.844726Z","end":"2025-08-13T07:18:34.949807Z","steps":["trace[1130744152] 'process raft request' (duration: 104.921963ms)"],"step_count":1} Aug 13 07:18:34.951434 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:34.951217Z","caller":"traceutil/trace.go:171","msg":"trace[153667656] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"104.100504ms","start":"2025-08-13T07:18:34.847095Z","end":"2025-08-13T07:18:34.951196Z","steps":["trace[153667656] 'process raft request' (duration: 103.959219ms)"],"step_count":1} Aug 13 07:18:38.252935 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.252473Z","caller":"traceutil/trace.go:171","msg":"trace[1841913433] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"109.672078ms","start":"2025-08-13T07:18:38.142779Z","end":"2025-08-13T07:18:38.252451Z","steps":["trace[1841913433] 'process raft request' (duration: 84.702133ms)","trace[1841913433] 'compare' (duration: 24.88544ms)"],"step_count":2} Aug 13 07:18:38.446178 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.445824Z","caller":"traceutil/trace.go:171","msg":"trace[690040450] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"189.627283ms","start":"2025-08-13T07:18:38.256178Z","end":"2025-08-13T07:18:38.445806Z","steps":["trace[690040450] 'process raft request' (duration: 114.607534ms)","trace[690040450] 'compare' (duration: 74.921529ms)"],"step_count":2} Aug 13 07:18:38.456717 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.456469Z","caller":"traceutil/trace.go:171","msg":"trace[240490948] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"197.702868ms","start":"2025-08-13T07:18:38.258758Z","end":"2025-08-13T07:18:38.456461Z","steps":["trace[240490948] 'process raft request' (duration: 197.650376ms)"],"step_count":1} Aug 13 07:18:38.745383 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:38.745120Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.136966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Aug 13 07:18:38.745583 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.745243Z","caller":"traceutil/trace.go:171","msg":"trace[924433510] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"285.586361ms","start":"2025-08-13T07:18:38.459646Z","end":"2025-08-13T07:18:38.745232Z","steps":["trace[924433510] 'process raft request' (duration: 285.547766ms)"],"step_count":1} Aug 13 07:18:38.745583 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.745298Z","caller":"traceutil/trace.go:171","msg":"trace[668517485] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"285.646838ms","start":"2025-08-13T07:18:38.459645Z","end":"2025-08-13T07:18:38.745292Z","steps":["trace[668517485] 'process raft request' (duration: 161.280786ms)","trace[668517485] 'compare' (duration: 124.026313ms)"],"step_count":2} Aug 13 07:18:38.982021 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.981656Z","caller":"traceutil/trace.go:171","msg":"trace[1326105921] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"141.059974ms","start":"2025-08-13T07:18:38.840574Z","end":"2025-08-13T07:18:38.981634Z","steps":["trace[1326105921] 'read index received' (duration: 58.897319ms)","trace[1326105921] 'applied index is now lower than readState.Index' (duration: 82.162154ms)"],"step_count":2} Aug 13 07:18:38.982021 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.981673Z","caller":"traceutil/trace.go:171","msg":"trace[60733089] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"183.232148ms","start":"2025-08-13T07:18:38.798414Z","end":"2025-08-13T07:18:38.981646Z","steps":["trace[60733089] 'process raft request' (duration: 101.101164ms)","trace[60733089] 'compare' (duration: 81.986694ms)"],"step_count":2} Aug 13 07:18:38.982352 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:18:38.981940Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.372048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c65d6cfc9-mfpjg\" ","response":"range_response_count:1 size:3814"} Aug 13 07:18:38.982352 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:38.982027Z","caller":"traceutil/trace.go:171","msg":"trace[1941410596] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c65d6cfc9-mfpjg; range_end:; response_count:1; response_revision:413; }","duration":"141.500709ms","start":"2025-08-13T07:18:38.840518Z","end":"2025-08-13T07:18:38.982019Z","steps":["trace[1941410596] 'agreement among raft nodes before linearized reading' (duration: 141.215486ms)"],"step_count":1} Aug 13 07:18:48.596728 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:48.596360Z","caller":"traceutil/trace.go:171","msg":"trace[1496708068] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"176.584321ms","start":"2025-08-13T07:18:48.419716Z","end":"2025-08-13T07:18:48.596300Z","steps":["trace[1496708068] 'process raft request' (duration: 159.277377ms)","trace[1496708068] 'compare' (duration: 17.223303ms)"],"step_count":2} Aug 13 07:18:52.374876 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:18:52.374518Z","caller":"traceutil/trace.go:171","msg":"trace[1310654344] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"144.995272ms","start":"2025-08-13T07:18:52.229508Z","end":"2025-08-13T07:18:52.374503Z","steps":["trace[1310654344] 'process raft request' (duration: 144.900509ms)"],"step_count":1} Aug 13 07:19:04.283938 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:19:04.283594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.183347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/10.0.0.153\" ","response":"range_response_count:1 size:127"} Aug 13 07:19:04.283938 etcd-wrapper[1622]: {"level":"info","ts":"2025-08-13T07:19:04.283666Z","caller":"traceutil/trace.go:171","msg":"trace[737547579] range","detail":"{range_begin:/registry/masterleases/10.0.0.153; range_end:; response_count:1; response_revision:573; }","duration":"131.310471ms","start":"2025-08-13T07:19:04.152342Z","end":"2025-08-13T07:19:04.283652Z","steps":["trace[737547579] 'range keys from in-memory index tree' (duration: 131.102483ms)"],"step_count":1} Aug 13 07:19:09.662835 etcd-wrapper[1622]: {"level":"warn","ts":"2025-08-13T07:19:09.662456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.527826ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"}