Apr 16 03:37:03.188771 kernel: Linux version 6.6.127-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 Wed Apr 15 22:45:03 -00 2026 Apr 16 03:37:03.188810 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=27643dbc59f658eac8bb37add3a8b4ed010a3c31134319f01549aa493a1f070c Apr 16 03:37:03.188825 kernel: BIOS-provided physical RAM map: Apr 16 03:37:03.188834 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Apr 16 03:37:03.188841 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Apr 16 03:37:03.188848 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Apr 16 03:37:03.188858 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Apr 16 03:37:03.188866 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Apr 16 03:37:03.188873 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Apr 16 03:37:03.188883 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Apr 16 03:37:03.188890 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Apr 16 03:37:03.188897 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Apr 16 03:37:03.188903 kernel: NX (Execute Disable) protection: active Apr 16 03:37:03.188910 kernel: APIC: Static calls initialized Apr 16 03:37:03.188919 kernel: SMBIOS 2.8 present. Apr 16 03:37:03.188928 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Apr 16 03:37:03.188936 kernel: Hypervisor detected: KVM Apr 16 03:37:03.188943 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Apr 16 03:37:03.188951 kernel: kvm-clock: using sched offset of 7161512170 cycles Apr 16 03:37:03.188961 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Apr 16 03:37:03.188970 kernel: tsc: Detected 2793.438 MHz processor Apr 16 03:37:03.188977 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 16 03:37:03.188987 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 16 03:37:03.188996 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x10000000000 Apr 16 03:37:03.189007 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Apr 16 03:37:03.189016 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 16 03:37:03.189024 kernel: Using GB pages for direct mapping Apr 16 03:37:03.189032 kernel: ACPI: Early table checksum verification disabled Apr 16 03:37:03.189041 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Apr 16 03:37:03.189049 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189058 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189067 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189075 kernel: ACPI: FACS 0x000000009CFE0000 000040 Apr 16 03:37:03.189087 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189095 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189104 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189113 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 16 03:37:03.189120 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Apr 16 03:37:03.189129 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Apr 16 03:37:03.189138 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Apr 16 03:37:03.189153 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Apr 16 03:37:03.189162 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Apr 16 03:37:03.189171 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Apr 16 03:37:03.189181 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Apr 16 03:37:03.189188 kernel: No NUMA configuration found Apr 16 03:37:03.189198 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Apr 16 03:37:03.189207 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Apr 16 03:37:03.189218 kernel: Zone ranges: Apr 16 03:37:03.189228 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 16 03:37:03.189999 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Apr 16 03:37:03.190021 kernel: Normal empty Apr 16 03:37:03.190029 kernel: Movable zone start for each node Apr 16 03:37:03.190038 kernel: Early memory node ranges Apr 16 03:37:03.190046 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Apr 16 03:37:03.190054 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Apr 16 03:37:03.190062 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Apr 16 03:37:03.190071 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Apr 16 03:37:03.190332 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Apr 16 03:37:03.190342 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Apr 16 03:37:03.190352 kernel: ACPI: PM-Timer IO Port: 0x608 Apr 16 03:37:03.190360 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Apr 16 03:37:03.190370 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Apr 16 03:37:03.190379 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Apr 16 03:37:03.190387 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Apr 16 03:37:03.190397 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Apr 16 03:37:03.190407 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Apr 16 03:37:03.190422 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Apr 16 03:37:03.190432 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Apr 16 03:37:03.190440 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Apr 16 03:37:03.190450 kernel: TSC deadline timer available Apr 16 03:37:03.190459 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Apr 16 03:37:03.190468 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Apr 16 03:37:03.190478 kernel: kvm-guest: KVM setup pv remote TLB flush Apr 16 03:37:03.190487 kernel: kvm-guest: setup PV sched yield Apr 16 03:37:03.190497 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Apr 16 03:37:03.190544 kernel: Booting paravirtualized kernel on KVM Apr 16 03:37:03.190553 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Apr 16 03:37:03.190562 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Apr 16 03:37:03.190572 kernel: percpu: Embedded 57 pages/cpu s196328 r8192 d28952 u524288 Apr 16 03:37:03.190580 kernel: pcpu-alloc: s196328 r8192 d28952 u524288 alloc=1*2097152 Apr 16 03:37:03.190590 kernel: pcpu-alloc: [0] 0 1 2 3 Apr 16 03:37:03.190599 kernel: kvm-guest: PV spinlocks enabled Apr 16 03:37:03.190607 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Apr 16 03:37:03.190617 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=27643dbc59f658eac8bb37add3a8b4ed010a3c31134319f01549aa493a1f070c Apr 16 03:37:03.190629 kernel: random: crng init done Apr 16 03:37:03.190638 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 16 03:37:03.190646 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 16 03:37:03.190655 kernel: Fallback order for Node 0: 0 Apr 16 03:37:03.190663 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 Apr 16 03:37:03.190670 kernel: Policy zone: DMA32 Apr 16 03:37:03.190677 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 16 03:37:03.190686 kernel: Memory: 2433648K/2571752K available (12288K kernel code, 2288K rwdata, 22752K rodata, 42896K init, 2300K bss, 137900K reserved, 0K cma-reserved) Apr 16 03:37:03.190695 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 16 03:37:03.190703 kernel: ftrace: allocating 37996 entries in 149 pages Apr 16 03:37:03.190710 kernel: ftrace: allocated 149 pages with 4 groups Apr 16 03:37:03.190718 kernel: Dynamic Preempt: voluntary Apr 16 03:37:03.190725 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 16 03:37:03.190734 kernel: rcu: RCU event tracing is enabled. Apr 16 03:37:03.190742 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Apr 16 03:37:03.190749 kernel: Trampoline variant of Tasks RCU enabled. Apr 16 03:37:03.190757 kernel: Rude variant of Tasks RCU enabled. Apr 16 03:37:03.190766 kernel: Tracing variant of Tasks RCU enabled. Apr 16 03:37:03.190773 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 16 03:37:03.190781 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 16 03:37:03.190788 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Apr 16 03:37:03.190796 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 16 03:37:03.190803 kernel: Console: colour VGA+ 80x25 Apr 16 03:37:03.190811 kernel: printk: console [ttyS0] enabled Apr 16 03:37:03.190819 kernel: ACPI: Core revision 20230628 Apr 16 03:37:03.190826 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Apr 16 03:37:03.190836 kernel: APIC: Switch to symmetric I/O mode setup Apr 16 03:37:03.190843 kernel: x2apic enabled Apr 16 03:37:03.190851 kernel: APIC: Switched APIC routing to: physical x2apic Apr 16 03:37:03.190858 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Apr 16 03:37:03.190866 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Apr 16 03:37:03.190873 kernel: kvm-guest: setup PV IPIs Apr 16 03:37:03.190880 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Apr 16 03:37:03.190888 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Apr 16 03:37:03.190904 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Apr 16 03:37:03.190912 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Apr 16 03:37:03.190920 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Apr 16 03:37:03.190928 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Apr 16 03:37:03.190938 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 16 03:37:03.190946 kernel: Spectre V2 : Mitigation: Retpolines Apr 16 03:37:03.190954 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Apr 16 03:37:03.190962 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Apr 16 03:37:03.190972 kernel: RETBleed: Vulnerable Apr 16 03:37:03.190980 kernel: Speculative Store Bypass: Vulnerable Apr 16 03:37:03.190988 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Apr 16 03:37:03.190996 kernel: GDS: Unknown: Dependent on hypervisor status Apr 16 03:37:03.191005 kernel: active return thunk: its_return_thunk Apr 16 03:37:03.191013 kernel: ITS: Mitigation: Aligned branch/return thunks Apr 16 03:37:03.191021 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Apr 16 03:37:03.191029 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Apr 16 03:37:03.191037 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Apr 16 03:37:03.191047 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Apr 16 03:37:03.191055 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Apr 16 03:37:03.191063 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Apr 16 03:37:03.191071 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Apr 16 03:37:03.191079 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Apr 16 03:37:03.191087 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Apr 16 03:37:03.191095 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Apr 16 03:37:03.191103 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Apr 16 03:37:03.191112 kernel: Freeing SMP alternatives memory: 32K Apr 16 03:37:03.191123 kernel: pid_max: default: 32768 minimum: 301 Apr 16 03:37:03.191132 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 16 03:37:03.191141 kernel: landlock: Up and running. Apr 16 03:37:03.191150 kernel: SELinux: Initializing. Apr 16 03:37:03.191160 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 16 03:37:03.191169 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 16 03:37:03.191178 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Apr 16 03:37:03.191188 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 16 03:37:03.191198 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 16 03:37:03.191211 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 16 03:37:03.191221 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Apr 16 03:37:03.191230 kernel: signal: max sigframe size: 3632 Apr 16 03:37:03.191353 kernel: rcu: Hierarchical SRCU implementation. Apr 16 03:37:03.191363 kernel: rcu: Max phase no-delay instances is 400. Apr 16 03:37:03.191372 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Apr 16 03:37:03.191380 kernel: smp: Bringing up secondary CPUs ... Apr 16 03:37:03.191388 kernel: smpboot: x86: Booting SMP configuration: Apr 16 03:37:03.191396 kernel: .... node #0, CPUs: #1 #2 #3 Apr 16 03:37:03.191411 kernel: smp: Brought up 1 node, 4 CPUs Apr 16 03:37:03.191419 kernel: smpboot: Max logical packages: 1 Apr 16 03:37:03.191428 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Apr 16 03:37:03.191437 kernel: devtmpfs: initialized Apr 16 03:37:03.191445 kernel: x86/mm: Memory block size: 128MB Apr 16 03:37:03.191455 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 16 03:37:03.191463 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 16 03:37:03.191472 kernel: pinctrl core: initialized pinctrl subsystem Apr 16 03:37:03.191481 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 16 03:37:03.191495 kernel: audit: initializing netlink subsys (disabled) Apr 16 03:37:03.191504 kernel: audit: type=2000 audit(1776310621.202:1): state=initialized audit_enabled=0 res=1 Apr 16 03:37:03.191552 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 16 03:37:03.191560 kernel: thermal_sys: Registered thermal governor 'user_space' Apr 16 03:37:03.191569 kernel: cpuidle: using governor menu Apr 16 03:37:03.191577 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 16 03:37:03.191586 kernel: dca service started, version 1.12.1 Apr 16 03:37:03.191594 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Apr 16 03:37:03.191602 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Apr 16 03:37:03.191615 kernel: PCI: Using configuration type 1 for base access Apr 16 03:37:03.191624 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 16 03:37:03.191633 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 16 03:37:03.191642 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Apr 16 03:37:03.191650 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 16 03:37:03.191659 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Apr 16 03:37:03.191668 kernel: ACPI: Added _OSI(Module Device) Apr 16 03:37:03.191677 kernel: ACPI: Added _OSI(Processor Device) Apr 16 03:37:03.191687 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 16 03:37:03.191699 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 16 03:37:03.191708 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Apr 16 03:37:03.191717 kernel: ACPI: Interpreter enabled Apr 16 03:37:03.191726 kernel: ACPI: PM: (supports S0 S3 S5) Apr 16 03:37:03.191735 kernel: ACPI: Using IOAPIC for interrupt routing Apr 16 03:37:03.191744 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 16 03:37:03.191753 kernel: PCI: Using E820 reservations for host bridge windows Apr 16 03:37:03.191763 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Apr 16 03:37:03.191772 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 16 03:37:03.192042 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 16 03:37:03.192143 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Apr 16 03:37:03.192268 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Apr 16 03:37:03.192283 kernel: PCI host bridge to bus 0000:00 Apr 16 03:37:03.192379 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Apr 16 03:37:03.192462 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Apr 16 03:37:03.192589 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Apr 16 03:37:03.192670 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Apr 16 03:37:03.192739 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Apr 16 03:37:03.192816 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Apr 16 03:37:03.192896 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 16 03:37:03.192992 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Apr 16 03:37:03.193089 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Apr 16 03:37:03.193184 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Apr 16 03:37:03.193647 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Apr 16 03:37:03.193744 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Apr 16 03:37:03.193826 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Apr 16 03:37:03.193930 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Apr 16 03:37:03.194181 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Apr 16 03:37:03.194384 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Apr 16 03:37:03.194476 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Apr 16 03:37:03.194624 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Apr 16 03:37:03.194715 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Apr 16 03:37:03.194803 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Apr 16 03:37:03.194883 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Apr 16 03:37:03.194976 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Apr 16 03:37:03.195069 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Apr 16 03:37:03.195153 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Apr 16 03:37:03.195401 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Apr 16 03:37:03.195587 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Apr 16 03:37:03.195687 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Apr 16 03:37:03.195776 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Apr 16 03:37:03.195869 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Apr 16 03:37:03.195958 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Apr 16 03:37:03.196039 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Apr 16 03:37:03.196131 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Apr 16 03:37:03.196217 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Apr 16 03:37:03.196229 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Apr 16 03:37:03.196364 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Apr 16 03:37:03.196375 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Apr 16 03:37:03.196384 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Apr 16 03:37:03.196398 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Apr 16 03:37:03.196406 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Apr 16 03:37:03.196414 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Apr 16 03:37:03.196423 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Apr 16 03:37:03.196431 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Apr 16 03:37:03.196439 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Apr 16 03:37:03.196447 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Apr 16 03:37:03.196455 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Apr 16 03:37:03.196463 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Apr 16 03:37:03.196473 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Apr 16 03:37:03.196482 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Apr 16 03:37:03.196491 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Apr 16 03:37:03.196500 kernel: iommu: Default domain type: Translated Apr 16 03:37:03.196551 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Apr 16 03:37:03.196561 kernel: PCI: Using ACPI for IRQ routing Apr 16 03:37:03.196570 kernel: PCI: pci_cache_line_size set to 64 bytes Apr 16 03:37:03.196579 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Apr 16 03:37:03.196589 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Apr 16 03:37:03.196738 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Apr 16 03:37:03.196832 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Apr 16 03:37:03.196924 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Apr 16 03:37:03.196938 kernel: vgaarb: loaded Apr 16 03:37:03.196949 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Apr 16 03:37:03.196959 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Apr 16 03:37:03.196969 kernel: clocksource: Switched to clocksource kvm-clock Apr 16 03:37:03.196980 kernel: VFS: Disk quotas dquot_6.6.0 Apr 16 03:37:03.196994 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 16 03:37:03.197005 kernel: pnp: PnP ACPI init Apr 16 03:37:03.197136 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Apr 16 03:37:03.197150 kernel: pnp: PnP ACPI: found 6 devices Apr 16 03:37:03.197179 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 16 03:37:03.197189 kernel: NET: Registered PF_INET protocol family Apr 16 03:37:03.197199 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 16 03:37:03.197210 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 16 03:37:03.197261 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 16 03:37:03.197307 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 16 03:37:03.197333 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 16 03:37:03.197372 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 16 03:37:03.197383 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 16 03:37:03.197393 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 16 03:37:03.197404 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 16 03:37:03.197414 kernel: NET: Registered PF_XDP protocol family Apr 16 03:37:03.197554 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Apr 16 03:37:03.197645 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Apr 16 03:37:03.197726 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Apr 16 03:37:03.197807 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Apr 16 03:37:03.197888 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Apr 16 03:37:03.197972 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Apr 16 03:37:03.197986 kernel: PCI: CLS 0 bytes, default 64 Apr 16 03:37:03.197996 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Apr 16 03:37:03.198007 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Apr 16 03:37:03.198018 kernel: Initialise system trusted keyrings Apr 16 03:37:03.198031 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 16 03:37:03.198041 kernel: Key type asymmetric registered Apr 16 03:37:03.198052 kernel: Asymmetric key parser 'x509' registered Apr 16 03:37:03.198062 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Apr 16 03:37:03.198072 kernel: io scheduler mq-deadline registered Apr 16 03:37:03.198081 kernel: io scheduler kyber registered Apr 16 03:37:03.198091 kernel: io scheduler bfq registered Apr 16 03:37:03.198101 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Apr 16 03:37:03.198112 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Apr 16 03:37:03.198125 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Apr 16 03:37:03.198136 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Apr 16 03:37:03.198145 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 16 03:37:03.198155 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 16 03:37:03.198166 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Apr 16 03:37:03.198175 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Apr 16 03:37:03.198185 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Apr 16 03:37:03.198384 kernel: rtc_cmos 00:04: RTC can wake from S4 Apr 16 03:37:03.198493 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Apr 16 03:37:03.198892 kernel: rtc_cmos 00:04: registered as rtc0 Apr 16 03:37:03.198988 kernel: rtc_cmos 00:04: setting system clock to 2026-04-16T03:37:02 UTC (1776310622) Apr 16 03:37:03.199138 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Apr 16 03:37:03.199154 kernel: intel_pstate: CPU model not supported Apr 16 03:37:03.199164 kernel: NET: Registered PF_INET6 protocol family Apr 16 03:37:03.199173 kernel: Segment Routing with IPv6 Apr 16 03:37:03.199183 kernel: In-situ OAM (IOAM) with IPv6 Apr 16 03:37:03.199194 kernel: NET: Registered PF_PACKET protocol family Apr 16 03:37:03.199208 kernel: Key type dns_resolver registered Apr 16 03:37:03.199218 kernel: IPI shorthand broadcast: enabled Apr 16 03:37:03.199228 kernel: sched_clock: Marking stable (1882084575, 420539848)->(2592558675, -289934252) Apr 16 03:37:03.199267 kernel: registered taskstats version 1 Apr 16 03:37:03.199277 kernel: Loading compiled-in X.509 certificates Apr 16 03:37:03.199286 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.127-flatcar: 6e6d886174c86dc730e1b14e46a1dab518d9b090' Apr 16 03:37:03.199296 kernel: Key type .fscrypt registered Apr 16 03:37:03.199305 kernel: Key type fscrypt-provisioning registered Apr 16 03:37:03.199315 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 16 03:37:03.199328 kernel: ima: Allocated hash algorithm: sha1 Apr 16 03:37:03.199337 kernel: ima: No architecture policies found Apr 16 03:37:03.199346 kernel: clk: Disabling unused clocks Apr 16 03:37:03.199356 kernel: Freeing unused kernel image (initmem) memory: 42896K Apr 16 03:37:03.199367 kernel: Write protecting the kernel read-only data: 36864k Apr 16 03:37:03.199377 kernel: Freeing unused kernel image (rodata/data gap) memory: 1824K Apr 16 03:37:03.199387 kernel: Run /init as init process Apr 16 03:37:03.199396 kernel: with arguments: Apr 16 03:37:03.199405 kernel: /init Apr 16 03:37:03.199416 kernel: with environment: Apr 16 03:37:03.199426 kernel: HOME=/ Apr 16 03:37:03.199436 kernel: TERM=linux Apr 16 03:37:03.199449 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) Apr 16 03:37:03.199462 systemd[1]: Detected virtualization kvm. Apr 16 03:37:03.199473 systemd[1]: Detected architecture x86-64. Apr 16 03:37:03.199484 systemd[1]: Running in initrd. Apr 16 03:37:03.199494 systemd[1]: No hostname configured, using default hostname. Apr 16 03:37:03.199546 systemd[1]: Hostname set to . Apr 16 03:37:03.199560 systemd[1]: Initializing machine ID from VM UUID. Apr 16 03:37:03.199571 systemd[1]: Queued start job for default target initrd.target. Apr 16 03:37:03.199582 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 16 03:37:03.199593 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 16 03:37:03.199606 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 16 03:37:03.199617 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 16 03:37:03.199628 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 16 03:37:03.199644 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 16 03:37:03.199671 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 16 03:37:03.199683 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 16 03:37:03.199694 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 16 03:37:03.199708 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 16 03:37:03.199720 systemd[1]: Reached target paths.target - Path Units. Apr 16 03:37:03.199731 systemd[1]: Reached target slices.target - Slice Units. Apr 16 03:37:03.199742 systemd[1]: Reached target swap.target - Swaps. Apr 16 03:37:03.199754 systemd[1]: Reached target timers.target - Timer Units. Apr 16 03:37:03.199765 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 16 03:37:03.199777 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 16 03:37:03.199789 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 16 03:37:03.199800 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 16 03:37:03.199813 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 16 03:37:03.199826 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 16 03:37:03.199837 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 16 03:37:03.199849 systemd[1]: Reached target sockets.target - Socket Units. Apr 16 03:37:03.199861 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 16 03:37:03.199872 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 16 03:37:03.199884 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 16 03:37:03.199895 systemd[1]: Starting systemd-fsck-usr.service... Apr 16 03:37:03.199909 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 16 03:37:03.199920 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 16 03:37:03.199932 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 16 03:37:03.199943 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 16 03:37:03.199982 systemd-journald[195]: Collecting audit messages is disabled. Apr 16 03:37:03.200015 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 16 03:37:03.200026 systemd[1]: Finished systemd-fsck-usr.service. Apr 16 03:37:03.200044 systemd-journald[195]: Journal started Apr 16 03:37:03.200071 systemd-journald[195]: Runtime Journal (/run/log/journal/0e5dc27a31a64989b21e6c57bba1c55b) is 6.0M, max 48.4M, 42.3M free. Apr 16 03:37:03.199161 systemd-modules-load[196]: Inserted module 'overlay' Apr 16 03:37:03.214154 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 16 03:37:03.220930 systemd[1]: Started systemd-journald.service - Journal Service. Apr 16 03:37:03.223181 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 16 03:37:03.278712 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 16 03:37:03.281633 kernel: Bridge firewalling registered Apr 16 03:37:03.281668 systemd-modules-load[196]: Inserted module 'br_netfilter' Apr 16 03:37:03.282980 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 16 03:37:03.453298 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 16 03:37:03.459762 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 16 03:37:03.466109 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 16 03:37:03.471203 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 16 03:37:03.480918 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 16 03:37:03.487298 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 16 03:37:03.494409 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 16 03:37:03.521484 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 16 03:37:03.583885 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 16 03:37:03.586160 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 16 03:37:03.597682 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 16 03:37:03.605312 dracut-cmdline[227]: dracut-dracut-053 Apr 16 03:37:03.610470 dracut-cmdline[227]: 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=27643dbc59f658eac8bb37add3a8b4ed010a3c31134319f01549aa493a1f070c Apr 16 03:37:03.651373 systemd-resolved[233]: Positive Trust Anchors: Apr 16 03:37:03.651407 systemd-resolved[233]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 16 03:37:03.651448 systemd-resolved[233]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 16 03:37:03.653793 systemd-resolved[233]: Defaulting to hostname 'linux'. Apr 16 03:37:03.674399 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 16 03:37:03.677450 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 16 03:37:03.735664 kernel: SCSI subsystem initialized Apr 16 03:37:03.745658 kernel: Loading iSCSI transport class v2.0-870. Apr 16 03:37:03.757896 kernel: iscsi: registered transport (tcp) Apr 16 03:37:03.789967 kernel: iscsi: registered transport (qla4xxx) Apr 16 03:37:03.790136 kernel: QLogic iSCSI HBA Driver Apr 16 03:37:03.911206 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 16 03:37:03.935459 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 16 03:37:03.976551 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 16 03:37:03.976663 kernel: device-mapper: uevent: version 1.0.3 Apr 16 03:37:03.976687 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 16 03:37:04.033947 kernel: raid6: avx512x4 gen() 36793 MB/s Apr 16 03:37:04.050742 kernel: raid6: avx512x2 gen() 35739 MB/s Apr 16 03:37:04.068886 kernel: raid6: avx512x1 gen() 44412 MB/s Apr 16 03:37:04.086703 kernel: raid6: avx2x4 gen() 31417 MB/s Apr 16 03:37:04.104828 kernel: raid6: avx2x2 gen() 30484 MB/s Apr 16 03:37:04.123327 kernel: raid6: avx2x1 gen() 25375 MB/s Apr 16 03:37:04.123551 kernel: raid6: using algorithm avx512x1 gen() 44412 MB/s Apr 16 03:37:04.143165 kernel: raid6: .... xor() 21024 MB/s, rmw enabled Apr 16 03:37:04.143281 kernel: raid6: using avx512x2 recovery algorithm Apr 16 03:37:04.169672 kernel: xor: automatically using best checksumming function avx Apr 16 03:37:04.286202 kernel: hrtimer: interrupt took 11208899 ns Apr 16 03:37:04.418691 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 16 03:37:04.433762 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 16 03:37:04.446777 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 16 03:37:04.464384 systemd-udevd[413]: Using default interface naming scheme 'v255'. Apr 16 03:37:04.471043 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 16 03:37:04.483709 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 16 03:37:04.497572 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Apr 16 03:37:04.534347 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 16 03:37:04.555930 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 16 03:37:04.679708 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 16 03:37:04.693907 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 16 03:37:04.710435 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 16 03:37:04.717035 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 16 03:37:04.722614 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 16 03:37:04.729085 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 16 03:37:04.744581 kernel: cryptd: max_cpu_qlen set to 1000 Apr 16 03:37:04.746745 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 16 03:37:04.752689 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Apr 16 03:37:04.762696 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 16 03:37:04.774949 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Apr 16 03:37:04.782563 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 16 03:37:04.782678 kernel: AVX2 version of gcm_enc/dec engaged. Apr 16 03:37:04.785395 kernel: AES CTR mode by8 optimization enabled Apr 16 03:37:04.789885 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 16 03:37:04.791313 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 16 03:37:04.796220 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 16 03:37:04.798432 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 16 03:37:04.817500 kernel: BTRFS: device fsid 936fcbd8-a8ab-4e87-b115-d77c7a08e984 devid 1 transid 34 /dev/vda3 scanned by (udev-worker) (467) Apr 16 03:37:04.802410 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 16 03:37:04.808589 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 16 03:37:04.886619 kernel: libata version 3.00 loaded. Apr 16 03:37:04.886837 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 16 03:37:04.894974 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (466) Apr 16 03:37:04.902434 kernel: ahci 0000:00:1f.2: version 3.0 Apr 16 03:37:04.902932 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Apr 16 03:37:04.909614 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Apr 16 03:37:04.909989 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Apr 16 03:37:04.912544 kernel: scsi host0: ahci Apr 16 03:37:04.917557 kernel: scsi host1: ahci Apr 16 03:37:04.920790 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Apr 16 03:37:04.922632 kernel: scsi host2: ahci Apr 16 03:37:04.928185 kernel: scsi host3: ahci Apr 16 03:37:04.934111 kernel: scsi host4: ahci Apr 16 03:37:04.934406 kernel: scsi host5: ahci Apr 16 03:37:04.934560 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Apr 16 03:37:04.936422 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Apr 16 03:37:04.940331 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Apr 16 03:37:04.940454 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Apr 16 03:37:04.944156 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Apr 16 03:37:04.944338 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Apr 16 03:37:04.953604 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Apr 16 03:37:05.080230 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 16 03:37:05.081534 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 16 03:37:05.093230 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Apr 16 03:37:05.094375 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Apr 16 03:37:05.115310 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 16 03:37:05.121483 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 16 03:37:05.138571 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 16 03:37:05.146640 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 16 03:37:05.151660 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 16 03:37:05.166592 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 16 03:37:05.257579 kernel: ata4: SATA link down (SStatus 0 SControl 300) Apr 16 03:37:05.257693 kernel: ata1: SATA link down (SStatus 0 SControl 300) Apr 16 03:37:05.257706 kernel: ata5: SATA link down (SStatus 0 SControl 300) Apr 16 03:37:05.259571 kernel: ata2: SATA link down (SStatus 0 SControl 300) Apr 16 03:37:05.262573 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Apr 16 03:37:05.263586 kernel: ata6: SATA link down (SStatus 0 SControl 300) Apr 16 03:37:05.265784 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Apr 16 03:37:05.268458 kernel: ata3.00: applying bridge limits Apr 16 03:37:05.270550 kernel: ata3.00: configured for UDMA/100 Apr 16 03:37:05.277810 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Apr 16 03:37:05.324940 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Apr 16 03:37:05.325411 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Apr 16 03:37:05.365583 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Apr 16 03:37:06.153393 disk-uuid[568]: The operation has completed successfully. Apr 16 03:37:06.156133 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 16 03:37:06.181064 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 16 03:37:06.181211 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 16 03:37:06.235577 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 16 03:37:06.241560 sh[593]: Success Apr 16 03:37:06.263678 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Apr 16 03:37:06.316674 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 16 03:37:06.332797 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 16 03:37:06.338476 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 16 03:37:06.353570 kernel: BTRFS info (device dm-0): first mount of filesystem 936fcbd8-a8ab-4e87-b115-d77c7a08e984 Apr 16 03:37:06.353691 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Apr 16 03:37:06.353720 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 16 03:37:06.356046 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 16 03:37:06.359017 kernel: BTRFS info (device dm-0): using free space tree Apr 16 03:37:06.366941 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 16 03:37:06.372883 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 16 03:37:06.379820 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 16 03:37:06.386097 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 16 03:37:06.413666 kernel: BTRFS info (device vda6): first mount of filesystem 90718864-f2fc-45a7-9234-85fc9574bf9c Apr 16 03:37:06.413837 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 16 03:37:06.413847 kernel: BTRFS info (device vda6): using free space tree Apr 16 03:37:06.462786 kernel: BTRFS info (device vda6): auto enabling async discard Apr 16 03:37:06.478821 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 16 03:37:06.484764 kernel: BTRFS info (device vda6): last unmount of filesystem 90718864-f2fc-45a7-9234-85fc9574bf9c Apr 16 03:37:06.494498 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 16 03:37:06.506058 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 16 03:37:06.584662 ignition[683]: Ignition 2.19.0 Apr 16 03:37:06.584697 ignition[683]: Stage: fetch-offline Apr 16 03:37:06.584733 ignition[683]: no configs at "/usr/lib/ignition/base.d" Apr 16 03:37:06.584742 ignition[683]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 16 03:37:06.584871 ignition[683]: parsed url from cmdline: "" Apr 16 03:37:06.584875 ignition[683]: no config URL provided Apr 16 03:37:06.584881 ignition[683]: reading system config file "/usr/lib/ignition/user.ign" Apr 16 03:37:06.584888 ignition[683]: no config at "/usr/lib/ignition/user.ign" Apr 16 03:37:06.584918 ignition[683]: op(1): [started] loading QEMU firmware config module Apr 16 03:37:06.584924 ignition[683]: op(1): executing: "modprobe" "qemu_fw_cfg" Apr 16 03:37:06.607273 ignition[683]: op(1): [finished] loading QEMU firmware config module Apr 16 03:37:06.607311 ignition[683]: QEMU firmware config was not found. Ignoring... Apr 16 03:37:06.609374 ignition[683]: parsing config with SHA512: 635bf49bdd835328451c4fe43f33c8220cb107932a41d6b1781dc664a35093ad2b6a8b73bc9fab51c62fb54a93f55ea1e7943c4e68bc48e7e5b8ed39962b39ae Apr 16 03:37:06.623752 unknown[683]: fetched base config from "system" Apr 16 03:37:06.623825 unknown[683]: fetched user config from "qemu" Apr 16 03:37:06.624434 ignition[683]: fetch-offline: fetch-offline passed Apr 16 03:37:06.624930 ignition[683]: Ignition finished successfully Apr 16 03:37:06.687907 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 16 03:37:06.735300 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 16 03:37:06.749981 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 16 03:37:06.816329 systemd-networkd[782]: lo: Link UP Apr 16 03:37:06.816354 systemd-networkd[782]: lo: Gained carrier Apr 16 03:37:06.818675 systemd-networkd[782]: Enumeration completed Apr 16 03:37:06.818936 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 16 03:37:06.819994 systemd-networkd[782]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 16 03:37:06.819997 systemd-networkd[782]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 16 03:37:06.821690 systemd[1]: Reached target network.target - Network. Apr 16 03:37:06.821749 systemd-networkd[782]: eth0: Link UP Apr 16 03:37:06.821752 systemd-networkd[782]: eth0: Gained carrier Apr 16 03:37:06.821761 systemd-networkd[782]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 16 03:37:06.821778 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Apr 16 03:37:06.882878 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 16 03:37:06.900750 systemd-networkd[782]: eth0: DHCPv4 address 10.0.0.3/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 16 03:37:06.916505 ignition[784]: Ignition 2.19.0 Apr 16 03:37:06.916572 ignition[784]: Stage: kargs Apr 16 03:37:06.916859 ignition[784]: no configs at "/usr/lib/ignition/base.d" Apr 16 03:37:06.916874 ignition[784]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 16 03:37:06.918380 ignition[784]: kargs: kargs passed Apr 16 03:37:06.918464 ignition[784]: Ignition finished successfully Apr 16 03:37:06.951150 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 16 03:37:06.970910 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 16 03:37:06.994428 ignition[793]: Ignition 2.19.0 Apr 16 03:37:06.994642 ignition[793]: Stage: disks Apr 16 03:37:06.999947 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 16 03:37:06.994868 ignition[793]: no configs at "/usr/lib/ignition/base.d" Apr 16 03:37:07.003065 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 16 03:37:06.994879 ignition[793]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 16 03:37:07.008854 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 16 03:37:06.995880 ignition[793]: disks: disks passed Apr 16 03:37:07.018995 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 16 03:37:06.995939 ignition[793]: Ignition finished successfully Apr 16 03:37:07.024968 systemd[1]: Reached target sysinit.target - System Initialization. Apr 16 03:37:07.026371 systemd[1]: Reached target basic.target - Basic System. Apr 16 03:37:07.049655 systemd-resolved[233]: Detected conflict on linux IN A 10.0.0.3 Apr 16 03:37:07.049854 systemd-resolved[233]: Hostname conflict, changing published hostname from 'linux' to 'linux7'. Apr 16 03:37:07.052149 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 16 03:37:07.085959 systemd-fsck[802]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 16 03:37:07.097998 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 16 03:37:07.119636 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 16 03:37:07.315854 kernel: EXT4-fs (vda9): mounted filesystem 9ac74074-8829-477f-a4c4-5563740ec49b r/w with ordered data mode. Quota mode: none. Apr 16 03:37:07.317964 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 16 03:37:07.323888 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 16 03:37:07.350119 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 16 03:37:07.370726 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 16 03:37:07.374158 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 16 03:37:07.393646 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (810) Apr 16 03:37:07.374311 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 16 03:37:07.417016 kernel: BTRFS info (device vda6): first mount of filesystem 90718864-f2fc-45a7-9234-85fc9574bf9c Apr 16 03:37:07.417057 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 16 03:37:07.417071 kernel: BTRFS info (device vda6): using free space tree Apr 16 03:37:07.374344 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 16 03:37:07.383021 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 16 03:37:07.396226 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 16 03:37:07.471967 kernel: BTRFS info (device vda6): auto enabling async discard Apr 16 03:37:07.475079 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 16 03:37:07.572087 initrd-setup-root[834]: cut: /sysroot/etc/passwd: No such file or directory Apr 16 03:37:07.591573 initrd-setup-root[841]: cut: /sysroot/etc/group: No such file or directory Apr 16 03:37:07.607676 initrd-setup-root[848]: cut: /sysroot/etc/shadow: No such file or directory Apr 16 03:37:07.617185 initrd-setup-root[855]: cut: /sysroot/etc/gshadow: No such file or directory Apr 16 03:37:07.889947 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 16 03:37:07.900097 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 16 03:37:07.921074 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 16 03:37:07.956408 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 16 03:37:07.960988 kernel: BTRFS info (device vda6): last unmount of filesystem 90718864-f2fc-45a7-9234-85fc9574bf9c Apr 16 03:37:07.987052 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 16 03:37:08.017284 ignition[923]: INFO : Ignition 2.19.0 Apr 16 03:37:08.017284 ignition[923]: INFO : Stage: mount Apr 16 03:37:08.024922 ignition[923]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 16 03:37:08.024922 ignition[923]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 16 03:37:08.024922 ignition[923]: INFO : mount: mount passed Apr 16 03:37:08.024922 ignition[923]: INFO : Ignition finished successfully Apr 16 03:37:08.031421 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 16 03:37:08.051944 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 16 03:37:08.073226 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 16 03:37:08.130157 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (935) Apr 16 03:37:08.163863 kernel: BTRFS info (device vda6): first mount of filesystem 90718864-f2fc-45a7-9234-85fc9574bf9c Apr 16 03:37:08.168048 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 16 03:37:08.168349 kernel: BTRFS info (device vda6): using free space tree Apr 16 03:37:08.186730 kernel: BTRFS info (device vda6): auto enabling async discard Apr 16 03:37:08.197942 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 16 03:37:08.250850 ignition[952]: INFO : Ignition 2.19.0 Apr 16 03:37:08.250850 ignition[952]: INFO : Stage: files Apr 16 03:37:08.250850 ignition[952]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 16 03:37:08.250850 ignition[952]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 16 03:37:08.277784 ignition[952]: DEBUG : files: compiled without relabeling support, skipping Apr 16 03:37:08.277784 ignition[952]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 16 03:37:08.277784 ignition[952]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 16 03:37:08.300749 ignition[952]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 16 03:37:08.305444 ignition[952]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 16 03:37:08.310023 unknown[952]: wrote ssh authorized keys file for user: core Apr 16 03:37:08.313205 ignition[952]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 16 03:37:08.318162 ignition[952]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 16 03:37:08.323928 ignition[952]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(4): [started] processing unit "etcd-member.service" Apr 16 03:37:08.323928 ignition[952]: 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" Apr 16 03:37:08.323928 ignition[952]: 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" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Apr 16 03:37:08.323928 ignition[952]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Apr 16 03:37:08.455365 ignition[952]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Apr 16 03:37:08.465373 ignition[952]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Apr 16 03:37:08.465373 ignition[952]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Apr 16 03:37:08.465373 ignition[952]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Apr 16 03:37:08.465373 ignition[952]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Apr 16 03:37:08.465373 ignition[952]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 16 03:37:08.487670 ignition[952]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 16 03:37:08.487670 ignition[952]: INFO : files: files passed Apr 16 03:37:08.487670 ignition[952]: INFO : Ignition finished successfully Apr 16 03:37:08.485074 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 16 03:37:08.518745 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 16 03:37:08.527383 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 16 03:37:08.534144 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 16 03:37:08.534341 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 16 03:37:08.549466 initrd-setup-root-after-ignition[981]: grep: /sysroot/oem/oem-release: No such file or directory Apr 16 03:37:08.557313 initrd-setup-root-after-ignition[983]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 16 03:37:08.557313 initrd-setup-root-after-ignition[983]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 16 03:37:08.563288 initrd-setup-root-after-ignition[987]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 16 03:37:08.561861 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 16 03:37:08.568206 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 16 03:37:08.585593 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 16 03:37:08.708117 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 16 03:37:08.712567 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 16 03:37:08.719490 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 16 03:37:08.723160 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 16 03:37:08.728153 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 16 03:37:08.739070 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 16 03:37:08.770394 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 16 03:37:08.779904 systemd-networkd[782]: eth0: Gained IPv6LL Apr 16 03:37:08.800817 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 16 03:37:08.820210 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 16 03:37:08.822414 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 16 03:37:08.875946 systemd[1]: Stopped target timers.target - Timer Units. Apr 16 03:37:08.882374 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 16 03:37:08.883020 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 16 03:37:08.891454 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 16 03:37:08.892920 systemd[1]: Stopped target basic.target - Basic System. Apr 16 03:37:08.900398 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 16 03:37:08.901787 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 16 03:37:08.911254 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 16 03:37:08.913844 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 16 03:37:08.915210 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 16 03:37:08.923889 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 16 03:37:08.938653 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 16 03:37:08.942774 systemd[1]: Stopped target swap.target - Swaps. Apr 16 03:37:08.949386 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 16 03:37:08.950066 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 16 03:37:08.954622 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 16 03:37:08.956093 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 16 03:37:08.960478 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 16 03:37:08.961074 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 16 03:37:08.965227 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 16 03:37:08.965948 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 16 03:37:08.977156 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 16 03:37:08.977495 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 16 03:37:08.988008 systemd[1]: Stopped target paths.target - Path Units. Apr 16 03:37:08.992913 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 16 03:37:08.996753 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 16 03:37:09.000771 systemd[1]: Stopped target slices.target - Slice Units. Apr 16 03:37:09.005357 systemd[1]: Stopped target sockets.target - Socket Units. Apr 16 03:37:09.009709 systemd[1]: iscsid.socket: Deactivated successfully. Apr 16 03:37:09.009963 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 16 03:37:09.018442 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 16 03:37:09.018894 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 16 03:37:09.028342 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 16 03:37:09.028843 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 16 03:37:09.029500 systemd[1]: ignition-files.service: Deactivated successfully. Apr 16 03:37:09.030148 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 16 03:37:09.061173 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 16 03:37:09.068597 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 16 03:37:09.070691 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 16 03:37:09.071027 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 16 03:37:09.075154 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 16 03:37:09.090098 ignition[1007]: INFO : Ignition 2.19.0 Apr 16 03:37:09.090098 ignition[1007]: INFO : Stage: umount Apr 16 03:37:09.090098 ignition[1007]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 16 03:37:09.090098 ignition[1007]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 16 03:37:09.090098 ignition[1007]: INFO : umount: umount passed Apr 16 03:37:09.090098 ignition[1007]: INFO : Ignition finished successfully Apr 16 03:37:09.076438 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 16 03:37:09.098207 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 16 03:37:09.098919 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 16 03:37:09.104927 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 16 03:37:09.105470 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 16 03:37:09.113369 systemd[1]: Stopped target network.target - Network. Apr 16 03:37:09.116102 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 16 03:37:09.116325 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 16 03:37:09.124907 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 16 03:37:09.125054 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 16 03:37:09.125171 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 16 03:37:09.125207 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 16 03:37:09.165982 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 16 03:37:09.166187 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 16 03:37:09.167310 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 16 03:37:09.180924 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 16 03:37:09.195384 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 16 03:37:09.197744 systemd-networkd[782]: eth0: DHCPv6 lease lost Apr 16 03:37:09.200992 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 16 03:37:09.201711 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 16 03:37:09.203836 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 16 03:37:09.203973 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 16 03:37:09.212987 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 16 03:37:09.213059 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 16 03:37:09.229481 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 16 03:37:09.237043 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 16 03:37:09.237611 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 16 03:37:09.238998 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 16 03:37:09.239053 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 16 03:37:09.251179 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 16 03:37:09.251497 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 16 03:37:09.257845 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 16 03:37:09.257989 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 16 03:37:09.259599 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 16 03:37:09.270102 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 16 03:37:09.270944 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 16 03:37:09.279477 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 16 03:37:09.279632 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 16 03:37:09.315428 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 16 03:37:09.317807 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 16 03:37:09.370489 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 16 03:37:09.371544 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 16 03:37:09.383984 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 16 03:37:09.384069 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 16 03:37:09.385140 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 16 03:37:09.385244 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 16 03:37:09.397051 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 16 03:37:09.397203 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 16 03:37:09.405783 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 16 03:37:09.405932 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 16 03:37:09.409740 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 16 03:37:09.410072 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 16 03:37:09.440833 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 16 03:37:09.446309 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 16 03:37:09.446438 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 16 03:37:09.447645 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Apr 16 03:37:09.447725 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 16 03:37:09.447945 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 16 03:37:09.448024 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 16 03:37:09.465808 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 16 03:37:09.465923 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 16 03:37:09.472916 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 16 03:37:09.473025 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 16 03:37:09.477239 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 16 03:37:09.484387 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 16 03:37:09.511964 systemd[1]: Switching root. Apr 16 03:37:09.606212 systemd-journald[195]: Journal stopped Apr 16 03:37:10.814925 systemd-journald[195]: Received SIGTERM from PID 1 (systemd). Apr 16 03:37:10.815008 kernel: SELinux: policy capability network_peer_controls=1 Apr 16 03:37:10.815028 kernel: SELinux: policy capability open_perms=1 Apr 16 03:37:10.815044 kernel: SELinux: policy capability extended_socket_class=1 Apr 16 03:37:10.815056 kernel: SELinux: policy capability always_check_network=0 Apr 16 03:37:10.815068 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 16 03:37:10.815080 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 16 03:37:10.815091 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 16 03:37:10.815101 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 16 03:37:10.815111 kernel: audit: type=1403 audit(1776310629.722:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 16 03:37:10.815125 systemd[1]: Successfully loaded SELinux policy in 53.148ms. Apr 16 03:37:10.815148 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 14.739ms. Apr 16 03:37:10.815161 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) Apr 16 03:37:10.815174 systemd[1]: Detected virtualization kvm. Apr 16 03:37:10.815186 systemd[1]: Detected architecture x86-64. Apr 16 03:37:10.815198 systemd[1]: Detected first boot. Apr 16 03:37:10.815211 systemd[1]: Initializing machine ID from VM UUID. Apr 16 03:37:10.815222 zram_generator::config[1053]: No configuration found. Apr 16 03:37:10.815240 systemd[1]: Populated /etc with preset unit settings. Apr 16 03:37:10.815252 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 16 03:37:10.815264 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 16 03:37:10.815412 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 16 03:37:10.815430 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 16 03:37:10.815445 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 16 03:37:10.815465 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 16 03:37:10.815478 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 16 03:37:10.815491 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 16 03:37:10.815653 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 16 03:37:10.815721 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 16 03:37:10.815729 systemd[1]: Created slice user.slice - User and Session Slice. Apr 16 03:37:10.815738 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 16 03:37:10.815747 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 16 03:37:10.815758 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 16 03:37:10.815770 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 16 03:37:10.815783 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 16 03:37:10.815795 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 16 03:37:10.815809 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 16 03:37:10.815823 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 16 03:37:10.815837 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 16 03:37:10.815852 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 16 03:37:10.815866 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 16 03:37:10.815881 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 16 03:37:10.815893 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 16 03:37:10.815907 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 16 03:37:10.815920 systemd[1]: Reached target slices.target - Slice Units. Apr 16 03:37:10.815934 systemd[1]: Reached target swap.target - Swaps. Apr 16 03:37:10.815943 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 16 03:37:10.815951 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 16 03:37:10.815959 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 16 03:37:10.815969 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 16 03:37:10.815976 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 16 03:37:10.815984 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 16 03:37:10.815993 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 16 03:37:10.816001 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 16 03:37:10.816009 systemd[1]: Mounting media.mount - External Media Directory... Apr 16 03:37:10.816017 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:10.816028 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 16 03:37:10.816038 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 16 03:37:10.816051 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 16 03:37:10.816059 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Apr 16 03:37:10.816069 systemd[1]: Reached target machines.target - Containers. Apr 16 03:37:10.816076 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 16 03:37:10.816085 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 16 03:37:10.816092 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 16 03:37:10.816100 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 16 03:37:10.816108 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 16 03:37:10.816117 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 16 03:37:10.816125 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 16 03:37:10.816132 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 16 03:37:10.816140 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 16 03:37:10.816148 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 16 03:37:10.816155 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 16 03:37:10.816165 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 16 03:37:10.816177 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 16 03:37:10.816188 systemd[1]: Stopped systemd-fsck-usr.service. Apr 16 03:37:10.816195 kernel: fuse: init (API version 7.39) Apr 16 03:37:10.816208 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 16 03:37:10.816225 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 16 03:37:10.816232 kernel: ACPI: bus type drm_connector registered Apr 16 03:37:10.816647 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 16 03:37:10.816706 kernel: loop: module loaded Apr 16 03:37:10.816752 systemd-journald[1137]: Collecting audit messages is disabled. Apr 16 03:37:10.816784 systemd-journald[1137]: Journal started Apr 16 03:37:10.816809 systemd-journald[1137]: Runtime Journal (/run/log/journal/0e5dc27a31a64989b21e6c57bba1c55b) is 6.0M, max 48.4M, 42.3M free. Apr 16 03:37:10.314426 systemd[1]: Queued start job for default target multi-user.target. Apr 16 03:37:10.345436 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Apr 16 03:37:10.346222 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 16 03:37:10.346963 systemd[1]: systemd-journald.service: Consumed 1.223s CPU time. Apr 16 03:37:10.822575 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 16 03:37:10.829955 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 16 03:37:10.835300 systemd[1]: verity-setup.service: Deactivated successfully. Apr 16 03:37:10.835391 systemd[1]: Stopped verity-setup.service. Apr 16 03:37:10.843792 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:10.849037 systemd[1]: Started systemd-journald.service - Journal Service. Apr 16 03:37:10.853668 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 16 03:37:10.857620 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 16 03:37:10.860932 systemd[1]: Mounted media.mount - External Media Directory. Apr 16 03:37:10.864022 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 16 03:37:10.867163 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 16 03:37:10.869882 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 16 03:37:10.873837 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 16 03:37:10.877795 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 16 03:37:10.881972 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 16 03:37:10.882410 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 16 03:37:10.887206 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 16 03:37:10.887656 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 16 03:37:10.891220 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 16 03:37:10.892454 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 16 03:37:10.895970 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 16 03:37:10.896174 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 16 03:37:10.900829 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 16 03:37:10.901489 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 16 03:37:10.906948 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 16 03:37:10.907181 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 16 03:37:10.911486 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 16 03:37:10.916310 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 16 03:37:10.921232 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 16 03:37:11.005407 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 16 03:37:11.019102 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 16 03:37:11.036580 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 16 03:37:11.042366 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 16 03:37:11.045439 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 16 03:37:11.045498 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 16 03:37:11.048653 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 16 03:37:11.052916 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 16 03:37:11.057475 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 16 03:37:11.059955 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 16 03:37:11.065740 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 16 03:37:11.069473 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 16 03:37:11.072362 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 16 03:37:11.077029 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 16 03:37:11.078146 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 16 03:37:11.080063 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 16 03:37:11.086881 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 16 03:37:11.101027 systemd-journald[1137]: Time spent on flushing to /var/log/journal/0e5dc27a31a64989b21e6c57bba1c55b is 62.520ms for 932 entries. Apr 16 03:37:11.101027 systemd-journald[1137]: System Journal (/var/log/journal/0e5dc27a31a64989b21e6c57bba1c55b) is 8.0M, max 195.6M, 187.6M free. Apr 16 03:37:11.208260 systemd-journald[1137]: Received client request to flush runtime journal. Apr 16 03:37:11.208850 kernel: loop0: detected capacity change from 0 to 142488 Apr 16 03:37:11.208885 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 16 03:37:11.099057 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 16 03:37:11.115249 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 16 03:37:11.121186 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 16 03:37:11.125199 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 16 03:37:11.132111 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 16 03:37:11.137197 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 16 03:37:11.150720 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 16 03:37:11.163874 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 16 03:37:11.170963 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 16 03:37:11.177564 udevadm[1170]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Apr 16 03:37:11.179615 systemd-tmpfiles[1169]: ACLs are not supported, ignoring. Apr 16 03:37:11.179630 systemd-tmpfiles[1169]: ACLs are not supported, ignoring. Apr 16 03:37:11.193661 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 16 03:37:11.208897 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 16 03:37:11.214685 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 16 03:37:11.221338 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 16 03:37:11.222429 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 16 03:37:11.233826 kernel: loop1: detected capacity change from 0 to 140768 Apr 16 03:37:11.264141 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 16 03:37:12.362812 kernel: clocksource: Long readout interval, skipping watchdog check: cs_nsec: 1101867803 wd_nsec: 1101867810 Apr 16 03:37:12.370058 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 16 03:37:12.400708 kernel: loop2: detected capacity change from 0 to 142488 Apr 16 03:37:12.457130 kernel: loop3: detected capacity change from 0 to 140768 Apr 16 03:37:12.455066 systemd-tmpfiles[1190]: ACLs are not supported, ignoring. Apr 16 03:37:12.455089 systemd-tmpfiles[1190]: ACLs are not supported, ignoring. Apr 16 03:37:12.464902 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 16 03:37:12.499243 (sd-merge)[1191]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Apr 16 03:37:12.500055 (sd-merge)[1191]: Merged extensions into '/usr'. Apr 16 03:37:12.549948 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 16 03:37:12.899859 systemd[1]: Starting ensure-sysext.service... Apr 16 03:37:12.921180 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 16 03:37:12.989405 systemd[1]: Reloading requested from client PID 1195 ('systemctl') (unit ensure-sysext.service)... Apr 16 03:37:12.989807 systemd[1]: Reloading... Apr 16 03:37:13.071218 systemd-tmpfiles[1196]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 16 03:37:13.072421 systemd-tmpfiles[1196]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 16 03:37:13.074347 systemd-tmpfiles[1196]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 16 03:37:13.075232 systemd-tmpfiles[1196]: ACLs are not supported, ignoring. Apr 16 03:37:13.075353 systemd-tmpfiles[1196]: ACLs are not supported, ignoring. Apr 16 03:37:13.083937 systemd-tmpfiles[1196]: Detected autofs mount point /boot during canonicalization of boot. Apr 16 03:37:13.083944 systemd-tmpfiles[1196]: Skipping /boot Apr 16 03:37:13.261376 systemd-tmpfiles[1196]: Detected autofs mount point /boot during canonicalization of boot. Apr 16 03:37:13.261383 systemd-tmpfiles[1196]: Skipping /boot Apr 16 03:37:13.735580 zram_generator::config[1257]: No configuration found. Apr 16 03:37:13.969034 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 16 03:37:14.046504 systemd[1]: Reloading finished in 1055 ms. Apr 16 03:37:14.100619 ldconfig[1163]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 16 03:37:14.104566 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 16 03:37:14.112982 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 16 03:37:14.212165 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Apr 16 03:37:14.223810 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 16 03:37:14.237392 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 16 03:37:14.247198 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 16 03:37:14.265236 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 16 03:37:14.297090 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:14.297271 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 16 03:37:14.312752 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 16 03:37:14.370168 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 16 03:37:14.388247 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 16 03:37:14.391136 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 16 03:37:14.391371 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:14.396150 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 16 03:37:14.396369 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 16 03:37:14.404767 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 16 03:37:14.404940 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 16 03:37:14.408479 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 16 03:37:14.408691 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 16 03:37:14.412859 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 16 03:37:14.432399 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 16 03:37:14.439335 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:14.439477 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 16 03:37:14.447553 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 16 03:37:14.466572 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 16 03:37:14.484846 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 16 03:37:14.487252 augenrules[1295]: No rules Apr 16 03:37:14.488162 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 16 03:37:14.493728 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 16 03:37:14.496921 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:14.502054 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Apr 16 03:37:14.507770 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 16 03:37:14.517895 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 16 03:37:14.518131 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 16 03:37:14.526891 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 16 03:37:14.527722 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 16 03:37:14.555437 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 16 03:37:14.559448 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 16 03:37:14.871140 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:14.872095 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 16 03:37:14.884245 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 16 03:37:14.908000 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 16 03:37:14.915491 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 16 03:37:14.937030 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 16 03:37:14.940830 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 16 03:37:14.941366 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Apr 16 03:37:14.942377 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 16 03:37:14.947235 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 16 03:37:14.948059 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 16 03:37:14.963203 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 16 03:37:14.978990 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 16 03:37:14.985143 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 16 03:37:14.989873 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 16 03:37:14.990113 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 16 03:37:14.996230 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 16 03:37:14.996916 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 16 03:37:15.018169 systemd[1]: Finished ensure-sysext.service. Apr 16 03:37:15.084204 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 16 03:37:15.084371 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 16 03:37:15.096064 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Apr 16 03:37:15.208850 systemd-resolved[1268]: Positive Trust Anchors: Apr 16 03:37:15.209484 systemd-resolved[1268]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 16 03:37:15.210243 systemd-resolved[1268]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 16 03:37:15.281762 systemd-resolved[1268]: Defaulting to hostname 'linux'. Apr 16 03:37:15.296194 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 16 03:37:15.300771 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 16 03:37:15.306827 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Apr 16 03:37:15.314877 systemd[1]: Reached target time-set.target - System Time Set. Apr 16 03:37:21.891103 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 16 03:37:21.905063 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 16 03:37:21.911225 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 16 03:37:21.947833 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 16 03:37:21.982470 systemd-udevd[1324]: Using default interface naming scheme 'v255'. Apr 16 03:37:22.129735 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 16 03:37:22.150959 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 16 03:37:22.308039 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 16 03:37:22.353651 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1328) Apr 16 03:37:22.353994 systemd-networkd[1334]: lo: Link UP Apr 16 03:37:22.353999 systemd-networkd[1334]: lo: Gained carrier Apr 16 03:37:22.356747 systemd-networkd[1334]: Enumeration completed Apr 16 03:37:22.356934 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 16 03:37:22.361087 systemd[1]: Reached target network.target - Network. Apr 16 03:37:22.640086 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 16 03:37:22.699381 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 16 03:37:22.785033 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 16 03:37:22.789103 systemd-networkd[1334]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 16 03:37:22.789111 systemd-networkd[1334]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 16 03:37:22.792240 systemd-networkd[1334]: eth0: Link UP Apr 16 03:37:22.792410 systemd-networkd[1334]: eth0: Gained carrier Apr 16 03:37:22.792589 systemd-networkd[1334]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 16 03:37:22.810123 systemd-networkd[1334]: eth0: DHCPv4 address 10.0.0.3/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 16 03:37:22.812708 systemd-timesyncd[1321]: Network configuration changed, trying to establish connection. Apr 16 03:37:23.876571 systemd-timesyncd[1321]: Contacted time server 10.0.0.1:123 (10.0.0.1). Apr 16 03:37:23.876585 systemd-resolved[1268]: Clock change detected. Flushing caches. Apr 16 03:37:23.876661 systemd-timesyncd[1321]: Initial clock synchronization to Thu 2026-04-16 03:37:23.875377 UTC. Apr 16 03:37:23.915313 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 16 03:37:23.972280 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Apr 16 03:37:23.976233 kernel: ACPI: button: Power Button [PWRF] Apr 16 03:37:24.041439 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Apr 16 03:37:24.061846 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Apr 16 03:37:24.071976 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Apr 16 03:37:24.074886 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Apr 16 03:37:24.561662 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 16 03:37:24.869403 kernel: mousedev: PS/2 mouse device common for all mice Apr 16 03:37:25.441026 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 16 03:37:25.516699 systemd-networkd[1334]: eth0: Gained IPv6LL Apr 16 03:37:25.643461 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 16 03:37:25.651276 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 16 03:37:25.658885 systemd[1]: Reached target network-online.target - Network is Online. Apr 16 03:37:25.675755 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 16 03:37:25.742822 lvm[1371]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 16 03:37:25.863038 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 16 03:37:25.867789 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 16 03:37:25.871896 systemd[1]: Reached target sysinit.target - System Initialization. Apr 16 03:37:25.875270 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 16 03:37:25.878755 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 16 03:37:25.884555 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 16 03:37:25.913533 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 16 03:37:25.918521 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 16 03:37:25.922824 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 16 03:37:25.923770 systemd[1]: Reached target paths.target - Path Units. Apr 16 03:37:25.927170 systemd[1]: Reached target timers.target - Timer Units. Apr 16 03:37:25.938567 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 16 03:37:25.948645 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 16 03:37:25.968599 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 16 03:37:25.986432 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 16 03:37:25.997856 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 16 03:37:26.005275 systemd[1]: Reached target sockets.target - Socket Units. Apr 16 03:37:26.013038 systemd[1]: Reached target basic.target - Basic System. Apr 16 03:37:26.023551 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 16 03:37:26.024872 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 16 03:37:26.040074 lvm[1375]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 16 03:37:26.050881 systemd[1]: Starting containerd.service - containerd container runtime... Apr 16 03:37:26.070381 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 16 03:37:26.082387 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 16 03:37:26.130523 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 16 03:37:26.139536 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 16 03:37:26.142745 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Apr 16 03:37:26.144802 jq[1379]: false Apr 16 03:37:26.147574 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 16 03:37:26.159547 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 16 03:37:26.165291 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 16 03:37:26.175657 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 16 03:37:26.199639 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 16 03:37:26.206565 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 16 03:37:26.208453 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 16 03:37:26.213475 systemd[1]: Starting update-engine.service - Update Engine... Apr 16 03:37:26.243503 extend-filesystems[1380]: Found loop2 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found loop3 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found sr0 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda1 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda2 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda3 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found usr Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda4 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda6 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda7 Apr 16 03:37:26.243503 extend-filesystems[1380]: Found vda9 Apr 16 03:37:26.243503 extend-filesystems[1380]: Checking size of /dev/vda9 Apr 16 03:37:26.360576 extend-filesystems[1380]: Old size kept for /dev/vda9 Apr 16 03:37:26.284736 dbus-daemon[1378]: [system] SELinux support is enabled Apr 16 03:37:26.255886 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 16 03:37:26.277722 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 16 03:37:26.377744 jq[1396]: true Apr 16 03:37:26.325287 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 16 03:37:26.356826 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 16 03:37:26.358607 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 16 03:37:26.360700 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 16 03:37:26.362660 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 16 03:37:26.377597 systemd[1]: motdgen.service: Deactivated successfully. Apr 16 03:37:26.378773 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 16 03:37:26.394589 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 16 03:37:26.399790 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 16 03:37:26.401485 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 16 03:37:26.604309 jq[1408]: true Apr 16 03:37:26.669760 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1344) Apr 16 03:37:26.876225 update_engine[1394]: I20260416 03:37:26.876031 1394 main.cc:92] Flatcar Update Engine starting Apr 16 03:37:26.982415 (ntainerd)[1411]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 16 03:37:26.982795 update_engine[1394]: I20260416 03:37:26.930656 1394 update_check_scheduler.cc:74] Next update check in 7m5s Apr 16 03:37:27.006653 systemd-logind[1388]: Watching system buttons on /dev/input/event1 (Power Button) Apr 16 03:37:27.006673 systemd-logind[1388]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Apr 16 03:37:27.011409 systemd-logind[1388]: New seat seat0. Apr 16 03:37:27.017499 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 16 03:37:27.018074 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 16 03:37:27.027774 systemd[1]: Started systemd-logind.service - User Login Management. Apr 16 03:37:27.145502 dbus-daemon[1378]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 16 03:37:27.164673 systemd[1]: Started update-engine.service - Update Engine. Apr 16 03:37:27.206973 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Apr 16 03:37:27.211757 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 16 03:37:27.214801 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Apr 16 03:37:27.217745 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 16 03:37:27.224533 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Apr 16 03:37:27.224676 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 16 03:37:27.244362 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 16 03:37:27.250606 (-wrapper)[1436]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Apr 16 03:37:27.272883 bash[1440]: Updated "/home/core/.ssh/authorized_keys" Apr 16 03:37:27.276254 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 16 03:37:27.287646 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Apr 16 03:37:27.761228 locksmithd[1441]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 16 03:37:27.900243 sshd_keygen[1403]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 16 03:37:28.059218 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 16 03:37:28.088841 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 16 03:37:28.184600 systemd[1]: issuegen.service: Deactivated successfully. Apr 16 03:37:28.185901 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 16 03:37:28.475870 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 16 03:37:28.552574 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 16 03:37:28.642053 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 16 03:37:28.667412 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 16 03:37:28.673817 systemd[1]: Reached target getty.target - Login Prompts. Apr 16 03:37:29.434402 containerd[1411]: time="2026-04-16T03:37:29.431970083Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Apr 16 03:37:29.634997 containerd[1411]: time="2026-04-16T03:37:29.634514359Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.675879 containerd[1411]: time="2026-04-16T03:37:29.673644696Z" 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.127-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 16 03:37:29.675879 containerd[1411]: time="2026-04-16T03:37:29.675961450Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 16 03:37:29.676733 containerd[1411]: time="2026-04-16T03:37:29.676153411Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 16 03:37:29.676733 containerd[1411]: time="2026-04-16T03:37:29.676682615Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 16 03:37:29.676780 containerd[1411]: time="2026-04-16T03:37:29.676736914Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.677180 containerd[1411]: time="2026-04-16T03:37:29.677133833Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 16 03:37:29.677180 containerd[1411]: time="2026-04-16T03:37:29.677167415Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.740628 containerd[1411]: time="2026-04-16T03:37:29.735085936Z" 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 Apr 16 03:37:29.744910 containerd[1411]: time="2026-04-16T03:37:29.743868990Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.745845 containerd[1411]: time="2026-04-16T03:37:29.745284864Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 16 03:37:29.745845 containerd[1411]: time="2026-04-16T03:37:29.745308954Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.748824 containerd[1411]: time="2026-04-16T03:37:29.747894228Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.751917 containerd[1411]: time="2026-04-16T03:37:29.751654682Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 16 03:37:29.757273 containerd[1411]: time="2026-04-16T03:37:29.757142047Z" 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 Apr 16 03:37:29.757273 containerd[1411]: time="2026-04-16T03:37:29.757230216Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 16 03:37:29.758739 containerd[1411]: time="2026-04-16T03:37:29.757563126Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 16 03:37:29.758739 containerd[1411]: time="2026-04-16T03:37:29.757648534Z" level=info msg="metadata content store policy set" policy=shared Apr 16 03:37:29.782655 containerd[1411]: time="2026-04-16T03:37:29.782302509Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 16 03:37:29.783424 containerd[1411]: time="2026-04-16T03:37:29.783204494Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 16 03:37:29.811399 containerd[1411]: time="2026-04-16T03:37:29.789450584Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 16 03:37:29.813126 containerd[1411]: time="2026-04-16T03:37:29.812884362Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 16 03:37:29.813437 containerd[1411]: time="2026-04-16T03:37:29.813176343Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 16 03:37:29.814022 containerd[1411]: time="2026-04-16T03:37:29.813587776Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 16 03:37:29.815633 containerd[1411]: time="2026-04-16T03:37:29.815550724Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 16 03:37:29.815959 containerd[1411]: time="2026-04-16T03:37:29.815877845Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 16 03:37:29.815959 containerd[1411]: time="2026-04-16T03:37:29.815904716Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 16 03:37:29.815959 containerd[1411]: time="2026-04-16T03:37:29.815916078Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 16 03:37:29.815959 containerd[1411]: time="2026-04-16T03:37:29.815945944Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.815960188Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.815979065Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.815996500Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.816014637Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.816030087Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.816064262Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816131 containerd[1411]: time="2026-04-16T03:37:29.816080648Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 16 03:37:29.816301 containerd[1411]: time="2026-04-16T03:37:29.816163869Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816301 containerd[1411]: time="2026-04-16T03:37:29.816183877Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816301 containerd[1411]: time="2026-04-16T03:37:29.816225308Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816301 containerd[1411]: time="2026-04-16T03:37:29.816238830Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816301 containerd[1411]: time="2026-04-16T03:37:29.816269179Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816323798Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816338435Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816353686Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816368928Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816387909Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816405196Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816423 containerd[1411]: time="2026-04-16T03:37:29.816419698Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816583 containerd[1411]: time="2026-04-16T03:37:29.816437095Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816583 containerd[1411]: time="2026-04-16T03:37:29.816458208Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 16 03:37:29.816583 containerd[1411]: time="2026-04-16T03:37:29.816548122Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816647 containerd[1411]: time="2026-04-16T03:37:29.816566707Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.816647 containerd[1411]: time="2026-04-16T03:37:29.816622018Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 16 03:37:29.816841 containerd[1411]: time="2026-04-16T03:37:29.816776754Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 16 03:37:29.816972 containerd[1411]: time="2026-04-16T03:37:29.816897016Z" 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 Apr 16 03:37:29.816972 containerd[1411]: time="2026-04-16T03:37:29.816953892Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 16 03:37:29.817041 containerd[1411]: time="2026-04-16T03:37:29.816973707Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 16 03:37:29.817041 containerd[1411]: time="2026-04-16T03:37:29.816986608Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.817041 containerd[1411]: time="2026-04-16T03:37:29.817021731Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 16 03:37:29.817168 containerd[1411]: time="2026-04-16T03:37:29.817051416Z" level=info msg="NRI interface is disabled by configuration." Apr 16 03:37:29.817168 containerd[1411]: time="2026-04-16T03:37:29.817066896Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 16 03:37:29.818426 containerd[1411]: time="2026-04-16T03:37:29.818303698Z" 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}" Apr 16 03:37:29.818426 containerd[1411]: time="2026-04-16T03:37:29.818393053Z" level=info msg="Connect containerd service" Apr 16 03:37:29.818426 containerd[1411]: time="2026-04-16T03:37:29.818443102Z" level=info msg="using legacy CRI server" Apr 16 03:37:29.818426 containerd[1411]: time="2026-04-16T03:37:29.818451952Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 16 03:37:29.823364 containerd[1411]: time="2026-04-16T03:37:29.823299432Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 16 03:37:29.827132 containerd[1411]: time="2026-04-16T03:37:29.827004892Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Apr 16 03:37:29.828417 containerd[1411]: time="2026-04-16T03:37:29.828179164Z" level=info msg="Start subscribing containerd event" Apr 16 03:37:29.828649 containerd[1411]: time="2026-04-16T03:37:29.828533420Z" level=info msg="Start recovering state" Apr 16 03:37:29.828867 containerd[1411]: time="2026-04-16T03:37:29.828683993Z" level=info msg="Start event monitor" Apr 16 03:37:29.829315 containerd[1411]: time="2026-04-16T03:37:29.829188345Z" level=info msg="Start snapshots syncer" Apr 16 03:37:29.829412 containerd[1411]: time="2026-04-16T03:37:29.829362595Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 16 03:37:29.830582 containerd[1411]: time="2026-04-16T03:37:29.829367874Z" level=info msg="Start cni network conf syncer for default" Apr 16 03:37:29.830582 containerd[1411]: time="2026-04-16T03:37:29.830206359Z" level=info msg="Start streaming server" Apr 16 03:37:29.830582 containerd[1411]: time="2026-04-16T03:37:29.830258311Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 16 03:37:29.830582 containerd[1411]: time="2026-04-16T03:37:29.830430693Z" level=info msg="containerd successfully booted in 0.409993s" Apr 16 03:37:29.830826 systemd[1]: Started containerd.service - containerd container runtime. Apr 16 03:37:29.856658 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 16 03:37:29.859485 (dockerd)[1483]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Apr 16 03:37:34.398763 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 16 03:37:34.417293 systemd[1]: Started sshd@0-10.0.0.3:22-10.0.0.1:40592.service - OpenSSH per-connection server daemon (10.0.0.1:40592). Apr 16 03:37:34.614760 sshd[1498]: Accepted publickey for core from 10.0.0.1 port 40592 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:34.623459 sshd[1498]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:34.627147 dockerd[1483]: time="2026-04-16T03:37:34.623658087Z" level=info msg="Starting up" Apr 16 03:37:34.674616 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 16 03:37:34.690678 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 16 03:37:34.706609 systemd-logind[1388]: New session 1 of user core. Apr 16 03:37:34.752659 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 16 03:37:34.862460 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 16 03:37:34.897529 (systemd)[1504]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 16 03:37:35.203348 systemd[1504]: Queued start job for default target default.target. Apr 16 03:37:35.208379 systemd[1504]: Created slice app.slice - User Application Slice. Apr 16 03:37:35.208415 systemd[1504]: Reached target paths.target - Paths. Apr 16 03:37:35.208426 systemd[1504]: Reached target timers.target - Timers. Apr 16 03:37:35.210460 systemd[1504]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 16 03:37:35.260846 systemd[1504]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 16 03:37:35.261042 systemd[1504]: Reached target sockets.target - Sockets. Apr 16 03:37:35.261057 systemd[1504]: Reached target basic.target - Basic System. Apr 16 03:37:35.261142 systemd[1504]: Reached target default.target - Main User Target. Apr 16 03:37:35.261170 systemd[1504]: Startup finished in 334ms. Apr 16 03:37:35.261458 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 16 03:37:35.274376 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 16 03:37:35.369341 systemd[1]: Started sshd@1-10.0.0.3:22-10.0.0.1:59202.service - OpenSSH per-connection server daemon (10.0.0.1:59202). Apr 16 03:37:35.483599 dockerd[1483]: time="2026-04-16T03:37:35.481675116Z" level=info msg="Loading containers: start." Apr 16 03:37:35.513155 sshd[1527]: Accepted publickey for core from 10.0.0.1 port 59202 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:35.522786 sshd[1527]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:35.568393 systemd-logind[1388]: New session 2 of user core. Apr 16 03:37:35.581286 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 16 03:37:35.770312 sshd[1527]: pam_unix(sshd:session): session closed for user core Apr 16 03:37:35.863459 systemd[1]: Started sshd@2-10.0.0.3:22-10.0.0.1:59206.service - OpenSSH per-connection server daemon (10.0.0.1:59206). Apr 16 03:37:35.902682 systemd[1]: sshd@1-10.0.0.3:22-10.0.0.1:59202.service: Deactivated successfully. Apr 16 03:37:35.909286 systemd[1]: session-2.scope: Deactivated successfully. Apr 16 03:37:35.910817 systemd-logind[1388]: Session 2 logged out. Waiting for processes to exit. Apr 16 03:37:35.918204 systemd-logind[1388]: Removed session 2. Apr 16 03:37:36.065715 sshd[1539]: Accepted publickey for core from 10.0.0.1 port 59206 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:36.072927 sshd[1539]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:36.218071 systemd-logind[1388]: New session 3 of user core. Apr 16 03:37:36.224538 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 16 03:37:36.416482 sshd[1539]: pam_unix(sshd:session): session closed for user core Apr 16 03:37:36.421593 systemd[1]: sshd@2-10.0.0.3:22-10.0.0.1:59206.service: Deactivated successfully. Apr 16 03:37:36.423658 systemd[1]: session-3.scope: Deactivated successfully. Apr 16 03:37:36.426213 systemd-logind[1388]: Session 3 logged out. Waiting for processes to exit. Apr 16 03:37:36.440549 systemd-logind[1388]: Removed session 3. Apr 16 03:37:37.823274 kernel: Initializing XFRM netlink socket Apr 16 03:37:40.941217 systemd-networkd[1334]: docker0: Link UP Apr 16 03:37:41.311686 dockerd[1483]: time="2026-04-16T03:37:41.290689688Z" level=info msg="Loading containers: done." Apr 16 03:37:41.774681 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2682443029-merged.mount: Deactivated successfully. Apr 16 03:37:41.907068 dockerd[1483]: time="2026-04-16T03:37:41.897719456Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Apr 16 03:37:42.000510 dockerd[1483]: time="2026-04-16T03:37:41.988552430Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Apr 16 03:37:42.076607 dockerd[1483]: time="2026-04-16T03:37:42.074658676Z" level=info msg="Daemon has completed initialization" Apr 16 03:37:46.370804 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 16 03:37:46.374128 dockerd[1483]: time="2026-04-16T03:37:46.369302813Z" level=info msg="API listen on /run/docker.sock" Apr 16 03:37:46.439421 etcd-wrapper[1446]: Error response from daemon: No such container: etcd-member Apr 16 03:37:46.467648 systemd[1]: Started sshd@3-10.0.0.3:22-10.0.0.1:50964.service - OpenSSH per-connection server daemon (10.0.0.1:50964). Apr 16 03:37:46.712306 sshd[1648]: Accepted publickey for core from 10.0.0.1 port 50964 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:46.720291 sshd[1648]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:46.781882 etcd-wrapper[1649]: Error response from daemon: No such container: etcd-member Apr 16 03:37:46.842244 systemd-logind[1388]: New session 4 of user core. Apr 16 03:37:46.853277 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 16 03:37:47.120475 sshd[1648]: pam_unix(sshd:session): session closed for user core Apr 16 03:37:47.148839 systemd[1]: Started sshd@4-10.0.0.3:22-10.0.0.1:50968.service - OpenSSH per-connection server daemon (10.0.0.1:50968). Apr 16 03:37:47.150616 systemd[1]: sshd@3-10.0.0.3:22-10.0.0.1:50964.service: Deactivated successfully. Apr 16 03:37:47.152954 systemd[1]: session-4.scope: Deactivated successfully. Apr 16 03:37:47.168464 etcd-wrapper[1669]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Apr 16 03:37:47.267048 systemd-logind[1388]: Session 4 logged out. Waiting for processes to exit. Apr 16 03:37:47.283282 systemd-logind[1388]: Removed session 4. Apr 16 03:37:47.332190 sshd[1678]: Accepted publickey for core from 10.0.0.1 port 50968 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:47.338224 sshd[1678]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:47.419761 systemd-logind[1388]: New session 5 of user core. Apr 16 03:37:47.442794 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 16 03:37:47.665923 sshd[1678]: pam_unix(sshd:session): session closed for user core Apr 16 03:37:47.756392 systemd[1]: sshd@4-10.0.0.3:22-10.0.0.1:50968.service: Deactivated successfully. Apr 16 03:37:47.765868 systemd[1]: session-5.scope: Deactivated successfully. Apr 16 03:37:47.781625 systemd-logind[1388]: Session 5 logged out. Waiting for processes to exit. Apr 16 03:37:47.809370 systemd-logind[1388]: Removed session 5. Apr 16 03:37:53.346784 etcd-wrapper[1669]: v3.5.24: Pulling from coreos/etcd Apr 16 03:37:54.667338 etcd-wrapper[1669]: 804c8aba2cc6: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 2ae710cd8bfe: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: d462aa345367: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 0f8b424aa0b9: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: d557676654e5: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: c8022d07192e: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: d858cbc252ad: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 1069fc2daed1: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: b40161cd83fc: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 5318d93a3a65: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 307c1adadb60: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 49a553fa7ab9: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 9cde5f0af3dd: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: b9581a18c15b: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 95c11f3cd524: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: ed40c9b2e219: Pulling fs layer Apr 16 03:37:54.668379 etcd-wrapper[1669]: 5318d93a3a65: Waiting Apr 16 03:37:54.668379 etcd-wrapper[1669]: 0f8b424aa0b9: Waiting Apr 16 03:37:54.668379 etcd-wrapper[1669]: 307c1adadb60: Waiting Apr 16 03:37:54.668379 etcd-wrapper[1669]: 9cde5f0af3dd: Waiting Apr 16 03:37:54.668379 etcd-wrapper[1669]: b9581a18c15b: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: 49a553fa7ab9: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: c8022d07192e: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: d858cbc252ad: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: b40161cd83fc: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: 1069fc2daed1: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: 95c11f3cd524: Waiting Apr 16 03:37:54.686167 etcd-wrapper[1669]: ed40c9b2e219: Waiting Apr 16 03:37:55.211050 etcd-wrapper[1669]: 2ae710cd8bfe: Verifying Checksum Apr 16 03:37:55.211050 etcd-wrapper[1669]: 2ae710cd8bfe: Download complete Apr 16 03:37:55.374170 etcd-wrapper[1669]: 804c8aba2cc6: Verifying Checksum Apr 16 03:37:55.374170 etcd-wrapper[1669]: 804c8aba2cc6: Download complete Apr 16 03:37:55.378917 etcd-wrapper[1669]: d462aa345367: Verifying Checksum Apr 16 03:37:55.378917 etcd-wrapper[1669]: d462aa345367: Download complete Apr 16 03:37:55.810796 etcd-wrapper[1669]: d557676654e5: Verifying Checksum Apr 16 03:37:55.812171 etcd-wrapper[1669]: 0f8b424aa0b9: Verifying Checksum Apr 16 03:37:55.812171 etcd-wrapper[1669]: d557676654e5: Download complete Apr 16 03:37:55.812171 etcd-wrapper[1669]: 0f8b424aa0b9: Download complete Apr 16 03:37:55.820793 etcd-wrapper[1669]: c8022d07192e: Verifying Checksum Apr 16 03:37:55.820793 etcd-wrapper[1669]: c8022d07192e: Download complete Apr 16 03:37:56.324316 etcd-wrapper[1669]: 1069fc2daed1: Verifying Checksum Apr 16 03:37:56.345144 etcd-wrapper[1669]: 1069fc2daed1: Download complete Apr 16 03:37:56.354333 etcd-wrapper[1669]: b40161cd83fc: Verifying Checksum Apr 16 03:37:56.363569 etcd-wrapper[1669]: b40161cd83fc: Download complete Apr 16 03:37:56.398833 etcd-wrapper[1669]: d858cbc252ad: Verifying Checksum Apr 16 03:37:56.399816 etcd-wrapper[1669]: d858cbc252ad: Download complete Apr 16 03:37:56.816364 etcd-wrapper[1669]: 307c1adadb60: Verifying Checksum Apr 16 03:37:56.816364 etcd-wrapper[1669]: 5318d93a3a65: Download complete Apr 16 03:37:56.816364 etcd-wrapper[1669]: 307c1adadb60: Download complete Apr 16 03:37:56.816364 etcd-wrapper[1669]: 804c8aba2cc6: Pull complete Apr 16 03:37:57.180009 systemd[1]: var-lib-docker-overlay2-62724ea2a5d0ea5d512f7860769813f23138c336efa9f183445164d29b7b85cd-merged.mount: Deactivated successfully. Apr 16 03:37:57.344905 etcd-wrapper[1669]: 2ae710cd8bfe: Pull complete Apr 16 03:37:57.863051 etcd-wrapper[1669]: 49a553fa7ab9: Download complete Apr 16 03:37:57.882636 systemd[1]: Started sshd@5-10.0.0.3:22-10.0.0.1:47608.service - OpenSSH per-connection server daemon (10.0.0.1:47608). Apr 16 03:37:58.039463 sshd[1708]: Accepted publickey for core from 10.0.0.1 port 47608 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:58.054683 sshd[1708]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:58.155500 systemd-logind[1388]: New session 6 of user core. Apr 16 03:37:58.163846 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 16 03:37:58.386144 etcd-wrapper[1669]: b9581a18c15b: Verifying Checksum Apr 16 03:37:58.419771 sshd[1708]: pam_unix(sshd:session): session closed for user core Apr 16 03:37:58.436168 etcd-wrapper[1669]: b9581a18c15b: Download complete Apr 16 03:37:58.436694 etcd-wrapper[1669]: 9cde5f0af3dd: Verifying Checksum Apr 16 03:37:58.436750 etcd-wrapper[1669]: 9cde5f0af3dd: Download complete Apr 16 03:37:58.453201 systemd[1]: sshd@5-10.0.0.3:22-10.0.0.1:47608.service: Deactivated successfully. Apr 16 03:37:58.462980 systemd[1]: session-6.scope: Deactivated successfully. Apr 16 03:37:58.478546 systemd-logind[1388]: Session 6 logged out. Waiting for processes to exit. Apr 16 03:37:58.518007 systemd[1]: Started sshd@6-10.0.0.3:22-10.0.0.1:47612.service - OpenSSH per-connection server daemon (10.0.0.1:47612). Apr 16 03:37:58.582827 systemd-logind[1388]: Removed session 6. Apr 16 03:37:58.726389 sshd[1715]: Accepted publickey for core from 10.0.0.1 port 47612 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:37:58.727061 sshd[1715]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:37:58.754310 etcd-wrapper[1669]: 95c11f3cd524: Verifying Checksum Apr 16 03:37:58.764213 etcd-wrapper[1669]: 95c11f3cd524: Download complete Apr 16 03:37:58.850370 systemd-logind[1388]: New session 7 of user core. Apr 16 03:37:58.869801 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 16 03:37:59.042044 sshd[1715]: pam_unix(sshd:session): session closed for user core Apr 16 03:37:59.052665 systemd[1]: sshd@6-10.0.0.3:22-10.0.0.1:47612.service: Deactivated successfully. Apr 16 03:37:59.075333 systemd[1]: session-7.scope: Deactivated successfully. Apr 16 03:37:59.129920 systemd-logind[1388]: Session 7 logged out. Waiting for processes to exit. Apr 16 03:37:59.155985 systemd-logind[1388]: Removed session 7. Apr 16 03:37:59.265394 etcd-wrapper[1669]: ed40c9b2e219: Verifying Checksum Apr 16 03:37:59.273666 etcd-wrapper[1669]: ed40c9b2e219: Download complete Apr 16 03:38:09.161342 systemd[1]: Started sshd@7-10.0.0.3:22-10.0.0.1:53578.service - OpenSSH per-connection server daemon (10.0.0.1:53578). Apr 16 03:38:09.401005 sshd[1722]: Accepted publickey for core from 10.0.0.1 port 53578 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:09.413818 sshd[1722]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:09.549673 systemd-logind[1388]: New session 8 of user core. Apr 16 03:38:09.562253 systemd[1]: Started session-8.scope - Session 8 of User core. Apr 16 03:38:09.676440 sshd[1722]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:09.757444 systemd[1]: sshd@7-10.0.0.3:22-10.0.0.1:53578.service: Deactivated successfully. Apr 16 03:38:09.765630 systemd[1]: session-8.scope: Deactivated successfully. Apr 16 03:38:09.767981 systemd-logind[1388]: Session 8 logged out. Waiting for processes to exit. Apr 16 03:38:09.802606 systemd[1]: Started sshd@8-10.0.0.3:22-10.0.0.1:53590.service - OpenSSH per-connection server daemon (10.0.0.1:53590). Apr 16 03:38:09.814470 systemd-logind[1388]: Removed session 8. Apr 16 03:38:09.874020 sshd[1729]: Accepted publickey for core from 10.0.0.1 port 53590 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:09.878247 sshd[1729]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:09.898991 systemd-logind[1388]: New session 9 of user core. Apr 16 03:38:09.908173 systemd[1]: Started session-9.scope - Session 9 of User core. Apr 16 03:38:09.982586 sshd[1729]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:10.078875 systemd[1]: sshd@8-10.0.0.3:22-10.0.0.1:53590.service: Deactivated successfully. Apr 16 03:38:10.087638 systemd[1]: session-9.scope: Deactivated successfully. Apr 16 03:38:10.088788 systemd-logind[1388]: Session 9 logged out. Waiting for processes to exit. Apr 16 03:38:10.105012 systemd-logind[1388]: Removed session 9. Apr 16 03:38:11.772161 update_engine[1394]: I20260416 03:38:11.772037 1394 update_attempter.cc:509] Updating boot flags... Apr 16 03:38:11.874150 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1742) Apr 16 03:38:12.001633 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1746) Apr 16 03:38:13.561680 systemd[1]: var-lib-docker-overlay2-c9adb4bc8b51358944cdce9c5b9be0d2f9f6f33ec536ddd3d6232ecf39956ba8-merged.mount: Deactivated successfully. Apr 16 03:38:13.738000 etcd-wrapper[1669]: d462aa345367: Pull complete Apr 16 03:38:13.800003 systemd[1]: var-lib-docker-overlay2-07b39165067ddedd816799b91833d57bda5571bf487a7329bf23bfd3994ce92a-merged.mount: Deactivated successfully. Apr 16 03:38:13.983165 etcd-wrapper[1669]: 0f8b424aa0b9: Pull complete Apr 16 03:38:14.265859 systemd[1]: var-lib-docker-overlay2-5b7f7df72802f7b5dcb1aaaa58c4025ea856d5666750d558b54f3709bef4eba5-merged.mount: Deactivated successfully. Apr 16 03:38:14.335180 etcd-wrapper[1669]: d557676654e5: Pull complete Apr 16 03:38:14.542196 etcd-wrapper[1669]: c8022d07192e: Pull complete Apr 16 03:38:14.609812 systemd[1]: var-lib-docker-overlay2-4c5dad6fd84a72f6db2fbae7556dc9212ea0c8c4f1ba01156b3bf375fee603e0-merged.mount: Deactivated successfully. Apr 16 03:38:14.651557 etcd-wrapper[1669]: d858cbc252ad: Pull complete Apr 16 03:38:14.724764 systemd[1]: var-lib-docker-overlay2-96e9e498708c91e6141d03d5074b938a662e1bdbe0848ca794cc91ffb1f95c9e-merged.mount: Deactivated successfully. Apr 16 03:38:14.850838 etcd-wrapper[1669]: 1069fc2daed1: Pull complete Apr 16 03:38:15.004210 etcd-wrapper[1669]: b40161cd83fc: Pull complete Apr 16 03:38:15.224597 etcd-wrapper[1669]: 5318d93a3a65: Pull complete Apr 16 03:38:15.356572 etcd-wrapper[1669]: 307c1adadb60: Pull complete Apr 16 03:38:16.428812 systemd[1]: var-lib-docker-overlay2-71c8e3e1ff92ae7f6afdb35deffc7b587745cf636eed3bb229c8b131fcf25361-merged.mount: Deactivated successfully. Apr 16 03:38:16.610731 etcd-wrapper[1669]: 49a553fa7ab9: Pull complete Apr 16 03:38:18.054476 systemd[1]: var-lib-docker-overlay2-4026dff99e072a0a052f50cc8b2ae84c463f1e146bee7f6c2b176feb6a583df6-merged.mount: Deactivated successfully. Apr 16 03:38:18.148977 etcd-wrapper[1669]: 9cde5f0af3dd: Pull complete Apr 16 03:38:19.135582 systemd[1]: var-lib-docker-overlay2-947a15774ce2f499e5c48266069ef867c78226299410788aec406ae200afecfc-merged.mount: Deactivated successfully. Apr 16 03:38:19.283415 etcd-wrapper[1669]: b9581a18c15b: Pull complete Apr 16 03:38:19.449693 systemd[1]: var-lib-docker-overlay2-dfea10b67e484772dd5f62d0c05e549b20efa1195094cca9022d76579070dbd9-merged.mount: Deactivated successfully. Apr 16 03:38:19.639393 etcd-wrapper[1669]: 95c11f3cd524: Pull complete Apr 16 03:38:19.833467 systemd[1]: var-lib-docker-overlay2-58a32a4c3855a023d18392a1d1eff97863ec7abad0b361aba0b426c924453f7d-merged.mount: Deactivated successfully. Apr 16 03:38:19.909273 etcd-wrapper[1669]: ed40c9b2e219: Pull complete Apr 16 03:38:20.076924 systemd[1]: Started sshd@9-10.0.0.3:22-10.0.0.1:48428.service - OpenSSH per-connection server daemon (10.0.0.1:48428). Apr 16 03:38:20.216579 sshd[1811]: Accepted publickey for core from 10.0.0.1 port 48428 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:20.218239 sshd[1811]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:20.337850 systemd-logind[1388]: New session 10 of user core. Apr 16 03:38:20.360724 systemd[1]: Started session-10.scope - Session 10 of User core. Apr 16 03:38:20.416251 etcd-wrapper[1669]: Digest: sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594 Apr 16 03:38:20.555614 etcd-wrapper[1669]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.24 Apr 16 03:38:20.596868 sshd[1811]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:20.634562 systemd[1]: sshd@9-10.0.0.3:22-10.0.0.1:48428.service: Deactivated successfully. Apr 16 03:38:20.658031 systemd[1]: session-10.scope: Deactivated successfully. Apr 16 03:38:20.675389 systemd-logind[1388]: Session 10 logged out. Waiting for processes to exit. Apr 16 03:38:20.731529 systemd[1]: Started sshd@10-10.0.0.3:22-10.0.0.1:48444.service - OpenSSH per-connection server daemon (10.0.0.1:48444). Apr 16 03:38:20.743916 systemd-logind[1388]: Removed session 10. Apr 16 03:38:20.830883 sshd[1818]: Accepted publickey for core from 10.0.0.1 port 48444 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:20.851629 sshd[1818]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:20.970333 systemd-logind[1388]: New session 11 of user core. Apr 16 03:38:20.988935 systemd[1]: Started session-11.scope - Session 11 of User core. Apr 16 03:38:21.036236 systemd[1]: var-lib-docker-overlay2-f9e253097b7daceaadbac9401c7f61907a851bce36a05cf9d719c6c168330514\x2dinit-merged.mount: Deactivated successfully. Apr 16 03:38:21.171962 sshd[1818]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:21.213232 systemd[1]: sshd@10-10.0.0.3:22-10.0.0.1:48444.service: Deactivated successfully. Apr 16 03:38:21.236851 systemd[1]: var-lib-docker-overlay2-f9e253097b7daceaadbac9401c7f61907a851bce36a05cf9d719c6c168330514-merged.mount: Deactivated successfully. Apr 16 03:38:21.253457 systemd[1]: session-11.scope: Deactivated successfully. Apr 16 03:38:21.255883 systemd-logind[1388]: Session 11 logged out. Waiting for processes to exit. Apr 16 03:38:21.269943 systemd-logind[1388]: Removed session 11. Apr 16 03:38:23.725640 containerd[1411]: time="2026-04-16T03:38:23.723383486Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 16 03:38:23.725640 containerd[1411]: time="2026-04-16T03:38:23.724878555Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 16 03:38:23.725640 containerd[1411]: time="2026-04-16T03:38:23.724897993Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 16 03:38:23.725640 containerd[1411]: time="2026-04-16T03:38:23.725271265Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 16 03:38:23.876923 systemd[1]: Started docker-04b036fa4ebf01d1b3b2dc0bd2c2d2a75dcf05067afecfe974fec1c49c0fd197.scope - libcontainer container 04b036fa4ebf01d1b3b2dc0bd2c2d2a75dcf05067afecfe974fec1c49c0fd197. Apr 16 03:38:23.938467 systemd-resolved[1268]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.244700Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.245650Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"0e5dc27a31a64989b21e6c57bba1c55b"} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.245685Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.245713Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.24"} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.245719Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.245724Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.246080Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.246239Z","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.3:2379"]} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.246592Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Apr 16 03:38:24.255536 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.246668Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Apr 16 03:38:24.261219 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.253257Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Apr 16 03:38:24.261219 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.253632Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","go-os":"linux","go-arch":"amd64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"0e5dc27a31a64989b21e6c57bba1c55b","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.3:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"0e5dc27a31a64989b21e6c57bba1c55b=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"} Apr 16 03:38:24.370569 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.284514Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"15.305262ms"} Apr 16 03:38:24.462868 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.392430Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Apr 16 03:38:24.462868 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.395570Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Apr 16 03:38:24.462868 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.395710Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Apr 16 03:38:24.462868 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.395734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Apr 16 03:38:24.462868 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.395755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Apr 16 03:38:24.483808 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.399237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Apr 16 03:38:24.483808 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:38:24.462293Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Apr 16 03:38:24.493189 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.490651Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Apr 16 03:38:24.494217 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.491717Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Apr 16 03:38:24.512367 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.494307Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Apr 16 03:38:24.512367 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.501140Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.24","cluster-version":"to_be_decided"} Apr 16 03:38:24.512367 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.503925Z","caller":"etcdserver/server.go:759","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"} Apr 16 03:38:24.512367 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.504346Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Apr 16 03:38:24.521479 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.504617Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Apr 16 03:38:24.521479 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.505168Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Apr 16 03:38:24.521479 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.505192Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Apr 16 03:38:24.524563 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.507670Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Apr 16 03:38:24.524563 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.509017Z","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"],"added-peer-is-learner":false} Apr 16 03:38:24.585069 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.569395Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Apr 16 03:38:24.585069 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.569656Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Apr 16 03:38:24.585069 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.570961Z","caller":"embed/etcd.go:292","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.3:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945670Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.945706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Apr 16 03:38:24.953282 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.951460Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Apr 16 03:38:24.955290 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.952986Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:0e5dc27a31a64989b21e6c57bba1c55b ClientURLs:[http://10.0.0.3:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Apr 16 03:38:24.955290 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.953353Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Apr 16 03:38:24.957579 systemd[1]: Started etcd-member.service - etcd (System Application Container). Apr 16 03:38:24.959525 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 16 03:38:24.960230 systemd[1]: Startup finished in 2.038s (kernel) + 6.925s (initrd) + 1min 14.227s (userspace) = 1min 23.191s. Apr 16 03:38:24.962003 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.954495Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Apr 16 03:38:24.962003 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.956652Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Apr 16 03:38:24.962003 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.957185Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Apr 16 03:38:24.962003 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.957343Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Apr 16 03:38:24.962634 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.957385Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} Apr 16 03:38:24.962634 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.957871Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Apr 16 03:38:24.962634 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:38:24.958618Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Apr 16 03:38:31.268987 systemd[1]: Started sshd@11-10.0.0.3:22-10.0.0.1:51578.service - OpenSSH per-connection server daemon (10.0.0.1:51578). Apr 16 03:38:31.341593 sshd[1881]: Accepted publickey for core from 10.0.0.1 port 51578 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:31.343995 sshd[1881]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:31.369002 systemd-logind[1388]: New session 12 of user core. Apr 16 03:38:31.392318 systemd[1]: Started session-12.scope - Session 12 of User core. Apr 16 03:38:31.496409 sshd[1881]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:31.555759 systemd[1]: sshd@11-10.0.0.3:22-10.0.0.1:51578.service: Deactivated successfully. Apr 16 03:38:31.575572 systemd[1]: session-12.scope: Deactivated successfully. Apr 16 03:38:31.590939 systemd-logind[1388]: Session 12 logged out. Waiting for processes to exit. Apr 16 03:38:31.619139 systemd[1]: Started sshd@12-10.0.0.3:22-10.0.0.1:51586.service - OpenSSH per-connection server daemon (10.0.0.1:51586). Apr 16 03:38:31.621233 systemd-logind[1388]: Removed session 12. Apr 16 03:38:31.662814 sshd[1888]: Accepted publickey for core from 10.0.0.1 port 51586 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:31.665854 sshd[1888]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:31.815723 systemd-logind[1388]: New session 13 of user core. Apr 16 03:38:31.835048 systemd[1]: Started session-13.scope - Session 13 of User core. Apr 16 03:38:31.899886 sshd[1888]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:31.920862 systemd[1]: sshd@12-10.0.0.3:22-10.0.0.1:51586.service: Deactivated successfully. Apr 16 03:38:31.930922 systemd[1]: session-13.scope: Deactivated successfully. Apr 16 03:38:31.935737 systemd-logind[1388]: Session 13 logged out. Waiting for processes to exit. Apr 16 03:38:31.948509 systemd[1]: Started sshd@13-10.0.0.3:22-10.0.0.1:51588.service - OpenSSH per-connection server daemon (10.0.0.1:51588). Apr 16 03:38:31.950317 systemd-logind[1388]: Removed session 13. Apr 16 03:38:31.997717 sshd[1895]: Accepted publickey for core from 10.0.0.1 port 51588 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:31.999515 sshd[1895]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:32.027190 systemd-logind[1388]: New session 14 of user core. Apr 16 03:38:32.051235 systemd[1]: Started session-14.scope - Session 14 of User core. Apr 16 03:38:32.181722 sshd[1895]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:32.201930 systemd[1]: sshd@13-10.0.0.3:22-10.0.0.1:51588.service: Deactivated successfully. Apr 16 03:38:32.205252 systemd[1]: session-14.scope: Deactivated successfully. Apr 16 03:38:32.211794 systemd-logind[1388]: Session 14 logged out. Waiting for processes to exit. Apr 16 03:38:32.225881 systemd[1]: Started sshd@14-10.0.0.3:22-10.0.0.1:51600.service - OpenSSH per-connection server daemon (10.0.0.1:51600). Apr 16 03:38:32.227866 systemd-logind[1388]: Removed session 14. Apr 16 03:38:32.293065 sshd[1902]: Accepted publickey for core from 10.0.0.1 port 51600 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:32.309727 sshd[1902]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:32.351176 systemd-logind[1388]: New session 15 of user core. Apr 16 03:38:32.365761 systemd[1]: Started session-15.scope - Session 15 of User core. Apr 16 03:38:32.552409 sudo[1905]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 16 03:38:32.552838 sudo[1905]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 16 03:38:32.580016 sudo[1905]: pam_unix(sudo:session): session closed for user root Apr 16 03:38:32.586999 sshd[1902]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:32.679934 systemd[1]: Started sshd@15-10.0.0.3:22-10.0.0.1:51610.service - OpenSSH per-connection server daemon (10.0.0.1:51610). Apr 16 03:38:32.684686 systemd[1]: sshd@14-10.0.0.3:22-10.0.0.1:51600.service: Deactivated successfully. Apr 16 03:38:32.699899 systemd[1]: session-15.scope: Deactivated successfully. Apr 16 03:38:32.708246 systemd-logind[1388]: Session 15 logged out. Waiting for processes to exit. Apr 16 03:38:32.736454 systemd-logind[1388]: Removed session 15. Apr 16 03:38:32.775864 sshd[1908]: Accepted publickey for core from 10.0.0.1 port 51610 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:32.780551 sshd[1908]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:32.848928 systemd-logind[1388]: New session 16 of user core. Apr 16 03:38:32.881010 systemd[1]: Started session-16.scope - Session 16 of User core. Apr 16 03:38:33.247956 sudo[1914]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Apr 16 03:38:33.249393 sudo[1914]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 16 03:38:33.285217 sudo[1914]: pam_unix(sudo:session): session closed for user root Apr 16 03:38:33.313023 sudo[1913]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Apr 16 03:38:33.314440 sudo[1913]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 16 03:38:33.384818 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Apr 16 03:38:33.386184 auditctl[1917]: No rules Apr 16 03:38:33.442957 systemd[1]: audit-rules.service: Deactivated successfully. Apr 16 03:38:33.449032 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Apr 16 03:38:33.470711 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Apr 16 03:38:33.576052 augenrules[1935]: No rules Apr 16 03:38:33.586451 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Apr 16 03:38:33.589054 sudo[1913]: pam_unix(sudo:session): session closed for user root Apr 16 03:38:33.603992 sshd[1908]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:33.729041 systemd[1]: sshd@15-10.0.0.3:22-10.0.0.1:51610.service: Deactivated successfully. Apr 16 03:38:33.745075 systemd[1]: session-16.scope: Deactivated successfully. Apr 16 03:38:33.756611 systemd-logind[1388]: Session 16 logged out. Waiting for processes to exit. Apr 16 03:38:33.795531 systemd[1]: Started sshd@16-10.0.0.3:22-10.0.0.1:51618.service - OpenSSH per-connection server daemon (10.0.0.1:51618). Apr 16 03:38:33.815997 systemd-logind[1388]: Removed session 16. Apr 16 03:38:33.950052 sshd[1943]: Accepted publickey for core from 10.0.0.1 port 51618 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:34.001140 sshd[1943]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:34.212198 systemd-logind[1388]: New session 17 of user core. Apr 16 03:38:34.261927 systemd[1]: Started session-17.scope - Session 17 of User core. Apr 16 03:38:34.441702 sshd[1943]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:34.461019 systemd[1]: sshd@16-10.0.0.3:22-10.0.0.1:51618.service: Deactivated successfully. Apr 16 03:38:34.479973 systemd[1]: session-17.scope: Deactivated successfully. Apr 16 03:38:34.535790 systemd-logind[1388]: Session 17 logged out. Waiting for processes to exit. Apr 16 03:38:34.554576 systemd[1]: Started sshd@17-10.0.0.3:22-10.0.0.1:51620.service - OpenSSH per-connection server daemon (10.0.0.1:51620). Apr 16 03:38:34.558872 systemd-logind[1388]: Removed session 17. Apr 16 03:38:34.657242 sshd[1950]: Accepted publickey for core from 10.0.0.1 port 51620 ssh2: RSA SHA256:MMGJjrWUPl5O0F7kSOeN2vf99CnP5T6mBFs726vCnXI Apr 16 03:38:34.666850 sshd[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 16 03:38:34.849301 systemd-logind[1388]: New session 18 of user core. Apr 16 03:38:34.869194 systemd[1]: Started session-18.scope - Session 18 of User core. Apr 16 03:38:35.255598 sshd[1950]: pam_unix(sshd:session): session closed for user core Apr 16 03:38:35.314277 systemd[1]: sshd@17-10.0.0.3:22-10.0.0.1:51620.service: Deactivated successfully. Apr 16 03:38:35.336812 systemd[1]: session-18.scope: Deactivated successfully. Apr 16 03:38:35.340604 systemd-logind[1388]: Session 18 logged out. Waiting for processes to exit. Apr 16 03:38:35.358568 systemd-logind[1388]: Removed session 18. Apr 16 03:40:23.920902 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:23.810052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.811051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} Apr 16 03:40:23.920902 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:23.811396Z","caller":"traceutil/trace.go:171","msg":"trace[824106367] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"738.290517ms","start":"2026-04-16T03:40:23.073029Z","end":"2026-04-16T03:40:23.811319Z","steps":["trace[824106367] 'process raft request' (duration: 738.021842ms)"],"step_count":1} Apr 16 03:40:23.920902 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:23.811561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:40:23.069890Z","time spent":"741.622575ms","remote":"10.0.0.7:39382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} Apr 16 03:40:23.920902 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:23.854813Z","caller":"traceutil/trace.go:171","msg":"trace[1930823938] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"781.591218ms","start":"2026-04-16T03:40:23.072793Z","end":"2026-04-16T03:40:23.854384Z","steps":["trace[1930823938] 'process raft request' (duration: 33.983308ms)","trace[1930823938] 'store kv pair into bolt db' {req_type:put; key:/registry/namespaces/default; req_size:323; } (duration: 700.876666ms)"],"step_count":2} Apr 16 03:40:23.944707 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:23.861025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:40:23.072781Z","time spent":"785.046051ms","remote":"10.0.0.7:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":326,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} Apr 16 03:40:24.999085 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:24.876561Z","caller":"traceutil/trace.go:171","msg":"trace[1125632710] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"101.38774ms","start":"2026-04-16T03:40:24.771757Z","end":"2026-04-16T03:40:24.873145Z","steps":["trace[1125632710] 'process raft request' (duration: 101.215155ms)"],"step_count":1} Apr 16 03:40:24.999085 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:24.877128Z","caller":"traceutil/trace.go:171","msg":"trace[779654410] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"132.026072ms","start":"2026-04-16T03:40:24.745035Z","end":"2026-04-16T03:40:24.877061Z","steps":["trace[779654410] 'process raft request' (duration: 112.459042ms)","trace[779654410] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/flowschemas/system-leader-election; req_size:1198; } (duration: 14.863503ms)"],"step_count":2} Apr 16 03:40:24.999085 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:24.877241Z","caller":"traceutil/trace.go:171","msg":"trace[386786685] linearizableReadLoop","detail":"{readStateIndex:68; appliedIndex:67; }","duration":"107.931692ms","start":"2026-04-16T03:40:24.769302Z","end":"2026-04-16T03:40:24.877234Z","steps":["trace[386786685] 'read index received' (duration: 88.511145ms)","trace[386786685] 'applied index is now lower than readState.Index' (duration: 19.419785ms)"],"step_count":2} Apr 16 03:40:24.999085 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:24.877639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.108286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" limit:1 ","response":"range_response_count:0 size:4"} Apr 16 03:40:25.041969 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:24.877693Z","caller":"traceutil/trace.go:171","msg":"trace[244159545] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:0; response_revision:63; }","duration":"108.379291ms","start":"2026-04-16T03:40:24.769286Z","end":"2026-04-16T03:40:24.877666Z","steps":["trace[244159545] 'agreement among raft nodes before linearized reading' (duration: 107.971498ms)"],"step_count":1} Apr 16 03:40:29.109368 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:29.086765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.75157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Apr 16 03:40:29.109368 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:29.091547Z","caller":"traceutil/trace.go:171","msg":"trace[1692899409] transaction","detail":"{read_only:false; response_revision:132; number_of_response:1; }","duration":"120.599398ms","start":"2026-04-16T03:40:28.970739Z","end":"2026-04-16T03:40:29.091338Z","steps":["trace[1692899409] 'process raft request' (duration: 14.225952ms)","trace[1692899409] 'compare' (duration: 16.58674ms)","trace[1692899409] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver; req_size:708; } (duration: 83.120818ms)"],"step_count":3} Apr 16 03:40:32.108315 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:32.089567Z","caller":"traceutil/trace.go:171","msg":"trace[1666412190] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"109.862283ms","start":"2026-04-16T03:40:31.977879Z","end":"2026-04-16T03:40:32.087741Z","steps":["trace[1666412190] 'process raft request' (duration: 86.79576ms)","trace[1666412190] 'compare' (duration: 18.000063ms)"],"step_count":2} Apr 16 03:40:32.583993 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:32.526220Z","caller":"traceutil/trace.go:171","msg":"trace[1493473800] transaction","detail":"{read_only:false; response_revision:159; number_of_response:1; }","duration":"151.107825ms","start":"2026-04-16T03:40:32.375052Z","end":"2026-04-16T03:40:32.526160Z","steps":["trace[1493473800] 'process raft request' (duration: 82.769159ms)","trace[1493473800] 'store kv pair into bolt db' {req_type:put; key:/registry/clusterroles/system:controller:endpointslicemirroring-controller; req_size:832; } (duration: 39.918702ms)"],"step_count":2} Apr 16 03:40:32.583993 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:32.526337Z","caller":"traceutil/trace.go:171","msg":"trace[1147988617] linearizableReadLoop","detail":"{readStateIndex:165; appliedIndex:164; }","duration":"150.266666ms","start":"2026-04-16T03:40:32.376047Z","end":"2026-04-16T03:40:32.526314Z","steps":["trace[1147988617] 'read index received' (duration: 81.685162ms)","trace[1147988617] 'applied index is now lower than readState.Index' (duration: 68.511941ms)"],"step_count":2} Apr 16 03:40:32.583993 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:32.564427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.916673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-scheduler-localhost.18a6b94464b58361\" limit:1 ","response":"range_response_count:1 size:816"} Apr 16 03:40:32.583993 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:32.564675Z","caller":"traceutil/trace.go:171","msg":"trace[1694234916] range","detail":"{range_begin:/registry/events/kube-system/kube-scheduler-localhost.18a6b94464b58361; range_end:; response_count:1; response_revision:159; }","duration":"188.579178ms","start":"2026-04-16T03:40:32.376040Z","end":"2026-04-16T03:40:32.564620Z","steps":["trace[1694234916] 'agreement among raft nodes before linearized reading' (duration: 150.342471ms)","trace[1694234916] 'range keys from in-memory index tree' (duration: 29.255288ms)"],"step_count":2} Apr 16 03:40:35.054572 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:34.977659Z","caller":"traceutil/trace.go:171","msg":"trace[1467551462] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"133.70188ms","start":"2026-04-16T03:40:34.843449Z","end":"2026-04-16T03:40:34.977151Z","steps":["trace[1467551462] 'process raft request' (duration: 42.84868ms)","trace[1467551462] 'compare' (duration: 64.374076ms)","trace[1467551462] 'store kv pair into bolt db' {req_type:put; key:/registry/events/kube-system/kube-scheduler-localhost.18a6b9482cf7cc62; req_size:761; } (duration: 16.327644ms)"],"step_count":3} Apr 16 03:40:35.678823 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:35.646420Z","caller":"traceutil/trace.go:171","msg":"trace[974983186] linearizableReadLoop","detail":"{readStateIndex:190; appliedIndex:189; }","duration":"108.938172ms","start":"2026-04-16T03:40:35.536973Z","end":"2026-04-16T03:40:35.645911Z","steps":["trace[974983186] 'read index received' (duration: 16.911929ms)","trace[974983186] 'applied index is now lower than readState.Index' (duration: 91.8918ms)"],"step_count":2} Apr 16 03:40:35.678823 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:35.646849Z","caller":"traceutil/trace.go:171","msg":"trace[2001783715] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"134.178183ms","start":"2026-04-16T03:40:35.512386Z","end":"2026-04-16T03:40:35.646564Z","steps":["trace[2001783715] 'process raft request' (duration: 41.295044ms)","trace[2001783715] 'compare' (duration: 88.577006ms)"],"step_count":2} Apr 16 03:40:35.678823 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:35.647061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.073721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replicaset-controller\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:40:35.678823 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:35.647087Z","caller":"traceutil/trace.go:171","msg":"trace[277509586] range","detail":"{range_begin:/registry/clusterroles/system:controller:replicaset-controller; range_end:; response_count:0; response_revision:184; }","duration":"110.114208ms","start":"2026-04-16T03:40:35.536962Z","end":"2026-04-16T03:40:35.647076Z","steps":["trace[277509586] 'agreement among raft nodes before linearized reading' (duration: 109.857071ms)"],"step_count":1} Apr 16 03:40:39.508456 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:39.352526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.143745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:validatingadmissionpolicy-status-controller\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:40:39.508456 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:39.352976Z","caller":"traceutil/trace.go:171","msg":"trace[1131484421] range","detail":"{range_begin:/registry/clusterroles/system:controller:validatingadmissionpolicy-status-controller; range_end:; response_count:0; response_revision:207; }","duration":"110.584173ms","start":"2026-04-16T03:40:39.242271Z","end":"2026-04-16T03:40:39.352856Z","steps":["trace[1131484421] 'range keys from in-memory index tree' (duration: 109.871913ms)"],"step_count":1} Apr 16 03:40:40.362991 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:40.348551Z","caller":"traceutil/trace.go:171","msg":"trace[1475077216] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"121.976506ms","start":"2026-04-16T03:40:40.226361Z","end":"2026-04-16T03:40:40.348337Z","steps":["trace[1475077216] 'process raft request' (duration: 22.852184ms)","trace[1475077216] 'compare' (duration: 13.976274ms)","trace[1475077216] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/events/kube-system/kube-scheduler-localhost.18a6b9482cf7cc62; req_size:761; } (duration: 79.28414ms)"],"step_count":3} Apr 16 03:40:41.372180 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:41.344872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.318855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:40:41.372180 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:41.347822Z","caller":"traceutil/trace.go:171","msg":"trace[630326313] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:0; response_revision:215; }","duration":"127.553569ms","start":"2026-04-16T03:40:41.219901Z","end":"2026-04-16T03:40:41.347455Z","steps":["trace[630326313] 'range keys from in-memory index tree' (duration: 118.828726ms)"],"step_count":1} Apr 16 03:40:41.901653 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:41.864611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.501475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Apr 16 03:40:41.901653 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:41.879138Z","caller":"traceutil/trace.go:171","msg":"trace[1433507631] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"163.628964ms","start":"2026-04-16T03:40:41.715371Z","end":"2026-04-16T03:40:41.879000Z","steps":["trace[1433507631] 'process raft request' (duration: 57.489907ms)","trace[1433507631] 'store kv pair into bolt db' {req_type:put; key:/registry/clusterrolebindings/system:discovery; req_size:676; } (duration: 71.264926ms)"],"step_count":2} Apr 16 03:40:44.971231 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:44.829951Z","caller":"traceutil/trace.go:171","msg":"trace[919169225] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"118.192082ms","start":"2026-04-16T03:40:44.711446Z","end":"2026-04-16T03:40:44.829638Z","steps":["trace[919169225] 'process raft request' (duration: 19.618218ms)","trace[919169225] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/apiserver-l2yubf4cvcl5c7a3wrubrwqdve; req_size:671; } (duration: 46.874806ms)"],"step_count":2} Apr 16 03:40:46.654757 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:46.638176Z","caller":"traceutil/trace.go:171","msg":"trace[646382935] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:228; }","duration":"106.818773ms","start":"2026-04-16T03:40:46.531252Z","end":"2026-04-16T03:40:46.638071Z","steps":["trace[646382935] 'agreement among raft nodes before linearized reading' (duration: 51.305143ms)","trace[646382935] 'range keys from in-memory index tree' (duration: 55.460016ms)"],"step_count":2} Apr 16 03:40:48.308738 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:48.281727Z","caller":"traceutil/trace.go:171","msg":"trace[855271841] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"112.444899ms","start":"2026-04-16T03:40:48.168470Z","end":"2026-04-16T03:40:48.280915Z","steps":["trace[855271841] 'process raft request' (duration: 96.502987ms)"],"step_count":1} Apr 16 03:40:49.084940 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:49.059228Z","caller":"traceutil/trace.go:171","msg":"trace[1070504151] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"113.49706ms","start":"2026-04-16T03:40:48.945508Z","end":"2026-04-16T03:40:49.059005Z","steps":["trace[1070504151] 'process raft request' (duration: 15.386801ms)","trace[1070504151] 'check requests' (duration: 16.803338ms)","trace[1070504151] 'store kv pair into bolt db' {req_type:put; key:/registry/clusterrolebindings/system:controller:cronjob-controller; req_size:729; } (duration: 66.521906ms)"],"step_count":3} Apr 16 03:40:53.988199 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:53.971157Z","caller":"traceutil/trace.go:171","msg":"trace[137820731] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"109.886701ms","start":"2026-04-16T03:40:53.861226Z","end":"2026-04-16T03:40:53.971113Z","steps":["trace[137820731] 'process raft request' (duration: 47.170537ms)"],"step_count":1} Apr 16 03:40:55.315477 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:55.287143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.928402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:namespace-controller\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:40:55.315477 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:55.309878Z","caller":"traceutil/trace.go:171","msg":"trace[1577588566] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:namespace-controller; range_end:; response_count:0; response_revision:249; }","duration":"124.374445ms","start":"2026-04-16T03:40:55.184772Z","end":"2026-04-16T03:40:55.309147Z","steps":["trace[1577588566] 'range keys from in-memory index tree' (duration: 101.616938ms)"],"step_count":1} Apr 16 03:40:59.610577 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:40:59.586926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.952088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Apr 16 03:40:59.610577 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:40:59.587311Z","caller":"traceutil/trace.go:171","msg":"trace[933028433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:264; }","duration":"144.263077ms","start":"2026-04-16T03:40:59.442943Z","end":"2026-04-16T03:40:59.587206Z","steps":["trace[933028433] 'range keys from in-memory index tree' (duration: 143.442922ms)"],"step_count":1} Apr 16 03:41:20.615448 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:20.546515Z","caller":"traceutil/trace.go:171","msg":"trace[369389182] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"113.120657ms","start":"2026-04-16T03:41:20.427548Z","end":"2026-04-16T03:41:20.540669Z","steps":["trace[369389182] 'process raft request' (duration: 53.227915ms)","trace[369389182] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/events/kube-system/kube-controller-manager.18a6b95599b3ece1; req_size:751; } (duration: 28.944486ms)","trace[369389182] 'store kv pair into bolt db' {req_type:put; key:/registry/events/kube-system/kube-controller-manager.18a6b95599b3ece1; req_size:751; } (duration: 19.67675ms)"],"step_count":3} Apr 16 03:41:20.615448 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:20.551297Z","caller":"traceutil/trace.go:171","msg":"trace[835613859] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"119.413042ms","start":"2026-04-16T03:41:20.431866Z","end":"2026-04-16T03:41:20.551280Z","steps":["trace[835613859] 'process raft request' (duration: 119.336075ms)"],"step_count":1} Apr 16 03:41:20.615448 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:20.551400Z","caller":"traceutil/trace.go:171","msg":"trace[1070966836] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"123.783879ms","start":"2026-04-16T03:41:20.427611Z","end":"2026-04-16T03:41:20.551395Z","steps":["trace[1070966836] 'process raft request' (duration: 120.796392ms)"],"step_count":1} Apr 16 03:41:21.476629 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:21.457689Z","caller":"traceutil/trace.go:171","msg":"trace[1653676142] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"167.467253ms","start":"2026-04-16T03:41:21.286797Z","end":"2026-04-16T03:41:21.454264Z","steps":["trace[1653676142] 'process raft request' (duration: 91.771345ms)","trace[1653676142] 'compare' (duration: 48.70272ms)","trace[1653676142] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/rolebindings/kube-system/kube-proxy; req_size:432; } (duration: 18.409558ms)"],"step_count":3} Apr 16 03:41:22.720809 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:22.660602Z","caller":"traceutil/trace.go:171","msg":"trace[820675624] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"101.992387ms","start":"2026-04-16T03:41:22.557798Z","end":"2026-04-16T03:41:22.659790Z","steps":["trace[820675624] 'process raft request' (duration: 29.465198ms)","trace[820675624] 'compare' (duration: 58.511881ms)"],"step_count":2} Apr 16 03:41:49.523382 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:49.501839Z","caller":"traceutil/trace.go:171","msg":"trace[442277661] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"113.547521ms","start":"2026-04-16T03:41:49.388237Z","end":"2026-04-16T03:41:49.501784Z","steps":["trace[442277661] 'process raft request' (duration: 79.396155ms)","trace[442277661] 'compare' (duration: 26.115788ms)"],"step_count":2} Apr 16 03:41:50.196194 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.151664Z","caller":"traceutil/trace.go:171","msg":"trace[195443973] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"107.959163ms","start":"2026-04-16T03:41:50.043676Z","end":"2026-04-16T03:41:50.151635Z","steps":["trace[195443973] 'process raft request' (duration: 34.513267ms)"],"step_count":1} Apr 16 03:41:50.280356 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.243975Z","caller":"traceutil/trace.go:171","msg":"trace[64445311] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:491; }","duration":"122.032955ms","start":"2026-04-16T03:41:50.121921Z","end":"2026-04-16T03:41:50.243954Z","steps":["trace[64445311] 'read index received' (duration: 122.026943ms)","trace[64445311] 'applied index is now lower than readState.Index' (duration: 4.142µs)"],"step_count":2} Apr 16 03:41:50.437435 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.346614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.40072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:1 size:193"} Apr 16 03:41:50.437435 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.346833Z","caller":"traceutil/trace.go:171","msg":"trace[1929156603] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:474; }","duration":"267.6242ms","start":"2026-04-16T03:41:50.079180Z","end":"2026-04-16T03:41:50.346804Z","steps":["trace[1929156603] 'agreement among raft nodes before linearized reading' (duration: 148.649791ms)","trace[1929156603] 'range keys from in-memory index tree' (duration: 79.321672ms)","trace[1929156603] 'range keys from bolt db' (duration: 32.683817ms)"],"step_count":3} Apr 16 03:41:50.437435 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.348620Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.048329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} Apr 16 03:41:50.437435 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.349016Z","caller":"traceutil/trace.go:171","msg":"trace[695599438] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"113.891131ms","start":"2026-04-16T03:41:50.234982Z","end":"2026-04-16T03:41:50.348873Z","steps":["trace[695599438] 'process raft request' (duration: 113.825179ms)"],"step_count":1} Apr 16 03:41:50.441862 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.349245Z","caller":"traceutil/trace.go:171","msg":"trace[353534106] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"162.745477ms","start":"2026-04-16T03:41:50.186461Z","end":"2026-04-16T03:41:50.349206Z","steps":["trace[353534106] 'process raft request' (duration: 162.095438ms)"],"step_count":1} Apr 16 03:41:50.441862 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.350243Z","caller":"traceutil/trace.go:171","msg":"trace[98727835] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:474; }","duration":"228.577919ms","start":"2026-04-16T03:41:50.121503Z","end":"2026-04-16T03:41:50.350081Z","steps":["trace[98727835] 'agreement among raft nodes before linearized reading' (duration: 200.400898ms)","trace[98727835] 'get authentication metadata' (duration: 26.273475ms)"],"step_count":2} Apr 16 03:41:50.441862 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.367723Z","caller":"traceutil/trace.go:171","msg":"trace[510325048] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"124.084916ms","start":"2026-04-16T03:41:50.243458Z","end":"2026-04-16T03:41:50.367543Z","steps":["trace[510325048] 'process raft request' (duration: 120.246049ms)"],"step_count":1} Apr 16 03:41:50.441862 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.367861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.361169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 ","response":"range_response_count:1 size:207"} Apr 16 03:41:50.444753 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.367902Z","caller":"traceutil/trace.go:171","msg":"trace[1865195859] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:477; }","duration":"132.414216ms","start":"2026-04-16T03:41:50.235478Z","end":"2026-04-16T03:41:50.367892Z","steps":["trace[1865195859] 'agreement among raft nodes before linearized reading' (duration: 132.313529ms)"],"step_count":1} Apr 16 03:41:50.444753 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.367965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.758185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/installations.operator.tigera.io\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:41:50.444753 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.367982Z","caller":"traceutil/trace.go:171","msg":"trace[257330350] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/installations.operator.tigera.io; range_end:; response_count:0; response_revision:477; }","duration":"124.773145ms","start":"2026-04-16T03:41:50.243201Z","end":"2026-04-16T03:41:50.367974Z","steps":["trace[257330350] 'agreement among raft nodes before linearized reading' (duration: 124.751104ms)"],"step_count":1} Apr 16 03:41:50.444753 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.368155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.777811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} Apr 16 03:41:50.455706 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.368176Z","caller":"traceutil/trace.go:171","msg":"trace[392249581] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:477; }","duration":"195.800806ms","start":"2026-04-16T03:41:50.172370Z","end":"2026-04-16T03:41:50.368170Z","steps":["trace[392249581] 'agreement among raft nodes before linearized reading' (duration: 195.7597ms)"],"step_count":1} Apr 16 03:41:50.455706 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.368254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.874586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking\" limit:1 ","response":"range_response_count:1 size:370"} Apr 16 03:41:50.455706 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.368293Z","caller":"traceutil/trace.go:171","msg":"trace[1992567884] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking; range_end:; response_count:1; response_revision:477; }","duration":"153.15286ms","start":"2026-04-16T03:41:50.215128Z","end":"2026-04-16T03:41:50.368281Z","steps":["trace[1992567884] 'agreement among raft nodes before linearized reading' (duration: 152.843699ms)"],"step_count":1} Apr 16 03:41:50.455706 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.369377Z","caller":"traceutil/trace.go:171","msg":"trace[1383336604] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:491; }","duration":"119.752931ms","start":"2026-04-16T03:41:50.247994Z","end":"2026-04-16T03:41:50.367747Z","steps":["trace[1383336604] 'read index received' (duration: 100.570942ms)","trace[1383336604] 'applied index is now lower than readState.Index' (duration: 19.180918ms)"],"step_count":2} Apr 16 03:41:50.466974 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.450055Z","caller":"traceutil/trace.go:171","msg":"trace[1049507072] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"103.668152ms","start":"2026-04-16T03:41:50.346245Z","end":"2026-04-16T03:41:50.449913Z","steps":["trace[1049507072] 'process raft request' (duration: 35.79066ms)","trace[1049507072] 'compare' (duration: 35.765017ms)","trace[1049507072] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/replicasets/tigera-operator/tigera-operator-6bf85f8dd; req_size:2857; } (duration: 20.749467ms)"],"step_count":3} Apr 16 03:41:50.466974 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.451146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.65707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Apr 16 03:41:50.466974 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.450990Z","caller":"traceutil/trace.go:171","msg":"trace[724621739] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"103.066767ms","start":"2026-04-16T03:41:50.347903Z","end":"2026-04-16T03:41:50.450970Z","steps":["trace[724621739] 'process raft request' (duration: 102.102167ms)"],"step_count":1} Apr 16 03:41:50.466974 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.454892Z","caller":"traceutil/trace.go:171","msg":"trace[925818530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:479; }","duration":"102.809443ms","start":"2026-04-16T03:41:50.348470Z","end":"2026-04-16T03:41:50.451279Z","steps":["trace[925818530] 'agreement among raft nodes before linearized reading' (duration: 102.456368ms)"],"step_count":1} Apr 16 03:41:50.642676 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.625835Z","caller":"traceutil/trace.go:171","msg":"trace[1234985565] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"107.397793ms","start":"2026-04-16T03:41:50.518404Z","end":"2026-04-16T03:41:50.625802Z","steps":["trace[1234985565] 'process raft request' (duration: 27.753493ms)","trace[1234985565] 'compare' (duration: 43.715673ms)","trace[1234985565] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/clusterroles/edit; req_size:3458; } (duration: 10.632657ms)","trace[1234985565] 'store kv pair into bolt db' {req_type:put; key:/registry/clusterroles/edit; req_size:3458; } (duration: 16.380443ms)"],"step_count":4} Apr 16 03:41:50.678837 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.640173Z","caller":"traceutil/trace.go:171","msg":"trace[1014258373] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"121.676114ms","start":"2026-04-16T03:41:50.518475Z","end":"2026-04-16T03:41:50.640151Z","steps":["trace[1014258373] 'process raft request' (duration: 106.732723ms)"],"step_count":1} Apr 16 03:41:50.678837 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.653714Z","caller":"traceutil/trace.go:171","msg":"trace[1067982145] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"132.89102ms","start":"2026-04-16T03:41:50.520340Z","end":"2026-04-16T03:41:50.653231Z","steps":["trace[1067982145] 'process raft request' (duration: 119.476682ms)"],"step_count":1} Apr 16 03:41:50.777189 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.748675Z","caller":"traceutil/trace.go:171","msg":"trace[1329000572] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"228.085713ms","start":"2026-04-16T03:41:50.520470Z","end":"2026-04-16T03:41:50.748556Z","steps":["trace[1329000572] 'process raft request' (duration: 134.512005ms)"],"step_count":1} Apr 16 03:41:50.811532 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.800394Z","caller":"traceutil/trace.go:171","msg":"trace[755900902] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"278.326814ms","start":"2026-04-16T03:41:50.522047Z","end":"2026-04-16T03:41:50.800374Z","steps":["trace[755900902] 'process raft request' (duration: 241.947704ms)","trace[755900902] 'compare' (duration: 31.036312ms)"],"step_count":2} Apr 16 03:41:50.811532 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.800658Z","caller":"traceutil/trace.go:171","msg":"trace[1574693965] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"278.113139ms","start":"2026-04-16T03:41:50.522539Z","end":"2026-04-16T03:41:50.800652Z","steps":["trace[1574693965] 'process raft request' (duration: 273.109187ms)"],"step_count":1} Apr 16 03:41:50.924399 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.809221Z","caller":"traceutil/trace.go:171","msg":"trace[583634381] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"284.479198ms","start":"2026-04-16T03:41:50.524537Z","end":"2026-04-16T03:41:50.809016Z","steps":["trace[583634381] 'process raft request' (duration: 271.192189ms)"],"step_count":1} Apr 16 03:41:50.924399 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.809924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.546213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} Apr 16 03:41:50.924399 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.810048Z","caller":"traceutil/trace.go:171","msg":"trace[830168026] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:492; }","duration":"291.590833ms","start":"2026-04-16T03:41:50.518357Z","end":"2026-04-16T03:41:50.809948Z","steps":["trace[830168026] 'agreement among raft nodes before linearized reading' (duration: 291.52769ms)"],"step_count":1} Apr 16 03:41:50.924399 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.810195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.863349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/installations.operator.tigera.io\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:41:50.953918 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.810214Z","caller":"traceutil/trace.go:171","msg":"trace[1374243588] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/installations.operator.tigera.io; range_end:; response_count:0; response_revision:492; }","duration":"291.884827ms","start":"2026-04-16T03:41:50.518322Z","end":"2026-04-16T03:41:50.810207Z","steps":["trace[1374243588] 'agreement among raft nodes before linearized reading' (duration: 291.853017ms)"],"step_count":1} Apr 16 03:41:50.953918 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.799001Z","caller":"traceutil/trace.go:171","msg":"trace[1799674149] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"275.575064ms","start":"2026-04-16T03:41:50.523000Z","end":"2026-04-16T03:41:50.798575Z","steps":["trace[1799674149] 'process raft request' (duration: 272.694475ms)"],"step_count":1} Apr 16 03:41:50.953918 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.817623Z","caller":"traceutil/trace.go:171","msg":"trace[1541629000] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:501; }","duration":"284.152847ms","start":"2026-04-16T03:41:50.519289Z","end":"2026-04-16T03:41:50.803442Z","steps":["trace[1541629000] 'read index received' (duration: 22.30173ms)","trace[1541629000] 'applied index is now lower than readState.Index' (duration: 261.474133ms)"],"step_count":2} Apr 16 03:41:51.022808 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.921799Z","caller":"traceutil/trace.go:171","msg":"trace[434773276] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"109.072952ms","start":"2026-04-16T03:41:50.812703Z","end":"2026-04-16T03:41:50.921776Z","steps":["trace[434773276] 'process raft request' (duration: 22.734933ms)"],"step_count":1} Apr 16 03:41:51.022808 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.952924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.642725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 ","response":"range_response_count:1 size:207"} Apr 16 03:41:51.022808 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:50.953602Z","caller":"traceutil/trace.go:171","msg":"trace[1784761370] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:493; }","duration":"426.677945ms","start":"2026-04-16T03:41:50.526870Z","end":"2026-04-16T03:41:50.953548Z","steps":["trace[1784761370] 'agreement among raft nodes before linearized reading' (duration: 336.905443ms)"],"step_count":1} Apr 16 03:41:51.022808 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:50.953744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:41:50.526853Z","time spent":"426.864298ms","remote":"10.0.0.7:45400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 "} Apr 16 03:41:51.069755 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.028001Z","caller":"traceutil/trace.go:171","msg":"trace[526426220] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"164.114192ms","start":"2026-04-16T03:41:50.863811Z","end":"2026-04-16T03:41:51.027926Z","steps":["trace[526426220] 'process raft request' (duration: 115.865355ms)","trace[526426220] 'compare' (duration: 36.040117ms)","trace[526426220] 'check requests' (duration: 10.368279ms)"],"step_count":3} Apr 16 03:41:51.084514 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.030414Z","caller":"traceutil/trace.go:171","msg":"trace[1552574640] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"109.333316ms","start":"2026-04-16T03:41:50.921064Z","end":"2026-04-16T03:41:51.030397Z","steps":["trace[1552574640] 'process raft request' (duration: 107.097149ms)"],"step_count":1} Apr 16 03:41:51.084514 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.030533Z","caller":"traceutil/trace.go:171","msg":"trace[1163497537] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"107.999956ms","start":"2026-04-16T03:41:50.922526Z","end":"2026-04-16T03:41:51.030526Z","steps":["trace[1163497537] 'process raft request' (duration: 105.343319ms)"],"step_count":1} Apr 16 03:41:51.880147 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.811985Z","caller":"traceutil/trace.go:171","msg":"trace[1929826051] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"123.66138ms","start":"2026-04-16T03:41:51.687824Z","end":"2026-04-16T03:41:51.811486Z","steps":["trace[1929826051] 'process raft request' (duration: 120.865539ms)"],"step_count":1} Apr 16 03:41:51.880147 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.839797Z","caller":"traceutil/trace.go:171","msg":"trace[1698846909] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"141.426711ms","start":"2026-04-16T03:41:51.685616Z","end":"2026-04-16T03:41:51.827043Z","steps":["trace[1698846909] 'process raft request' (duration: 121.416509ms)"],"step_count":1} Apr 16 03:41:52.042768 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.881793Z","caller":"traceutil/trace.go:171","msg":"trace[1306974193] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"193.840729ms","start":"2026-04-16T03:41:51.687891Z","end":"2026-04-16T03:41:51.881732Z","steps":["trace[1306974193] 'process raft request' (duration: 120.832719ms)"],"step_count":1} Apr 16 03:41:52.064874 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.979493Z","caller":"traceutil/trace.go:171","msg":"trace[902670806] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:517; }","duration":"208.298214ms","start":"2026-04-16T03:41:51.771171Z","end":"2026-04-16T03:41:51.979470Z","steps":["trace[902670806] 'read index received' (duration: 6.452288ms)","trace[902670806] 'applied index is now lower than readState.Index' (duration: 201.843841ms)"],"step_count":2} Apr 16 03:41:52.064874 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.979757Z","caller":"traceutil/trace.go:171","msg":"trace[1853613806] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"188.90736ms","start":"2026-04-16T03:41:51.790834Z","end":"2026-04-16T03:41:51.979742Z","steps":["trace[1853613806] 'process raft request' (duration: 188.797505ms)"],"step_count":1} Apr 16 03:41:52.064874 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:51.979811Z","caller":"traceutil/trace.go:171","msg":"trace[1568697134] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"208.927915ms","start":"2026-04-16T03:41:51.770875Z","end":"2026-04-16T03:41:51.979803Z","steps":["trace[1568697134] 'process raft request' (duration: 200.292274ms)"],"step_count":1} Apr 16 03:41:52.064874 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:51.980046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.859722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:41:52.064874 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:52.004510Z","caller":"traceutil/trace.go:171","msg":"trace[358590265] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:507; }","duration":"233.318631ms","start":"2026-04-16T03:41:51.771168Z","end":"2026-04-16T03:41:52.004486Z","steps":["trace[358590265] 'agreement among raft nodes before linearized reading' (duration: 208.792825ms)"],"step_count":1} Apr 16 03:41:52.072447 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:52.012350Z","caller":"traceutil/trace.go:171","msg":"trace[1606307439] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"213.487204ms","start":"2026-04-16T03:41:51.786531Z","end":"2026-04-16T03:41:52.000018Z","steps":["trace[1606307439] 'process raft request' (duration: 192.861633ms)"],"step_count":1} Apr 16 03:41:52.104134 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:52.082882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.613394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:3684"} Apr 16 03:41:52.104134 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:52.097850Z","caller":"traceutil/trace.go:171","msg":"trace[231181451] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:507; }","duration":"299.10258ms","start":"2026-04-16T03:41:51.798724Z","end":"2026-04-16T03:41:52.097827Z","steps":["trace[231181451] 'agreement among raft nodes before linearized reading' (duration: 205.610266ms)","trace[231181451] 'range keys from in-memory index tree' (duration: 77.976137ms)"],"step_count":2} Apr 16 03:41:53.025887 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:52.993765Z","caller":"traceutil/trace.go:171","msg":"trace[1288878447] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"122.470992ms","start":"2026-04-16T03:41:52.859798Z","end":"2026-04-16T03:41:52.982269Z","steps":["trace[1288878447] 'process raft request' (duration: 19.10479ms)","trace[1288878447] 'store kv pair into bolt db' {req_type:put; key:/registry/configmaps/tigera-operator/kube-root-ca.crt; req_size:1736; } (duration: 24.558471ms)"],"step_count":2} Apr 16 03:41:59.107240 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:59.057881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.77066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Apr 16 03:41:59.148193 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:59.075982Z","caller":"traceutil/trace.go:171","msg":"trace[1003208277] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"204.117143ms","start":"2026-04-16T03:41:58.871511Z","end":"2026-04-16T03:41:59.075628Z","steps":["trace[1003208277] 'process raft request' (duration: 61.274368ms)","trace[1003208277] 'compare' (duration: 102.207104ms)","trace[1003208277] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 10.917936ms)"],"step_count":3} Apr 16 03:41:59.148193 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:59.075783Z","caller":"traceutil/trace.go:171","msg":"trace[1207658867] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"205.936458ms","start":"2026-04-16T03:41:58.869383Z","end":"2026-04-16T03:41:59.075320Z","steps":["trace[1207658867] 'read index received' (duration: 29.795899ms)","trace[1207658867] 'applied index is now lower than readState.Index' (duration: 176.033312ms)"],"step_count":2} Apr 16 03:41:59.148193 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:41:59.080800Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.150273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/installations.operator.tigera.io\" limit:1 ","response":"range_response_count:0 size:5"} Apr 16 03:41:59.148193 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:41:59.080861Z","caller":"traceutil/trace.go:171","msg":"trace[148467683] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/installations.operator.tigera.io; range_end:; response_count:0; response_revision:552; }","duration":"211.464614ms","start":"2026-04-16T03:41:58.869377Z","end":"2026-04-16T03:41:59.080842Z","steps":["trace[148467683] 'agreement among raft nodes before linearized reading' (duration: 210.887849ms)"],"step_count":1} Apr 16 03:42:18.902689 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:42:18.850830Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.007717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Apr 16 03:42:18.902689 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:42:18.851055Z","caller":"traceutil/trace.go:171","msg":"trace[949399157] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"167.444645ms","start":"2026-04-16T03:42:18.683589Z","end":"2026-04-16T03:42:18.851033Z","steps":["trace[949399157] 'process raft request' (duration: 15.694086ms)","trace[949399157] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 29.178399ms)","trace[949399157] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 56.665584ms)"],"step_count":3} Apr 16 03:42:21.889336 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:42:21.866521Z","caller":"traceutil/trace.go:171","msg":"trace[302141059] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"106.33642ms","start":"2026-04-16T03:42:21.760154Z","end":"2026-04-16T03:42:21.866490Z","steps":["trace[302141059] 'process raft request' (duration: 64.505505ms)","trace[302141059] 'compare' (duration: 41.181903ms)"],"step_count":2} Apr 16 03:42:25.946906 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:42:25.915327Z","caller":"traceutil/trace.go:171","msg":"trace[1324796151] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"123.884465ms","start":"2026-04-16T03:42:25.783437Z","end":"2026-04-16T03:42:25.907321Z","steps":["trace[1324796151] 'read index received' (duration: 90.422801ms)","trace[1324796151] 'applied index is now lower than readState.Index' (duration: 33.336999ms)"],"step_count":2} Apr 16 03:42:25.946906 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:42:25.915909Z","caller":"traceutil/trace.go:171","msg":"trace[1595913173] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"132.409262ms","start":"2026-04-16T03:42:25.783196Z","end":"2026-04-16T03:42:25.915606Z","steps":["trace[1595913173] 'process raft request' (duration: 93.672622ms)","trace[1595913173] 'compare' (duration: 11.589369ms)","trace[1595913173] 'store kv pair into bolt db' {req_type:put; key:/registry/deployments/tigera-operator/tigera-operator; req_size:3258; } (duration: 10.340653ms)"],"step_count":3} Apr 16 03:42:25.976732 etcd-wrapper[1669]: {"level":"warn","ts":"2026-04-16T03:42:25.941623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.522994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} Apr 16 03:42:25.976732 etcd-wrapper[1669]: {"level":"info","ts":"2026-04-16T03:42:25.944033Z","caller":"traceutil/trace.go:171","msg":"trace[1357132882] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:592; }","duration":"158.710176ms","start":"2026-04-16T03:42:25.783336Z","end":"2026-04-16T03:42:25.942046Z","steps":["trace[1357132882] 'agreement among raft nodes before linearized reading' (duration: 136.74013ms)"],"step_count":1}