Jun 4 23:58:12.992170 kernel: Linux version 6.6.142-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 Thu Jun 4 22:23:18 -00 2026 Jun 4 23:58:12.992233 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=e1004ccd988c172286f015cffa1e8c8cccfff5b7e9ae8436827a357b2897c394 Jun 4 23:58:12.992249 kernel: BIOS-provided physical RAM map: Jun 4 23:58:12.992258 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jun 4 23:58:12.992264 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jun 4 23:58:12.992271 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jun 4 23:58:12.992279 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Jun 4 23:58:12.992287 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Jun 4 23:58:12.992293 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jun 4 23:58:12.992302 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Jun 4 23:58:12.992309 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jun 4 23:58:12.992316 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jun 4 23:58:12.992374 kernel: NX (Execute Disable) protection: active Jun 4 23:58:12.992382 kernel: APIC: Static calls initialized Jun 4 23:58:12.992391 kernel: SMBIOS 2.8 present. Jun 4 23:58:12.992448 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Jun 4 23:58:12.992457 kernel: Hypervisor detected: KVM Jun 4 23:58:12.992465 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jun 4 23:58:12.992472 kernel: kvm-clock: using sched offset of 20155624123 cycles Jun 4 23:58:12.992481 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jun 4 23:58:12.992489 kernel: tsc: Detected 2793.438 MHz processor Jun 4 23:58:12.992497 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 4 23:58:12.992505 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 4 23:58:12.992513 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x10000000000 Jun 4 23:58:12.992523 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Jun 4 23:58:12.992531 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 4 23:58:12.992539 kernel: Using GB pages for direct mapping Jun 4 23:58:12.992547 kernel: ACPI: Early table checksum verification disabled Jun 4 23:58:12.992554 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Jun 4 23:58:12.992562 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.992570 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.992578 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.992585 kernel: ACPI: FACS 0x000000009CFE0000 000040 Jun 4 23:58:12.993574 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.993587 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.994292 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.994329 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:58:12.994337 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Jun 4 23:58:12.994346 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Jun 4 23:58:12.994356 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Jun 4 23:58:12.994402 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Jun 4 23:58:12.994413 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Jun 4 23:58:12.994421 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Jun 4 23:58:12.994429 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Jun 4 23:58:12.994438 kernel: No NUMA configuration found Jun 4 23:58:12.994446 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Jun 4 23:58:12.994453 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Jun 4 23:58:12.994463 kernel: Zone ranges: Jun 4 23:58:12.994473 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 4 23:58:12.994482 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Jun 4 23:58:12.994492 kernel: Normal empty Jun 4 23:58:12.994502 kernel: Movable zone start for each node Jun 4 23:58:12.994512 kernel: Early memory node ranges Jun 4 23:58:12.994521 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jun 4 23:58:12.994530 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Jun 4 23:58:12.994540 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Jun 4 23:58:12.994549 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 4 23:58:12.994561 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jun 4 23:58:12.995298 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Jun 4 23:58:12.995372 kernel: ACPI: PM-Timer IO Port: 0x608 Jun 4 23:58:12.995384 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jun 4 23:58:12.995394 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jun 4 23:58:12.995404 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jun 4 23:58:12.995414 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jun 4 23:58:12.995422 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 4 23:58:12.995431 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jun 4 23:58:12.995506 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jun 4 23:58:12.995515 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 4 23:58:12.995524 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jun 4 23:58:12.995533 kernel: TSC deadline timer available Jun 4 23:58:12.995542 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jun 4 23:58:12.995551 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jun 4 23:58:12.995560 kernel: kvm-guest: KVM setup pv remote TLB flush Jun 4 23:58:12.995569 kernel: kvm-guest: setup PV sched yield Jun 4 23:58:12.995677 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Jun 4 23:58:12.995690 kernel: Booting paravirtualized kernel on KVM Jun 4 23:58:12.995699 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jun 4 23:58:12.995708 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jun 4 23:58:12.995717 kernel: percpu: Embedded 57 pages/cpu s196392 r8192 d28888 u524288 Jun 4 23:58:12.995726 kernel: pcpu-alloc: s196392 r8192 d28888 u524288 alloc=1*2097152 Jun 4 23:58:12.995735 kernel: pcpu-alloc: [0] 0 1 2 3 Jun 4 23:58:12.995743 kernel: kvm-guest: PV spinlocks enabled Jun 4 23:58:12.995752 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jun 4 23:58:12.995764 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=e1004ccd988c172286f015cffa1e8c8cccfff5b7e9ae8436827a357b2897c394 Jun 4 23:58:12.995776 kernel: random: crng init done Jun 4 23:58:12.995785 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 4 23:58:12.995795 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 4 23:58:12.995804 kernel: Fallback order for Node 0: 0 Jun 4 23:58:12.995813 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 Jun 4 23:58:12.995821 kernel: Policy zone: DMA32 Jun 4 23:58:12.995830 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 4 23:58:12.995838 kernel: Memory: 2433652K/2571752K available (12288K kernel code, 2288K rwdata, 22760K rodata, 42896K init, 2296K bss, 137896K reserved, 0K cma-reserved) Jun 4 23:58:12.995950 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 4 23:58:12.995958 kernel: ftrace: allocating 38023 entries in 149 pages Jun 4 23:58:12.995967 kernel: ftrace: allocated 149 pages with 4 groups Jun 4 23:58:12.995975 kernel: Dynamic Preempt: voluntary Jun 4 23:58:12.995984 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 4 23:58:12.995993 kernel: rcu: RCU event tracing is enabled. Jun 4 23:58:12.996001 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jun 4 23:58:12.996010 kernel: Trampoline variant of Tasks RCU enabled. Jun 4 23:58:12.996020 kernel: Rude variant of Tasks RCU enabled. Jun 4 23:58:12.996029 kernel: Tracing variant of Tasks RCU enabled. Jun 4 23:58:12.996037 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 4 23:58:12.996046 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 4 23:58:12.996054 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jun 4 23:58:12.996107 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 4 23:58:12.996116 kernel: Console: colour VGA+ 80x25 Jun 4 23:58:12.996124 kernel: printk: console [ttyS0] enabled Jun 4 23:58:12.996132 kernel: ACPI: Core revision 20230628 Jun 4 23:58:12.996141 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jun 4 23:58:12.996153 kernel: APIC: Switch to symmetric I/O mode setup Jun 4 23:58:12.996160 kernel: x2apic enabled Jun 4 23:58:12.996168 kernel: APIC: Switched APIC routing to: physical x2apic Jun 4 23:58:12.996176 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jun 4 23:58:12.996183 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jun 4 23:58:12.996191 kernel: kvm-guest: setup PV IPIs Jun 4 23:58:12.996199 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jun 4 23:58:12.996207 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Jun 4 23:58:12.996225 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Jun 4 23:58:12.996233 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jun 4 23:58:12.996242 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jun 4 23:58:12.996251 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jun 4 23:58:12.996261 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 4 23:58:12.996270 kernel: Spectre V2 : Mitigation: Retpolines Jun 4 23:58:12.996280 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jun 4 23:58:12.996288 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Jun 4 23:58:12.996300 kernel: RETBleed: Vulnerable Jun 4 23:58:12.996308 kernel: Speculative Store Bypass: Vulnerable Jun 4 23:58:12.996318 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Jun 4 23:58:12.996374 kernel: GDS: Unknown: Dependent on hypervisor status Jun 4 23:58:12.996383 kernel: active return thunk: its_return_thunk Jun 4 23:58:12.996392 kernel: ITS: Mitigation: Aligned branch/return thunks Jun 4 23:58:12.996401 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 4 23:58:12.996411 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 4 23:58:12.996419 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jun 4 23:58:12.996431 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Jun 4 23:58:12.996489 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Jun 4 23:58:12.996498 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Jun 4 23:58:12.996508 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jun 4 23:58:12.996516 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Jun 4 23:58:12.996524 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Jun 4 23:58:12.996534 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Jun 4 23:58:12.996542 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Jun 4 23:58:12.996550 kernel: Freeing SMP alternatives memory: 32K Jun 4 23:58:12.996563 kernel: pid_max: default: 32768 minimum: 301 Jun 4 23:58:12.996572 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jun 4 23:58:12.996580 kernel: landlock: Up and running. Jun 4 23:58:12.996638 kernel: SELinux: Initializing. Jun 4 23:58:12.996649 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 4 23:58:12.996658 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 4 23:58:12.996668 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Jun 4 23:58:12.996725 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 4 23:58:12.996736 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 4 23:58:12.996748 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 4 23:58:12.996756 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Jun 4 23:58:12.996767 kernel: signal: max sigframe size: 3632 Jun 4 23:58:12.996777 kernel: rcu: Hierarchical SRCU implementation. Jun 4 23:58:12.996786 kernel: rcu: Max phase no-delay instances is 400. Jun 4 23:58:12.996794 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jun 4 23:58:12.996803 kernel: smp: Bringing up secondary CPUs ... Jun 4 23:58:12.996812 kernel: smpboot: x86: Booting SMP configuration: Jun 4 23:58:12.996821 kernel: .... node #0, CPUs: #1 #2 #3 Jun 4 23:58:12.996832 kernel: smp: Brought up 1 node, 4 CPUs Jun 4 23:58:12.997794 kernel: smpboot: Max logical packages: 1 Jun 4 23:58:12.998044 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Jun 4 23:58:12.998053 kernel: devtmpfs: initialized Jun 4 23:58:12.998062 kernel: x86/mm: Memory block size: 128MB Jun 4 23:58:12.998072 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 4 23:58:12.998082 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 4 23:58:12.998093 kernel: pinctrl core: initialized pinctrl subsystem Jun 4 23:58:12.998104 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 4 23:58:12.998786 kernel: audit: initializing netlink subsys (disabled) Jun 4 23:58:12.999484 kernel: audit: type=2000 audit(1780617480.102:1): state=initialized audit_enabled=0 res=1 Jun 4 23:58:12.999497 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 4 23:58:12.999506 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 4 23:58:12.999514 kernel: cpuidle: using governor menu Jun 4 23:58:12.999524 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 4 23:58:12.999533 kernel: dca service started, version 1.12.1 Jun 4 23:58:12.999541 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Jun 4 23:58:12.999551 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Jun 4 23:58:12.999651 kernel: PCI: Using configuration type 1 for base access Jun 4 23:58:12.999661 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 4 23:58:12.999669 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 4 23:58:12.999679 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jun 4 23:58:12.999689 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 4 23:58:12.999699 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 4 23:58:12.999758 kernel: ACPI: Added _OSI(Module Device) Jun 4 23:58:12.999769 kernel: ACPI: Added _OSI(Processor Device) Jun 4 23:58:12.999779 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 4 23:58:12.999790 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 4 23:58:12.999800 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jun 4 23:58:12.999810 kernel: ACPI: Interpreter enabled Jun 4 23:58:12.999820 kernel: ACPI: PM: (supports S0 S3 S5) Jun 4 23:58:12.999828 kernel: ACPI: Using IOAPIC for interrupt routing Jun 4 23:58:12.999836 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 4 23:58:12.999948 kernel: PCI: Using E820 reservations for host bridge windows Jun 4 23:58:12.999959 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jun 4 23:58:12.999970 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 4 23:58:13.004388 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jun 4 23:58:13.004735 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jun 4 23:58:13.005365 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jun 4 23:58:13.005424 kernel: PCI host bridge to bus 0000:00 Jun 4 23:58:13.007581 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jun 4 23:58:13.007746 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 4 23:58:13.008243 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jun 4 23:58:13.009558 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jun 4 23:58:13.009725 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jun 4 23:58:13.009804 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Jun 4 23:58:13.010528 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 4 23:58:13.011769 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Jun 4 23:58:13.012516 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Jun 4 23:58:13.012686 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Jun 4 23:58:13.012751 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Jun 4 23:58:13.012811 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Jun 4 23:58:13.012964 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 4 23:58:13.013122 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Jun 4 23:58:13.013186 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Jun 4 23:58:13.013247 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Jun 4 23:58:13.013312 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Jun 4 23:58:13.013648 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Jun 4 23:58:13.013720 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Jun 4 23:58:13.013782 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Jun 4 23:58:13.014283 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Jun 4 23:58:13.016380 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Jun 4 23:58:13.016465 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Jun 4 23:58:13.016525 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Jun 4 23:58:13.016586 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Jun 4 23:58:13.017443 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Jun 4 23:58:13.017694 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Jun 4 23:58:13.018283 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jun 4 23:58:13.018409 kernel: pci 0000:00:1f.0: quirk_ich7_lpc+0x0/0x180 took 14648 usecs Jun 4 23:58:13.018689 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Jun 4 23:58:13.019336 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Jun 4 23:58:13.019450 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Jun 4 23:58:13.020433 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Jun 4 23:58:13.020513 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Jun 4 23:58:13.020522 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jun 4 23:58:13.020529 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jun 4 23:58:13.020536 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jun 4 23:58:13.020550 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jun 4 23:58:13.020557 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jun 4 23:58:13.020564 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jun 4 23:58:13.020570 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jun 4 23:58:13.020577 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jun 4 23:58:13.020584 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jun 4 23:58:13.020650 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jun 4 23:58:13.020657 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jun 4 23:58:13.020664 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jun 4 23:58:13.020673 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jun 4 23:58:13.020680 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jun 4 23:58:13.020686 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jun 4 23:58:13.020693 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jun 4 23:58:13.020700 kernel: iommu: Default domain type: Translated Jun 4 23:58:13.020707 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 4 23:58:13.020713 kernel: PCI: Using ACPI for IRQ routing Jun 4 23:58:13.020720 kernel: PCI: pci_cache_line_size set to 64 bytes Jun 4 23:58:13.020727 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jun 4 23:58:13.020735 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Jun 4 23:58:13.020814 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jun 4 23:58:13.020969 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jun 4 23:58:13.021032 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 4 23:58:13.021039 kernel: vgaarb: loaded Jun 4 23:58:13.021045 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jun 4 23:58:13.021051 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jun 4 23:58:13.021056 kernel: clocksource: Switched to clocksource kvm-clock Jun 4 23:58:13.021064 kernel: VFS: Disk quotas dquot_6.6.0 Jun 4 23:58:13.021070 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 4 23:58:13.021076 kernel: pnp: PnP ACPI init Jun 4 23:58:13.021436 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jun 4 23:58:13.021446 kernel: pnp: PnP ACPI: found 6 devices Jun 4 23:58:13.021452 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 4 23:58:13.021458 kernel: NET: Registered PF_INET protocol family Jun 4 23:58:13.021463 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jun 4 23:58:13.021470 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jun 4 23:58:13.021478 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 4 23:58:13.021484 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 4 23:58:13.021490 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jun 4 23:58:13.021496 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jun 4 23:58:13.021502 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 4 23:58:13.021508 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 4 23:58:13.021513 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 4 23:58:13.021519 kernel: NET: Registered PF_XDP protocol family Jun 4 23:58:13.022277 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jun 4 23:58:13.022339 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jun 4 23:58:13.022392 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jun 4 23:58:13.022445 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jun 4 23:58:13.022499 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jun 4 23:58:13.022552 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Jun 4 23:58:13.022559 kernel: PCI: CLS 0 bytes, default 64 Jun 4 23:58:13.022565 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jun 4 23:58:13.022571 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Jun 4 23:58:13.022932 kernel: Initialise system trusted keyrings Jun 4 23:58:13.022940 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jun 4 23:58:13.022946 kernel: Key type asymmetric registered Jun 4 23:58:13.022952 kernel: Asymmetric key parser 'x509' registered Jun 4 23:58:13.022957 kernel: hrtimer: interrupt took 17559790 ns Jun 4 23:58:13.022964 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jun 4 23:58:13.022969 kernel: io scheduler mq-deadline registered Jun 4 23:58:13.022975 kernel: io scheduler kyber registered Jun 4 23:58:13.022985 kernel: io scheduler bfq registered Jun 4 23:58:13.022991 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jun 4 23:58:13.022997 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jun 4 23:58:13.023003 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jun 4 23:58:13.023008 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jun 4 23:58:13.023014 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 4 23:58:13.023020 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jun 4 23:58:13.023026 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jun 4 23:58:13.023031 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jun 4 23:58:13.023039 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jun 4 23:58:13.024724 kernel: rtc_cmos 00:04: RTC can wake from S4 Jun 4 23:58:13.024759 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jun 4 23:58:13.025029 kernel: rtc_cmos 00:04: registered as rtc0 Jun 4 23:58:13.025038 kernel: hpet: Lost 1 RTC interrupts Jun 4 23:58:13.025094 kernel: rtc_cmos 00:04: setting system clock to 2026-06-04T23:58:09 UTC (1780617489) Jun 4 23:58:13.025149 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jun 4 23:58:13.025157 kernel: intel_pstate: CPU model not supported Jun 4 23:58:13.025168 kernel: NET: Registered PF_INET6 protocol family Jun 4 23:58:13.025173 kernel: Segment Routing with IPv6 Jun 4 23:58:13.025179 kernel: In-situ OAM (IOAM) with IPv6 Jun 4 23:58:13.025185 kernel: NET: Registered PF_PACKET protocol family Jun 4 23:58:13.025191 kernel: Key type dns_resolver registered Jun 4 23:58:13.025197 kernel: IPI shorthand broadcast: enabled Jun 4 23:58:13.025203 kernel: sched_clock: Marking stable (8132041490, 960821874)->(10588329756, -1495466392) Jun 4 23:58:13.025209 kernel: registered taskstats version 1 Jun 4 23:58:13.025214 kernel: Loading compiled-in X.509 certificates Jun 4 23:58:13.025222 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.142-flatcar: f19d6160dbc65d860d419fe300c71fac00dc6f81' Jun 4 23:58:13.025228 kernel: Key type .fscrypt registered Jun 4 23:58:13.025233 kernel: Key type fscrypt-provisioning registered Jun 4 23:58:13.025239 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 4 23:58:13.025245 kernel: ima: Allocated hash algorithm: sha1 Jun 4 23:58:13.025250 kernel: ima: No architecture policies found Jun 4 23:58:13.025256 kernel: clk: Disabling unused clocks Jun 4 23:58:13.025262 kernel: Freeing unused kernel image (initmem) memory: 42896K Jun 4 23:58:13.025268 kernel: Write protecting the kernel read-only data: 36864k Jun 4 23:58:13.025275 kernel: Freeing unused kernel image (rodata/data gap) memory: 1816K Jun 4 23:58:13.025281 kernel: Run /init as init process Jun 4 23:58:13.025286 kernel: with arguments: Jun 4 23:58:13.025292 kernel: /init Jun 4 23:58:13.025298 kernel: with environment: Jun 4 23:58:13.025304 kernel: HOME=/ Jun 4 23:58:13.025309 kernel: TERM=linux Jun 4 23:58:13.025317 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) Jun 4 23:58:13.025325 systemd[1]: Detected virtualization kvm. Jun 4 23:58:13.025333 systemd[1]: Detected architecture x86-64. Jun 4 23:58:13.025339 systemd[1]: Running in initrd. Jun 4 23:58:13.025345 systemd[1]: No hostname configured, using default hostname. Jun 4 23:58:13.025350 systemd[1]: Hostname set to . Jun 4 23:58:13.025357 systemd[1]: Initializing machine ID from VM UUID. Jun 4 23:58:13.025363 systemd[1]: Queued start job for default target initrd.target. Jun 4 23:58:13.025369 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 4 23:58:13.025376 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 4 23:58:13.025383 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jun 4 23:58:13.025397 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 4 23:58:13.025405 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jun 4 23:58:13.025411 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jun 4 23:58:13.025420 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jun 4 23:58:13.025427 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jun 4 23:58:13.025433 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 4 23:58:13.025439 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 4 23:58:13.025445 systemd[1]: Reached target paths.target - Path Units. Jun 4 23:58:13.025452 systemd[1]: Reached target slices.target - Slice Units. Jun 4 23:58:13.025458 systemd[1]: Reached target swap.target - Swaps. Jun 4 23:58:13.025464 systemd[1]: Reached target timers.target - Timer Units. Jun 4 23:58:13.025470 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jun 4 23:58:13.025477 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 4 23:58:13.025484 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jun 4 23:58:13.025490 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jun 4 23:58:13.025496 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 4 23:58:13.025502 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 4 23:58:13.025508 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 4 23:58:13.025514 systemd[1]: Reached target sockets.target - Socket Units. Jun 4 23:58:13.025520 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jun 4 23:58:13.025528 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 4 23:58:13.025534 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jun 4 23:58:13.025540 systemd[1]: Starting systemd-fsck-usr.service... Jun 4 23:58:13.025547 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 4 23:58:13.025553 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 4 23:58:13.025559 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 4 23:58:13.025565 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jun 4 23:58:13.025571 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 4 23:58:13.026220 systemd-journald[195]: Collecting audit messages is disabled. Jun 4 23:58:13.026297 systemd[1]: Finished systemd-fsck-usr.service. Jun 4 23:58:13.026304 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 4 23:58:13.026312 systemd-journald[195]: Journal started Jun 4 23:58:13.026331 systemd-journald[195]: Runtime Journal (/run/log/journal/55cd5626129e4ef6bb605896bc27adce) is 6.0M, max 48.4M, 42.3M free. Jun 4 23:58:12.992265 systemd-modules-load[196]: Inserted module 'overlay' Jun 4 23:58:13.046233 systemd[1]: Started systemd-journald.service - Journal Service. Jun 4 23:58:13.168219 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jun 4 23:58:13.177437 kernel: Bridge firewalling registered Jun 4 23:58:13.176304 systemd-modules-load[196]: Inserted module 'br_netfilter' Jun 4 23:58:13.185342 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 4 23:58:14.756720 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 4 23:58:14.817090 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 4 23:58:14.855066 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 4 23:58:14.941380 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 4 23:58:14.982537 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 4 23:58:15.021454 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 4 23:58:15.049717 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 4 23:58:15.122570 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 4 23:58:15.141327 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jun 4 23:58:15.181470 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 4 23:58:15.195754 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 4 23:58:15.244591 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 4 23:58:15.337065 dracut-cmdline[228]: dracut-dracut-053 Jun 4 23:58:15.388467 dracut-cmdline[228]: 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=e1004ccd988c172286f015cffa1e8c8cccfff5b7e9ae8436827a357b2897c394 Jun 4 23:58:15.534545 systemd-resolved[231]: Positive Trust Anchors: Jun 4 23:58:15.534667 systemd-resolved[231]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 4 23:58:15.535127 systemd-resolved[231]: 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 Jun 4 23:58:15.629542 systemd-resolved[231]: Defaulting to hostname 'linux'. Jun 4 23:58:15.639125 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 4 23:58:15.678316 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 4 23:58:16.400310 kernel: SCSI subsystem initialized Jun 4 23:58:16.430781 kernel: Loading iSCSI transport class v2.0-870. Jun 4 23:58:16.511342 kernel: iscsi: registered transport (tcp) Jun 4 23:58:16.686494 kernel: iscsi: registered transport (qla4xxx) Jun 4 23:58:16.691046 kernel: QLogic iSCSI HBA Driver Jun 4 23:58:17.651051 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jun 4 23:58:17.699717 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jun 4 23:58:18.128494 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jun 4 23:58:18.129432 kernel: device-mapper: uevent: version 1.0.3 Jun 4 23:58:18.144219 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jun 4 23:58:18.675356 kernel: raid6: avx512x4 gen() 7722 MB/s Jun 4 23:58:18.695271 kernel: raid6: avx512x2 gen() 10538 MB/s Jun 4 23:58:18.725327 kernel: raid6: avx512x1 gen() 20383 MB/s Jun 4 23:58:18.748207 kernel: raid6: avx2x4 gen() 16331 MB/s Jun 4 23:58:18.800413 kernel: raid6: avx2x2 gen() 7812 MB/s Jun 4 23:58:18.828427 kernel: raid6: avx2x1 gen() 7343 MB/s Jun 4 23:58:18.830539 kernel: raid6: using algorithm avx512x1 gen() 20383 MB/s Jun 4 23:58:18.854390 kernel: raid6: .... xor() 4771 MB/s, rmw enabled Jun 4 23:58:18.855243 kernel: raid6: using avx512x2 recovery algorithm Jun 4 23:58:19.035718 kernel: xor: automatically using best checksumming function avx Jun 4 23:58:20.275594 kernel: Btrfs loaded, zoned=no, fsverity=no Jun 4 23:58:20.504332 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jun 4 23:58:20.542714 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 4 23:58:20.717729 systemd-udevd[415]: Using default interface naming scheme 'v255'. Jun 4 23:58:20.751124 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 4 23:58:20.822213 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jun 4 23:58:21.199698 dracut-pre-trigger[419]: rd.md=0: removing MD RAID activation Jun 4 23:58:22.134444 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jun 4 23:58:22.281056 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 4 23:58:23.523413 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 4 23:58:23.573434 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jun 4 23:58:23.638519 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jun 4 23:58:23.699577 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jun 4 23:58:23.726757 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 4 23:58:23.733600 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 4 23:58:23.823778 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jun 4 23:58:23.972380 kernel: libata version 3.00 loaded. Jun 4 23:58:24.002701 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jun 4 23:58:24.103370 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jun 4 23:58:24.135242 kernel: cryptd: max_cpu_qlen set to 1000 Jun 4 23:58:24.138619 kernel: ahci 0000:00:1f.2: version 3.0 Jun 4 23:58:24.156020 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jun 4 23:58:24.161815 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jun 4 23:58:24.194634 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jun 4 23:58:24.197125 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:58:24.197144 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jun 4 23:58:24.207939 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 4 23:58:24.224525 kernel: AVX2 version of gcm_enc/dec engaged. Jun 4 23:58:24.211963 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 4 23:58:24.249276 kernel: AES CTR mode by8 optimization enabled Jun 4 23:58:24.250553 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 4 23:58:24.314547 kernel: scsi host0: ahci Jun 4 23:58:24.316012 kernel: scsi host1: ahci Jun 4 23:58:24.303415 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 4 23:58:24.368399 kernel: scsi host2: ahci Jun 4 23:58:24.411707 kernel: scsi host3: ahci Jun 4 23:58:24.414976 kernel: scsi host4: ahci Jun 4 23:58:24.304789 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 4 23:58:24.471227 kernel: scsi host5: ahci Jun 4 23:58:24.471490 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Jun 4 23:58:24.473321 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Jun 4 23:58:24.473461 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Jun 4 23:58:24.473485 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Jun 4 23:58:24.473498 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Jun 4 23:58:24.473510 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Jun 4 23:58:24.329745 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 4 23:58:24.474307 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 4 23:58:24.683943 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (472) Jun 4 23:58:24.717753 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jun 4 23:58:24.928356 kernel: BTRFS: device fsid 06bc7987-790d-46e3-8f94-012bf306fde1 devid 1 transid 29 /dev/vda3 scanned by (udev-worker) (465) Jun 4 23:58:24.928389 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jun 4 23:58:24.928398 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jun 4 23:58:24.928406 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jun 4 23:58:24.929070 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jun 4 23:58:24.929108 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jun 4 23:58:24.929116 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jun 4 23:58:24.929154 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jun 4 23:58:24.929163 kernel: ata3.00: applying bridge limits Jun 4 23:58:24.929171 kernel: ata3.00: configured for UDMA/100 Jun 4 23:58:24.950161 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jun 4 23:58:24.955523 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jun 4 23:58:25.036327 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 4 23:58:26.683988 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jun 4 23:58:26.698352 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jun 4 23:58:26.698422 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jun 4 23:58:26.717424 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 4 23:58:26.773294 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jun 4 23:58:26.834602 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jun 4 23:58:26.946821 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jun 4 23:58:27.214107 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 4 23:58:27.353971 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:58:27.407276 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:58:27.504298 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:58:27.543292 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 4 23:58:27.642462 kernel: block device autoloading is deprecated and will be removed. Jun 4 23:58:28.455733 disk-uuid[575]: Warning: The kernel is still using the old partition table. Jun 4 23:58:28.455733 disk-uuid[575]: The new table will be used at the next reboot or after you Jun 4 23:58:28.455733 disk-uuid[575]: run partprobe(8) or kpartx(8) Jun 4 23:58:28.455733 disk-uuid[575]: The operation has completed successfully. Jun 4 23:58:29.501499 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 4 23:58:29.516165 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jun 4 23:58:29.728193 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jun 4 23:58:30.142475 sh[594]: Success Jun 4 23:58:30.697520 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Jun 4 23:58:31.724120 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jun 4 23:58:31.818423 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jun 4 23:58:32.020419 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jun 4 23:58:32.364242 kernel: BTRFS info (device dm-0): first mount of filesystem 06bc7987-790d-46e3-8f94-012bf306fde1 Jun 4 23:58:32.368019 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jun 4 23:58:32.369825 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jun 4 23:58:32.384400 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jun 4 23:58:32.390563 kernel: BTRFS info (device dm-0): using free space tree Jun 4 23:58:32.740401 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jun 4 23:58:32.786663 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jun 4 23:58:32.840945 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jun 4 23:58:32.917834 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jun 4 23:58:33.191512 kernel: BTRFS info (device vda6): first mount of filesystem 23791e55-e245-4598-9e8b-2725b1dc26f6 Jun 4 23:58:33.193810 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 4 23:58:33.193831 kernel: BTRFS info (device vda6): using free space tree Jun 4 23:58:33.288427 kernel: BTRFS info (device vda6): auto enabling async discard Jun 4 23:58:33.617173 systemd[1]: mnt-oem.mount: Deactivated successfully. Jun 4 23:58:33.637828 kernel: BTRFS info (device vda6): last unmount of filesystem 23791e55-e245-4598-9e8b-2725b1dc26f6 Jun 4 23:58:33.805781 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jun 4 23:58:33.899327 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jun 4 23:58:35.139481 ignition[680]: Ignition 2.19.0 Jun 4 23:58:35.139545 ignition[680]: Stage: fetch-offline Jun 4 23:58:35.139590 ignition[680]: no configs at "/usr/lib/ignition/base.d" Jun 4 23:58:35.139600 ignition[680]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 4 23:58:35.139794 ignition[680]: parsed url from cmdline: "" Jun 4 23:58:35.139798 ignition[680]: no config URL provided Jun 4 23:58:35.139804 ignition[680]: reading system config file "/usr/lib/ignition/user.ign" Jun 4 23:58:35.139815 ignition[680]: no config at "/usr/lib/ignition/user.ign" Jun 4 23:58:35.139954 ignition[680]: op(1): [started] loading QEMU firmware config module Jun 4 23:58:35.139961 ignition[680]: op(1): executing: "modprobe" "qemu_fw_cfg" Jun 4 23:58:35.401064 ignition[680]: op(1): [finished] loading QEMU firmware config module Jun 4 23:58:35.407160 ignition[680]: QEMU firmware config was not found. Ignoring... Jun 4 23:58:35.408784 ignition[680]: parsing config with SHA512: e5821f7bfd47c8e74f7feaf39bdc9ff1bc1440a32d9d7aecbc4459efeee0706357f8f55bd146c6b1e905a9e27658e103e29f2658d7a11ca2868a68ac1fa5519f Jun 4 23:58:35.738434 unknown[680]: fetched base config from "system" Jun 4 23:58:35.738812 unknown[680]: fetched user config from "qemu" Jun 4 23:58:35.739228 ignition[680]: fetch-offline: fetch-offline passed Jun 4 23:58:35.749250 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jun 4 23:58:35.743445 ignition[680]: Ignition finished successfully Jun 4 23:58:36.843298 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 4 23:58:37.122601 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 4 23:58:38.335396 systemd-networkd[785]: lo: Link UP Jun 4 23:58:38.335459 systemd-networkd[785]: lo: Gained carrier Jun 4 23:58:38.481128 systemd-networkd[785]: Enumeration completed Jun 4 23:58:38.481825 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 4 23:58:38.498652 systemd[1]: Reached target network.target - Network. Jun 4 23:58:38.532509 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jun 4 23:58:38.600550 systemd-networkd[785]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 4 23:58:38.602462 systemd-networkd[785]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 4 23:58:38.621172 systemd-networkd[785]: eth0: Link UP Jun 4 23:58:38.621176 systemd-networkd[785]: eth0: Gained carrier Jun 4 23:58:38.621188 systemd-networkd[785]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 4 23:58:38.632702 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jun 4 23:58:38.712006 systemd-networkd[785]: eth0: DHCPv4 address 10.0.0.22/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 4 23:58:39.941210 ignition[787]: Ignition 2.19.0 Jun 4 23:58:39.941324 ignition[787]: Stage: kargs Jun 4 23:58:40.019295 ignition[787]: no configs at "/usr/lib/ignition/base.d" Jun 4 23:58:40.021074 ignition[787]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 4 23:58:40.146600 ignition[787]: kargs: kargs passed Jun 4 23:58:40.153227 ignition[787]: Ignition finished successfully Jun 4 23:58:40.198066 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jun 4 23:58:40.384833 systemd-networkd[785]: eth0: Gained IPv6LL Jun 4 23:58:40.385017 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jun 4 23:58:41.636233 ignition[795]: Ignition 2.19.0 Jun 4 23:58:41.636320 ignition[795]: Stage: disks Jun 4 23:58:41.636787 ignition[795]: no configs at "/usr/lib/ignition/base.d" Jun 4 23:58:41.636803 ignition[795]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 4 23:58:41.637539 ignition[795]: disks: disks passed Jun 4 23:58:41.637580 ignition[795]: Ignition finished successfully Jun 4 23:58:41.713490 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jun 4 23:58:41.812576 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jun 4 23:58:41.836712 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jun 4 23:58:41.915674 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 4 23:58:41.941303 systemd[1]: Reached target sysinit.target - System Initialization. Jun 4 23:58:41.973676 systemd[1]: Reached target basic.target - Basic System. Jun 4 23:58:42.133346 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jun 4 23:58:42.936093 systemd-fsck[805]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jun 4 23:58:42.974269 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jun 4 23:58:43.018416 systemd[1]: Mounting sysroot.mount - /sysroot... Jun 4 23:58:44.753230 kernel: EXT4-fs (vda9): mounted filesystem e80f7f28-2aaf-492b-8065-60f248a2f64b r/w with ordered data mode. Quota mode: none. Jun 4 23:58:44.754813 systemd[1]: Mounted sysroot.mount - /sysroot. Jun 4 23:58:44.806241 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jun 4 23:58:44.922956 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 4 23:58:44.934695 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jun 4 23:58:44.951474 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jun 4 23:58:44.951539 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jun 4 23:58:44.951570 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jun 4 23:58:45.055984 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (815) Jun 4 23:58:45.056139 kernel: BTRFS info (device vda6): first mount of filesystem 23791e55-e245-4598-9e8b-2725b1dc26f6 Jun 4 23:58:45.088256 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 4 23:58:45.089402 kernel: BTRFS info (device vda6): using free space tree Jun 4 23:58:45.156083 kernel: BTRFS info (device vda6): auto enabling async discard Jun 4 23:58:45.242107 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 4 23:58:45.252302 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jun 4 23:58:45.381375 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jun 4 23:58:46.228986 initrd-setup-root[839]: cut: /sysroot/etc/passwd: No such file or directory Jun 4 23:58:46.285416 initrd-setup-root[846]: cut: /sysroot/etc/group: No such file or directory Jun 4 23:58:46.320982 initrd-setup-root[853]: cut: /sysroot/etc/shadow: No such file or directory Jun 4 23:58:46.372835 initrd-setup-root[860]: cut: /sysroot/etc/gshadow: No such file or directory Jun 4 23:58:49.598739 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jun 4 23:58:49.737346 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jun 4 23:58:49.805120 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jun 4 23:58:49.936066 kernel: BTRFS info (device vda6): last unmount of filesystem 23791e55-e245-4598-9e8b-2725b1dc26f6 Jun 4 23:58:49.936547 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jun 4 23:58:50.122643 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jun 4 23:58:50.243471 ignition[929]: INFO : Ignition 2.19.0 Jun 4 23:58:50.243471 ignition[929]: INFO : Stage: mount Jun 4 23:58:50.254611 ignition[929]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 4 23:58:50.254611 ignition[929]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 4 23:58:50.254611 ignition[929]: INFO : mount: mount passed Jun 4 23:58:50.254611 ignition[929]: INFO : Ignition finished successfully Jun 4 23:58:50.317983 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jun 4 23:58:50.384128 systemd[1]: Starting ignition-files.service - Ignition (files)... Jun 4 23:58:50.537411 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 4 23:58:50.657439 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (942) Jun 4 23:58:50.698266 kernel: BTRFS info (device vda6): first mount of filesystem 23791e55-e245-4598-9e8b-2725b1dc26f6 Jun 4 23:58:50.699641 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 4 23:58:50.710059 kernel: BTRFS info (device vda6): using free space tree Jun 4 23:58:50.769078 kernel: BTRFS info (device vda6): auto enabling async discard Jun 4 23:58:50.794515 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 4 23:58:51.035055 ignition[959]: INFO : Ignition 2.19.0 Jun 4 23:58:51.040287 ignition[959]: INFO : Stage: files Jun 4 23:58:51.040287 ignition[959]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 4 23:58:51.040287 ignition[959]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 4 23:58:51.139613 ignition[959]: DEBUG : files: compiled without relabeling support, skipping Jun 4 23:58:51.200368 ignition[959]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jun 4 23:58:51.200368 ignition[959]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jun 4 23:58:51.217447 ignition[959]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jun 4 23:58:51.217447 ignition[959]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jun 4 23:58:51.217447 ignition[959]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jun 4 23:58:51.211756 unknown[959]: wrote ssh authorized keys file for user: core Jun 4 23:58:51.253465 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jun 4 23:58:51.253465 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jun 4 23:58:51.253465 ignition[959]: 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" Jun 4 23:58:51.253465 ignition[959]: 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" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jun 4 23:58:51.253465 ignition[959]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Jun 4 23:58:51.519423 ignition[959]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Jun 4 23:58:51.560297 ignition[959]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jun 4 23:58:51.574101 ignition[959]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Jun 4 23:58:51.574101 ignition[959]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Jun 4 23:58:51.574101 ignition[959]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Jun 4 23:58:51.574101 ignition[959]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jun 4 23:58:51.574101 ignition[959]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jun 4 23:58:51.574101 ignition[959]: INFO : files: files passed Jun 4 23:58:51.574101 ignition[959]: INFO : Ignition finished successfully Jun 4 23:58:51.571650 systemd[1]: Finished ignition-files.service - Ignition (files). Jun 4 23:58:51.731670 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jun 4 23:58:51.744363 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jun 4 23:58:51.782245 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 4 23:58:51.782426 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jun 4 23:58:51.805256 initrd-setup-root-after-ignition[986]: grep: /sysroot/oem/oem-release: No such file or directory Jun 4 23:58:51.815517 initrd-setup-root-after-ignition[989]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 4 23:58:51.815517 initrd-setup-root-after-ignition[989]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jun 4 23:58:51.853273 initrd-setup-root-after-ignition[993]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 4 23:58:51.821020 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 4 23:58:51.843354 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jun 4 23:58:51.993574 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jun 4 23:58:52.513678 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 4 23:58:52.525335 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jun 4 23:58:52.538017 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jun 4 23:58:52.554453 systemd[1]: Reached target initrd.target - Initrd Default Target. Jun 4 23:58:52.580318 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jun 4 23:58:52.604718 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jun 4 23:58:52.817113 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 4 23:58:52.842328 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jun 4 23:58:53.507271 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jun 4 23:58:53.525264 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 4 23:58:53.548497 systemd[1]: Stopped target timers.target - Timer Units. Jun 4 23:58:53.618208 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 4 23:58:53.620505 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 4 23:58:53.639722 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jun 4 23:58:53.722753 systemd[1]: Stopped target basic.target - Basic System. Jun 4 23:58:53.752616 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jun 4 23:58:53.756293 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jun 4 23:58:53.801735 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jun 4 23:58:53.838115 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jun 4 23:58:53.850208 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jun 4 23:58:53.933709 systemd[1]: Stopped target sysinit.target - System Initialization. Jun 4 23:58:53.953508 systemd[1]: Stopped target local-fs.target - Local File Systems. Jun 4 23:58:53.991648 systemd[1]: Stopped target swap.target - Swaps. Jun 4 23:58:53.997487 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 4 23:58:53.998218 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jun 4 23:58:54.095714 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jun 4 23:58:54.155731 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 4 23:58:54.251537 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jun 4 23:58:54.259238 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 4 23:58:54.273434 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 4 23:58:54.275164 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jun 4 23:58:54.275642 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jun 4 23:58:54.278019 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jun 4 23:58:54.278735 systemd[1]: Stopped target paths.target - Path Units. Jun 4 23:58:54.282561 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 4 23:58:54.291619 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 4 23:58:54.315595 systemd[1]: Stopped target slices.target - Slice Units. Jun 4 23:58:54.327738 systemd[1]: Stopped target sockets.target - Socket Units. Jun 4 23:58:54.418584 systemd[1]: iscsid.socket: Deactivated successfully. Jun 4 23:58:54.422559 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jun 4 23:58:54.450434 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 4 23:58:54.458429 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 4 23:58:54.466237 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jun 4 23:58:54.469401 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 4 23:58:54.500316 systemd[1]: ignition-files.service: Deactivated successfully. Jun 4 23:58:54.500542 systemd[1]: Stopped ignition-files.service - Ignition (files). Jun 4 23:58:54.606344 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jun 4 23:58:54.622475 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 4 23:58:54.622743 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jun 4 23:58:54.693431 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jun 4 23:58:54.698429 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 4 23:58:54.698667 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jun 4 23:58:54.720365 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 4 23:58:54.720517 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jun 4 23:58:54.804342 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 4 23:58:54.804527 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jun 4 23:58:54.923420 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 4 23:58:55.050608 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 4 23:58:55.078232 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jun 4 23:58:55.118501 ignition[1013]: INFO : Ignition 2.19.0 Jun 4 23:58:55.118501 ignition[1013]: INFO : Stage: umount Jun 4 23:58:55.149445 ignition[1013]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 4 23:58:55.149445 ignition[1013]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 4 23:58:55.149445 ignition[1013]: INFO : umount: umount passed Jun 4 23:58:55.149445 ignition[1013]: INFO : Ignition finished successfully Jun 4 23:58:55.426576 systemd[1]: ignition-mount.service: Deactivated successfully. Jun 4 23:58:55.479666 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jun 4 23:58:55.619639 systemd[1]: Stopped target network.target - Network. Jun 4 23:58:55.637329 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 4 23:58:55.637579 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jun 4 23:58:55.731424 systemd[1]: ignition-kargs.service: Deactivated successfully. Jun 4 23:58:55.731650 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jun 4 23:58:55.767698 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 4 23:58:55.768499 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jun 4 23:58:55.795614 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jun 4 23:58:55.796599 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jun 4 23:58:55.849217 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 4 23:58:55.852234 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jun 4 23:58:55.929174 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jun 4 23:58:55.935329 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jun 4 23:58:55.990733 systemd-networkd[785]: eth0: DHCPv6 lease lost Jun 4 23:58:56.104574 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 4 23:58:56.109463 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jun 4 23:58:56.250371 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 4 23:58:56.264710 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jun 4 23:58:56.382599 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 4 23:58:56.397510 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jun 4 23:58:56.566722 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jun 4 23:58:56.594781 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jun 4 23:58:56.595213 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 4 23:58:56.634126 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 4 23:58:56.634279 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jun 4 23:58:56.687667 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jun 4 23:58:56.688682 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jun 4 23:58:56.712034 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jun 4 23:58:56.712123 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 4 23:58:56.809730 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 4 23:58:56.854782 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 4 23:58:56.884606 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 4 23:58:57.052775 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 4 23:58:57.053495 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jun 4 23:58:57.115687 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 4 23:58:57.128719 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jun 4 23:58:57.143583 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 4 23:58:57.143708 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jun 4 23:58:57.185684 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 4 23:58:57.193478 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jun 4 23:58:57.221278 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 4 23:58:57.221537 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 4 23:58:57.335082 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jun 4 23:58:57.348494 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 4 23:58:57.348728 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 4 23:58:57.404655 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 4 23:58:57.406516 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 4 23:58:57.563424 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 4 23:58:57.566044 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jun 4 23:58:58.136625 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 4 23:58:58.140189 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jun 4 23:58:58.190082 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jun 4 23:58:58.233511 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jun 4 23:58:58.797208 systemd[1]: Switching root. Jun 4 23:58:58.973759 systemd-journald[195]: Journal stopped Jun 4 23:59:30.535078 systemd-journald[195]: Received SIGTERM from PID 1 (systemd). Jun 4 23:59:30.535192 kernel: SELinux: policy capability network_peer_controls=1 Jun 4 23:59:30.535211 kernel: SELinux: policy capability open_perms=1 Jun 4 23:59:30.535224 kernel: SELinux: policy capability extended_socket_class=1 Jun 4 23:59:30.535240 kernel: SELinux: policy capability always_check_network=0 Jun 4 23:59:30.535252 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 4 23:59:30.535264 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 4 23:59:30.535278 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 4 23:59:30.535292 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jun 4 23:59:30.535305 kernel: audit: type=1403 audit(1780617540.149:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 4 23:59:30.535318 systemd[1]: Successfully loaded SELinux policy in 493.291ms. Jun 4 23:59:30.535341 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 242.304ms. Jun 4 23:59:30.535355 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) Jun 4 23:59:30.535370 systemd[1]: Detected virtualization kvm. Jun 4 23:59:30.535383 systemd[1]: Detected architecture x86-64. Jun 4 23:59:30.535395 systemd[1]: Detected first boot. Jun 4 23:59:30.535407 systemd[1]: Initializing machine ID from VM UUID. Jun 4 23:59:30.535420 zram_generator::config[1058]: No configuration found. Jun 4 23:59:30.535433 systemd[1]: Populated /etc with preset unit settings. Jun 4 23:59:30.535446 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 4 23:59:30.535458 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jun 4 23:59:30.535472 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 4 23:59:30.535486 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jun 4 23:59:30.535500 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jun 4 23:59:30.535515 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 4 23:59:30.535528 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jun 4 23:59:30.535543 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jun 4 23:59:30.535555 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jun 4 23:59:30.535567 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jun 4 23:59:30.535581 systemd[1]: Created slice user.slice - User and Session Slice. Jun 4 23:59:30.535616 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 4 23:59:30.535629 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 4 23:59:30.535642 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jun 4 23:59:30.535654 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jun 4 23:59:30.535666 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jun 4 23:59:30.535681 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 4 23:59:30.535693 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jun 4 23:59:30.535706 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 4 23:59:30.535718 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jun 4 23:59:30.535730 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jun 4 23:59:30.535742 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jun 4 23:59:30.535754 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jun 4 23:59:30.535780 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 4 23:59:30.535795 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 4 23:59:30.535807 systemd[1]: Reached target slices.target - Slice Units. Jun 4 23:59:30.535824 systemd[1]: Reached target swap.target - Swaps. Jun 4 23:59:30.535837 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jun 4 23:59:30.535875 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jun 4 23:59:30.536250 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 4 23:59:30.536267 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 4 23:59:30.536280 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 4 23:59:30.536292 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jun 4 23:59:30.536309 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jun 4 23:59:30.536321 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jun 4 23:59:30.536335 systemd[1]: Mounting media.mount - External Media Directory... Jun 4 23:59:30.536348 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:30.536362 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jun 4 23:59:30.536375 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jun 4 23:59:30.536388 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jun 4 23:59:30.536400 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). Jun 4 23:59:30.536415 systemd[1]: Reached target machines.target - Containers. Jun 4 23:59:30.536428 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jun 4 23:59:30.536441 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 4 23:59:30.536455 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 4 23:59:30.536467 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jun 4 23:59:30.536480 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 4 23:59:30.536494 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 4 23:59:30.536506 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 4 23:59:30.536538 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jun 4 23:59:30.536553 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 4 23:59:30.536577 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jun 4 23:59:30.536589 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 4 23:59:30.536602 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jun 4 23:59:30.536614 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 4 23:59:30.536626 systemd[1]: Stopped systemd-fsck-usr.service. Jun 4 23:59:30.536638 kernel: fuse: init (API version 7.39) Jun 4 23:59:30.536651 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 4 23:59:30.536663 kernel: loop: module loaded Jun 4 23:59:30.536677 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 4 23:59:30.536689 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 4 23:59:30.536702 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jun 4 23:59:30.536715 kernel: ACPI: bus type drm_connector registered Jun 4 23:59:30.536726 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 4 23:59:30.536777 systemd-journald[1136]: Collecting audit messages is disabled. Jun 4 23:59:30.536802 systemd[1]: verity-setup.service: Deactivated successfully. Jun 4 23:59:30.536816 systemd[1]: Stopped verity-setup.service. Jun 4 23:59:30.536828 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:30.536873 systemd-journald[1136]: Journal started Jun 4 23:59:30.536899 systemd-journald[1136]: Runtime Journal (/run/log/journal/55cd5626129e4ef6bb605896bc27adce) is 6.0M, max 48.4M, 42.3M free. Jun 4 23:59:26.537873 systemd[1]: Queued start job for default target multi-user.target. Jun 4 23:59:27.007881 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jun 4 23:59:27.008463 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 4 23:59:27.014564 systemd[1]: systemd-journald.service: Consumed 3.646s CPU time. Jun 4 23:59:30.559656 systemd[1]: Started systemd-journald.service - Journal Service. Jun 4 23:59:30.625020 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jun 4 23:59:30.630783 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jun 4 23:59:30.646717 systemd[1]: Mounted media.mount - External Media Directory. Jun 4 23:59:30.649292 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jun 4 23:59:30.654758 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jun 4 23:59:30.660250 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jun 4 23:59:30.669340 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jun 4 23:59:30.693682 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 4 23:59:30.784089 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 4 23:59:30.789501 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jun 4 23:59:30.800530 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 4 23:59:30.800780 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 4 23:59:30.806012 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 4 23:59:30.806278 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 4 23:59:30.833934 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 4 23:59:30.834136 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 4 23:59:30.836390 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 4 23:59:30.836574 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jun 4 23:59:30.838293 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 4 23:59:30.840603 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 4 23:59:30.850511 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 4 23:59:30.856434 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 4 23:59:30.924297 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jun 4 23:59:31.115318 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 4 23:59:31.182477 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jun 4 23:59:31.205809 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jun 4 23:59:31.219994 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jun 4 23:59:31.220110 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 4 23:59:31.253177 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jun 4 23:59:31.405372 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jun 4 23:59:31.528250 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jun 4 23:59:31.535498 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 4 23:59:31.550126 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jun 4 23:59:31.614795 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jun 4 23:59:31.618340 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 4 23:59:31.631075 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jun 4 23:59:31.635351 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 4 23:59:31.640360 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 4 23:59:31.770668 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jun 4 23:59:31.780404 systemd-journald[1136]: Time spent on flushing to /var/log/journal/55cd5626129e4ef6bb605896bc27adce is 39.382ms for 932 entries. Jun 4 23:59:31.780404 systemd-journald[1136]: System Journal (/var/log/journal/55cd5626129e4ef6bb605896bc27adce) is 8.0M, max 195.6M, 187.6M free. Jun 4 23:59:31.855284 systemd-journald[1136]: Received client request to flush runtime journal. Jun 4 23:59:31.814217 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jun 4 23:59:31.850146 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 4 23:59:31.853938 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jun 4 23:59:31.890130 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jun 4 23:59:31.909920 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jun 4 23:59:31.922141 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jun 4 23:59:31.929791 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jun 4 23:59:31.954354 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jun 4 23:59:32.041533 kernel: loop0: detected capacity change from 0 to 140768 Jun 4 23:59:32.053637 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jun 4 23:59:32.083367 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jun 4 23:59:32.144224 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 4 23:59:32.233343 udevadm[1186]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jun 4 23:59:32.346634 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 4 23:59:32.330497 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 4 23:59:32.366783 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jun 4 23:59:32.410434 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jun 4 23:59:32.497971 kernel: loop1: detected capacity change from 0 to 142488 Jun 4 23:59:32.530804 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 4 23:59:32.811167 kernel: loop2: detected capacity change from 0 to 140768 Jun 4 23:59:32.956152 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Jun 4 23:59:32.956167 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Jun 4 23:59:33.014621 kernel: loop3: detected capacity change from 0 to 142488 Jun 4 23:59:33.112740 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 4 23:59:33.223649 (sd-merge)[1196]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jun 4 23:59:33.224172 (sd-merge)[1196]: Merged extensions into '/usr'. Jun 4 23:59:33.238752 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jun 4 23:59:33.411356 systemd[1]: Starting ensure-sysext.service... Jun 4 23:59:33.442388 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 4 23:59:33.581388 systemd[1]: Reloading requested from client PID 1199 ('systemctl') (unit ensure-sysext.service)... Jun 4 23:59:33.582507 systemd[1]: Reloading... Jun 4 23:59:33.918681 systemd-tmpfiles[1200]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 4 23:59:33.919324 systemd-tmpfiles[1200]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 4 23:59:33.920609 systemd-tmpfiles[1200]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 4 23:59:33.922382 systemd-tmpfiles[1200]: ACLs are not supported, ignoring. Jun 4 23:59:33.922451 systemd-tmpfiles[1200]: ACLs are not supported, ignoring. Jun 4 23:59:33.942244 systemd-tmpfiles[1200]: Detected autofs mount point /boot during canonicalization of boot. Jun 4 23:59:33.942258 systemd-tmpfiles[1200]: Skipping /boot Jun 4 23:59:34.294082 zram_generator::config[1224]: No configuration found. Jun 4 23:59:34.301087 systemd-tmpfiles[1200]: Detected autofs mount point /boot during canonicalization of boot. Jun 4 23:59:34.330263 systemd-tmpfiles[1200]: Skipping /boot Jun 4 23:59:36.145880 ldconfig[1168]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 4 23:59:36.811806 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. Jun 4 23:59:38.885359 systemd[1]: Reloading finished in 5296 ms. Jun 4 23:59:39.379615 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jun 4 23:59:39.510212 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 4 23:59:40.015735 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jun 4 23:59:40.120585 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jun 4 23:59:40.133548 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jun 4 23:59:40.218028 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 4 23:59:40.412125 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jun 4 23:59:40.507461 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:40.507681 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 4 23:59:40.534560 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 4 23:59:40.651732 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 4 23:59:40.688133 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 4 23:59:40.706214 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 4 23:59:40.731468 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:40.804144 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jun 4 23:59:40.848979 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:40.852238 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 4 23:59:40.902479 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 4 23:59:40.982881 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jun 4 23:59:40.990157 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:41.039286 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jun 4 23:59:41.096745 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 4 23:59:41.104482 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 4 23:59:41.127613 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 4 23:59:41.127824 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 4 23:59:41.192640 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 4 23:59:41.202751 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 4 23:59:41.232128 augenrules[1292]: No rules Jun 4 23:59:41.233243 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jun 4 23:59:41.681938 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jun 4 23:59:41.739908 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:41.740768 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 4 23:59:41.833182 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 4 23:59:41.934691 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 4 23:59:42.019081 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 4 23:59:42.040745 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 4 23:59:42.045524 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 4 23:59:42.045625 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). Jun 4 23:59:42.045651 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 4 23:59:42.054525 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jun 4 23:59:42.111917 systemd[1]: Finished ensure-sysext.service. Jun 4 23:59:42.129974 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 4 23:59:42.184075 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 4 23:59:42.212183 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 4 23:59:42.214520 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 4 23:59:42.228440 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 4 23:59:42.228641 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 4 23:59:42.251682 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 4 23:59:42.324404 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 4 23:59:42.480661 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 4 23:59:42.480955 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 4 23:59:42.532831 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jun 4 23:59:43.422318 systemd-resolved[1277]: Positive Trust Anchors: Jun 4 23:59:43.422388 systemd-resolved[1277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 4 23:59:43.422425 systemd-resolved[1277]: 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 Jun 4 23:59:43.720693 systemd-resolved[1277]: Defaulting to hostname 'linux'. Jun 4 23:59:43.804227 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 4 23:59:43.824535 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 4 23:59:43.979537 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jun 4 23:59:43.993034 systemd[1]: Reached target time-set.target - System Time Set. Jun 5 00:00:26.187081 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jun 5 00:00:27.879645 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 5 00:00:28.656444 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jun 5 00:00:30.298991 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jun 5 00:00:32.137451 systemd-udevd[1320]: Using default interface naming scheme 'v255'. Jun 5 00:00:55.013784 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 5 00:00:55.611806 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 5 00:00:57.718254 systemd[1]: dev-disk-by\x2dlabel-OEM.device: Job dev-disk-by\x2dlabel-OEM.device/start timed out. Jun 5 00:00:57.719616 systemd[1]: Timed out waiting for device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 5 00:00:57.732224 systemd[1]: Dependency failed for systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jun 5 00:00:57.744598 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Job systemd-fsck@dev-disk-by\x2dlabel-OEM.service/start failed with result 'dependency'. Jun 5 00:00:57.752018 systemd[1]: dev-disk-by\x2dlabel-OEM.device: Job dev-disk-by\x2dlabel-OEM.device/start failed with result 'timeout'. Jun 5 00:00:57.752319 systemd[1]: dev-ttyS0.device: Job dev-ttyS0.device/start timed out. Jun 5 00:00:57.754309 systemd[1]: Timed out waiting for device dev-ttyS0.device - /dev/ttyS0. Jun 5 00:00:57.789814 systemd[1]: Dependency failed for serial-getty@ttyS0.service - Serial Getty on ttyS0. Jun 5 00:00:57.804556 systemd[1]: serial-getty@ttyS0.service: Job serial-getty@ttyS0.service/start failed with result 'dependency'. Jun 5 00:00:57.809769 systemd[1]: dev-ttyS0.device: Job dev-ttyS0.device/start failed with result 'timeout'. Jun 5 00:00:58.030246 systemd-networkd[1324]: lo: Link UP Jun 5 00:00:58.030501 systemd-networkd[1324]: lo: Gained carrier Jun 5 00:00:58.088704 systemd-networkd[1324]: Enumeration completed Jun 5 00:00:58.089257 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 5 00:00:58.098810 systemd[1]: Reached target network.target - Network. Jun 5 00:00:58.229418 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jun 5 00:00:58.254094 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 29 scanned by (udev-worker) (1332) Jun 5 00:00:59.524208 systemd-networkd[1324]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 5 00:00:59.524283 systemd-networkd[1324]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 5 00:00:59.581199 systemd-networkd[1324]: eth0: Link UP Jun 5 00:00:59.581764 systemd-networkd[1324]: eth0: Gained carrier Jun 5 00:00:59.582781 systemd-networkd[1324]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 5 00:00:59.684764 systemd-networkd[1324]: eth0: DHCPv4 address 10.0.0.22/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 5 00:00:59.731918 systemd-timesyncd[1317]: Network configuration changed, trying to establish connection. Jun 5 00:00:59.748476 systemd-timesyncd[1317]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jun 5 00:00:59.749083 systemd-timesyncd[1317]: Initial clock synchronization to Fri 2026-06-05 00:00:59.999534 UTC. Jun 5 00:01:00.532728 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Jun 5 00:01:00.627627 systemd-networkd[1324]: eth0: Gained IPv6LL Jun 5 00:01:00.658176 kernel: ACPI: button: Power Button [PWRF] Jun 5 00:01:00.748433 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jun 5 00:01:00.805488 systemd[1]: Reached target network-online.target - Network is Online. Jun 5 00:01:01.905378 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Jun 5 00:01:02.036460 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jun 5 00:01:02.057197 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jun 5 00:01:02.063563 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jun 5 00:01:04.202377 kernel: mousedev: PS/2 mouse device common for all mice Jun 5 00:01:04.219821 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 5 00:01:09.305543 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jun 5 00:01:09.895625 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jun 5 00:01:12.406825 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 5 00:01:13.637043 lvm[1362]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jun 5 00:01:17.861310 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jun 5 00:01:18.066448 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 5 00:01:18.107764 systemd[1]: Reached target sysinit.target - System Initialization. Jun 5 00:01:18.135645 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jun 5 00:01:18.717590 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 5 00:01:19.272414 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jun 5 00:01:19.431869 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jun 5 00:01:19.670692 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 5 00:01:19.883344 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jun 5 00:01:20.159666 systemd[1]: Reached target paths.target - Path Units. Jun 5 00:01:20.241295 systemd[1]: Reached target timers.target - Timer Units. Jun 5 00:01:21.539071 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jun 5 00:01:24.185354 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 5 00:01:27.724708 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jun 5 00:01:28.188800 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jun 5 00:01:28.587236 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 5 00:01:28.776018 systemd[1]: Reached target sockets.target - Socket Units. Jun 5 00:01:28.805150 systemd[1]: Reached target basic.target - Basic System. Jun 5 00:01:28.845705 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jun 5 00:01:28.877008 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jun 5 00:01:29.131291 systemd[1]: Starting containerd.service - containerd container runtime... Jun 5 00:01:29.172142 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 5 00:01:29.271716 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jun 5 00:01:29.327017 lvm[1367]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jun 5 00:01:29.334801 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jun 5 00:01:29.459652 jq[1371]: false Jun 5 00:01:29.469041 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jun 5 00:01:29.476580 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). Jun 5 00:01:29.547822 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jun 5 00:01:29.667405 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jun 5 00:01:29.928932 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jun 5 00:01:29.987723 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jun 5 00:01:30.073340 extend-filesystems[1372]: Found loop2 Jun 5 00:01:30.073340 extend-filesystems[1372]: Found loop3 Jun 5 00:01:30.073340 extend-filesystems[1372]: Found sr0 Jun 5 00:01:30.185978 dbus-daemon[1370]: [system] SELinux support is enabled Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda1 Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda2 Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda3 Jun 5 00:01:30.238418 extend-filesystems[1372]: Found usr Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda4 Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda6 Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda7 Jun 5 00:01:30.238418 extend-filesystems[1372]: Found vda9 Jun 5 00:01:30.238418 extend-filesystems[1372]: Checking size of /dev/vda9 Jun 5 00:01:30.226473 systemd[1]: Starting systemd-logind.service - User Login Management... Jun 5 00:01:30.239397 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jun 5 00:01:30.250754 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 5 00:01:30.353763 systemd[1]: Starting update-engine.service - Update Engine... Jun 5 00:01:30.472603 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jun 5 00:01:30.508317 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jun 5 00:01:30.565720 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jun 5 00:01:30.744835 extend-filesystems[1372]: Old size kept for /dev/vda9 Jun 5 00:01:30.781081 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jun 5 00:01:30.804797 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jun 5 00:01:30.875410 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 5 00:01:31.227705 jq[1388]: true Jun 5 00:01:30.880624 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jun 5 00:01:31.058386 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 5 00:01:31.063712 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jun 5 00:01:31.162559 systemd[1]: motdgen.service: Deactivated successfully. Jun 5 00:01:31.167410 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jun 5 00:01:31.680767 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jun 5 00:01:31.817251 jq[1403]: true Jun 5 00:01:32.075970 (ntainerd)[1408]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 5 00:01:32.171401 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 5 00:01:32.175832 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 5 00:01:32.505280 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 29 scanned by (udev-worker) (1411) Jun 5 00:01:32.606024 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jun 5 00:01:32.835315 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jun 5 00:01:32.848329 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jun 5 00:01:32.857445 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). Jun 5 00:01:32.896379 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jun 5 00:01:32.983612 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). Jun 5 00:01:32.987098 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jun 5 00:01:33.196734 (-wrapper)[1438]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jun 5 00:01:33.553390 bash[1439]: Updated "/home/core/.ssh/authorized_keys" Jun 5 00:01:33.707655 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jun 5 00:01:33.779802 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jun 5 00:01:33.855528 sshd_keygen[1393]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jun 5 00:01:33.987685 update_engine[1384]: I20260605 00:01:33.929992 1384 main.cc:92] Flatcar Update Engine starting Jun 5 00:01:34.855165 systemd[1]: Started update-engine.service - Update Engine. Jun 5 00:01:34.952637 update_engine[1384]: I20260605 00:01:34.952229 1384 update_check_scheduler.cc:74] Next update check in 4m29s Jun 5 00:01:35.065966 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jun 5 00:01:36.561273 systemd-logind[1379]: Watching system buttons on /dev/input/event1 (Power Button) Jun 5 00:01:36.564541 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jun 5 00:01:36.564960 systemd-logind[1379]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jun 5 00:01:36.613614 systemd-logind[1379]: New seat seat0. Jun 5 00:01:37.234084 systemd[1]: Starting issuegen.service - Generate /run/issue... Jun 5 00:01:37.507590 systemd[1]: Started sshd@0-10.0.0.22:22-10.0.0.1:49480.service - OpenSSH per-connection server daemon (10.0.0.1:49480). Jun 5 00:01:37.610220 systemd[1]: Started systemd-logind.service - User Login Management. Jun 5 00:01:38.307611 systemd[1]: issuegen.service: Deactivated successfully. Jun 5 00:01:38.354261 systemd[1]: Finished issuegen.service - Generate /run/issue. Jun 5 00:01:38.893215 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jun 5 00:01:39.067917 locksmithd[1457]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 5 00:01:39.554068 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jun 5 00:01:39.714514 sshd[1469]: Accepted publickey for core from 10.0.0.1 port 49480 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:01:39.928063 sshd[1469]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:01:39.977524 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 5 00:01:39.989275 systemd[1]: Reached target getty.target - Login Prompts. Jun 5 00:01:40.480077 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jun 5 00:01:40.681790 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jun 5 00:01:40.721643 containerd[1408]: time="2026-06-05T00:01:40.720988130Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jun 5 00:01:40.738587 systemd-logind[1379]: New session 1 of user core. Jun 5 00:01:41.291733 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jun 5 00:01:41.324815 containerd[1408]: time="2026-06-05T00:01:41.324585056Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.380591 containerd[1408]: time="2026-06-05T00:01:41.380254904Z" 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.142-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jun 5 00:01:41.380591 containerd[1408]: time="2026-06-05T00:01:41.380496818Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jun 5 00:01:41.380591 containerd[1408]: time="2026-06-05T00:01:41.380621294Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jun 5 00:01:41.386709 containerd[1408]: time="2026-06-05T00:01:41.386561225Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jun 5 00:01:41.386988 containerd[1408]: time="2026-06-05T00:01:41.386827842Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.387258 containerd[1408]: time="2026-06-05T00:01:41.387192612Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jun 5 00:01:41.387294 containerd[1408]: time="2026-06-05T00:01:41.387256485Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.387729 containerd[1408]: time="2026-06-05T00:01:41.387659970Z" 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 Jun 5 00:01:41.387729 containerd[1408]: time="2026-06-05T00:01:41.387718832Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.387822 containerd[1408]: time="2026-06-05T00:01:41.387736956Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jun 5 00:01:41.387822 containerd[1408]: time="2026-06-05T00:01:41.387751775Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.388105 containerd[1408]: time="2026-06-05T00:01:41.388051022Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.388566 containerd[1408]: time="2026-06-05T00:01:41.388504199Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jun 5 00:01:41.389006 containerd[1408]: time="2026-06-05T00:01:41.388795876Z" 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 Jun 5 00:01:41.389006 containerd[1408]: time="2026-06-05T00:01:41.388970209Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jun 5 00:01:41.389187 containerd[1408]: time="2026-06-05T00:01:41.389133141Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jun 5 00:01:41.389486 containerd[1408]: time="2026-06-05T00:01:41.389317624Z" level=info msg="metadata content store policy set" policy=shared Jun 5 00:01:41.404225 systemd[1]: Starting user@500.service - User Manager for UID 500... Jun 5 00:01:41.405185 containerd[1408]: time="2026-06-05T00:01:41.405053527Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jun 5 00:01:41.405620 containerd[1408]: time="2026-06-05T00:01:41.405360569Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jun 5 00:01:41.405620 containerd[1408]: time="2026-06-05T00:01:41.405427753Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jun 5 00:01:41.405620 containerd[1408]: time="2026-06-05T00:01:41.405449145Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jun 5 00:01:41.405620 containerd[1408]: time="2026-06-05T00:01:41.405521821Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jun 5 00:01:41.409384 containerd[1408]: time="2026-06-05T00:01:41.409172990Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jun 5 00:01:41.410087 containerd[1408]: time="2026-06-05T00:01:41.409725704Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jun 5 00:01:41.410140 containerd[1408]: time="2026-06-05T00:01:41.410093556Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jun 5 00:01:41.410268 containerd[1408]: time="2026-06-05T00:01:41.410213165Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jun 5 00:01:41.410295 containerd[1408]: time="2026-06-05T00:01:41.410266574Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jun 5 00:01:41.410295 containerd[1408]: time="2026-06-05T00:01:41.410289289Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410345 containerd[1408]: time="2026-06-05T00:01:41.410307413Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410345 containerd[1408]: time="2026-06-05T00:01:41.410327063Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410391 containerd[1408]: time="2026-06-05T00:01:41.410346076Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410391 containerd[1408]: time="2026-06-05T00:01:41.410365211Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410434 containerd[1408]: time="2026-06-05T00:01:41.410419593Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410459 containerd[1408]: time="2026-06-05T00:01:41.410437453Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.410459 containerd[1408]: time="2026-06-05T00:01:41.410452247Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410541322Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410591092Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410609439Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410625085Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410639490Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410657982Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410701295Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410723267Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410739469Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410756596Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410770601Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410784458Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410800512Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410818351Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jun 5 00:01:41.411033 containerd[1408]: time="2026-06-05T00:01:41.410917850Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.410971095Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.410987464Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411134463Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411158903Z" 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 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411171947Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411189461Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411202685Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411218844Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411230641Z" level=info msg="NRI interface is disabled by configuration." Jun 5 00:01:41.411511 containerd[1408]: time="2026-06-05T00:01:41.411244114Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jun 5 00:01:41.413316 containerd[1408]: time="2026-06-05T00:01:41.412806511Z" 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}" Jun 5 00:01:41.413316 containerd[1408]: time="2026-06-05T00:01:41.413108669Z" level=info msg="Connect containerd service" Jun 5 00:01:41.413316 containerd[1408]: time="2026-06-05T00:01:41.413175012Z" level=info msg="using legacy CRI server" Jun 5 00:01:41.413316 containerd[1408]: time="2026-06-05T00:01:41.413223451Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 5 00:01:41.472478 containerd[1408]: time="2026-06-05T00:01:41.450528829Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jun 5 00:01:41.508557 (systemd)[1492]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 5 00:01:41.517300 containerd[1408]: time="2026-06-05T00:01:41.511598773Z" 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" Jun 5 00:01:41.517760 containerd[1408]: time="2026-06-05T00:01:41.512616851Z" level=info msg="Start subscribing containerd event" Jun 5 00:01:41.523635 containerd[1408]: time="2026-06-05T00:01:41.517381680Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 5 00:01:41.523635 containerd[1408]: time="2026-06-05T00:01:41.518155692Z" level=info msg="Start recovering state" Jun 5 00:01:41.529736 containerd[1408]: time="2026-06-05T00:01:41.529135041Z" level=info msg="Start event monitor" Jun 5 00:01:41.529736 containerd[1408]: time="2026-06-05T00:01:41.529259003Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 5 00:01:41.529736 containerd[1408]: time="2026-06-05T00:01:41.529591389Z" level=info msg="Start snapshots syncer" Jun 5 00:01:41.529736 containerd[1408]: time="2026-06-05T00:01:41.529684255Z" level=info msg="Start cni network conf syncer for default" Jun 5 00:01:41.529736 containerd[1408]: time="2026-06-05T00:01:41.529694065Z" level=info msg="Start streaming server" Jun 5 00:01:41.534701 containerd[1408]: time="2026-06-05T00:01:41.534391018Z" level=info msg="containerd successfully booted in 0.845224s" Jun 5 00:01:41.540605 systemd[1]: Started containerd.service - containerd container runtime. Jun 5 00:01:41.594770 systemd[1]: Starting docker.service - Docker Application Container Engine... Jun 5 00:01:41.596101 (dockerd)[1494]: 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 Jun 5 00:02:04.899035 systemd[1492]: Queued start job for default target default.target. Jun 5 00:02:05.208784 systemd[1492]: Created slice app.slice - User Application Slice. Jun 5 00:02:05.210191 systemd[1492]: Reached target paths.target - Paths. Jun 5 00:02:05.210209 systemd[1492]: Reached target timers.target - Timers. Jun 5 00:02:05.960767 systemd[1492]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 5 00:02:07.269052 systemd[1492]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 5 00:02:07.269579 systemd[1492]: Reached target sockets.target - Sockets. Jun 5 00:02:07.269598 systemd[1492]: Reached target basic.target - Basic System. Jun 5 00:02:07.283257 systemd[1492]: Reached target default.target - Main User Target. Jun 5 00:02:07.285678 systemd[1492]: Startup finished in 25.710s. Jun 5 00:02:07.299800 systemd[1]: Started user@500.service - User Manager for UID 500. Jun 5 00:02:07.896828 systemd[1]: Started session-1.scope - Session 1 of User core. Jun 5 00:02:11.795455 systemd[1]: Started sshd@1-10.0.0.22:22-10.0.0.1:50334.service - OpenSSH per-connection server daemon (10.0.0.1:50334). Jun 5 00:02:13.884124 sshd[1515]: Accepted publickey for core from 10.0.0.1 port 50334 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:02:14.048543 sshd[1515]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:02:15.711780 systemd-logind[1379]: New session 2 of user core. Jun 5 00:02:16.785311 systemd[1]: Started session-2.scope - Session 2 of User core. Jun 5 00:02:17.251913 dockerd[1494]: time="2026-06-05T00:02:17.250711972Z" level=info msg="Starting up" Jun 5 00:02:18.308004 sshd[1515]: pam_unix(sshd:session): session closed for user core Jun 5 00:02:19.773628 update_engine[1384]: I20260605 00:02:19.713419 1384 update_attempter.cc:509] Updating boot flags... Jun 5 00:02:19.970630 systemd[1]: sshd@1-10.0.0.22:22-10.0.0.1:50334.service: Deactivated successfully. Jun 5 00:02:20.252518 systemd[1]: session-2.scope: Deactivated successfully. Jun 5 00:02:20.671355 systemd-logind[1379]: Session 2 logged out. Waiting for processes to exit. Jun 5 00:02:21.144763 systemd[1]: Started sshd@2-10.0.0.22:22-10.0.0.1:59206.service - OpenSSH per-connection server daemon (10.0.0.1:59206). Jun 5 00:02:22.189353 systemd-logind[1379]: Removed session 2. Jun 5 00:02:23.335427 sshd[1541]: Accepted publickey for core from 10.0.0.1 port 59206 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:02:23.448587 sshd[1541]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:02:24.380611 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 29 scanned by (udev-worker) (1545) Jun 5 00:02:27.380773 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 29 scanned by (udev-worker) (1544) Jun 5 00:02:30.154481 systemd-logind[1379]: New session 3 of user core. Jun 5 00:02:36.410048 dockerd[1494]: time="2026-06-05T00:02:36.361900338Z" level=info msg="Loading containers: start." Jun 5 00:02:42.866423 systemd[1]: Started session-3.scope - Session 3 of User core. Jun 5 00:02:48.789445 kernel: Initializing XFRM netlink socket Jun 5 00:02:51.515755 sshd[1541]: pam_unix(sshd:session): session closed for user core Jun 5 00:02:52.315478 systemd[1]: sshd@2-10.0.0.22:22-10.0.0.1:59206.service: Deactivated successfully. Jun 5 00:02:53.529594 systemd[1]: session-3.scope: Deactivated successfully. Jun 5 00:02:54.363295 systemd-logind[1379]: Session 3 logged out. Waiting for processes to exit. Jun 5 00:02:55.574653 systemd-logind[1379]: Removed session 3. Jun 5 00:03:03.821258 systemd-networkd[1324]: docker0: Link UP Jun 5 00:03:04.008766 systemd[1]: Started sshd@3-10.0.0.22:22-10.0.0.1:40320.service - OpenSSH per-connection server daemon (10.0.0.1:40320). Jun 5 00:03:05.999358 dockerd[1494]: time="2026-06-05T00:03:05.994386920Z" level=info msg="Loading containers: done." Jun 5 00:03:06.875793 sshd[1638]: Accepted publickey for core from 10.0.0.1 port 40320 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:03:07.089034 sshd[1638]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:03:11.196795 dockerd[1494]: time="2026-06-05T00:03:11.190163076Z" 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 Jun 5 00:03:11.299183 dockerd[1494]: time="2026-06-05T00:03:11.281547259Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Jun 5 00:03:11.417190 dockerd[1494]: time="2026-06-05T00:03:11.406769995Z" level=info msg="Daemon has completed initialization" Jun 5 00:03:12.145802 systemd-logind[1379]: New session 4 of user core. Jun 5 00:03:13.636791 systemd[1]: Started session-4.scope - Session 4 of User core. Jun 5 00:03:15.397334 sshd[1638]: pam_unix(sshd:session): session closed for user core Jun 5 00:03:18.631269 systemd[1]: sshd@3-10.0.0.22:22-10.0.0.1:40320.service: Deactivated successfully. Jun 5 00:03:18.652979 systemd[1]: sshd@3-10.0.0.22:22-10.0.0.1:40320.service: Consumed 1.336s CPU time. Jun 5 00:03:19.410331 systemd[1]: session-4.scope: Deactivated successfully. Jun 5 00:03:20.204637 systemd-logind[1379]: Session 4 logged out. Waiting for processes to exit. Jun 5 00:03:20.559883 systemd[1]: Started sshd@4-10.0.0.22:22-10.0.0.1:58144.service - OpenSSH per-connection server daemon (10.0.0.1:58144). Jun 5 00:03:21.377654 systemd-logind[1379]: Removed session 4. Jun 5 00:03:21.769805 dockerd[1494]: time="2026-06-05T00:03:21.756030277Z" level=info msg="API listen on /run/docker.sock" Jun 5 00:03:21.767322 systemd[1]: Started docker.service - Docker Application Container Engine. Jun 5 00:03:22.592818 sshd[1676]: Accepted publickey for core from 10.0.0.1 port 58144 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:03:22.717814 etcd-wrapper[1446]: Error response from daemon: No such container: etcd-member Jun 5 00:03:22.905817 sshd[1676]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:03:26.786690 etcd-wrapper[1678]: Error response from daemon: No such container: etcd-member Jun 5 00:03:26.800910 systemd-logind[1379]: New session 5 of user core. Jun 5 00:03:27.162288 systemd[1]: Started session-5.scope - Session 5 of User core. Jun 5 00:03:30.196470 sshd[1676]: pam_unix(sshd:session): session closed for user core Jun 5 00:03:30.472759 etcd-wrapper[1695]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Jun 5 00:03:30.661368 systemd[1]: sshd@4-10.0.0.22:22-10.0.0.1:58144.service: Deactivated successfully. Jun 5 00:03:30.663713 systemd[1]: sshd@4-10.0.0.22:22-10.0.0.1:58144.service: Consumed 1.072s CPU time. Jun 5 00:03:31.096786 systemd[1]: session-5.scope: Deactivated successfully. Jun 5 00:03:31.772804 systemd-logind[1379]: Session 5 logged out. Waiting for processes to exit. Jun 5 00:03:32.262066 systemd-logind[1379]: Removed session 5. Jun 5 00:03:42.636323 systemd[1]: Started sshd@5-10.0.0.22:22-10.0.0.1:43020.service - OpenSSH per-connection server daemon (10.0.0.1:43020). Jun 5 00:03:44.311337 dockerd[1494]: time="2026-06-05T00:03:44.293748523Z" level=warning msg="Error getting v2 registry: Get \"https://quay.io/v2/\": net/http: TLS handshake timeout" spanID=4d7f9e10fb4928a6 traceID=b8dd143ee535b38ca3c4ae05c776c3ed Jun 5 00:03:44.311337 dockerd[1494]: time="2026-06-05T00:03:44.316232788Z" level=info msg="Attempting next endpoint for pull after error: Get \"https://quay.io/v2/\": net/http: TLS handshake timeout" spanID=4d7f9e10fb4928a6 traceID=b8dd143ee535b38ca3c4ae05c776c3ed Jun 5 00:03:45.116597 sshd[1709]: Accepted publickey for core from 10.0.0.1 port 43020 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:03:45.248699 sshd[1709]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:03:45.431119 dockerd[1494]: time="2026-06-05T00:03:45.407516507Z" level=error msg="Handler for POST /v1.45/images/create returned error: Get \"https://quay.io/v2/\": net/http: TLS handshake timeout" spanID=4d7f9e10fb4928a6 traceID=b8dd143ee535b38ca3c4ae05c776c3ed Jun 5 00:03:45.481003 etcd-wrapper[1695]: docker: Error response from daemon: Get "https://quay.io/v2/": net/http: TLS handshake timeout. Jun 5 00:03:45.481003 etcd-wrapper[1695]: See 'docker run --help'. Jun 5 00:03:45.683713 systemd[1]: etcd-member.service: Main process exited, code=exited, status=125/n/a Jun 5 00:03:47.169332 systemd-logind[1379]: New session 6 of user core. Jun 5 00:03:47.294564 systemd[1]: Started session-6.scope - Session 6 of User core. Jun 5 00:03:47.452453 docker[1712]: Error response from daemon: No such container: etcd-member Jun 5 00:03:47.463980 systemd[1]: etcd-member.service: Control process exited, code=exited, status=1/FAILURE Jun 5 00:03:47.464139 systemd[1]: etcd-member.service: Failed with result 'exit-code'. Jun 5 00:03:47.490465 systemd[1]: Failed to start etcd-member.service - etcd (System Application Container). Jun 5 00:03:47.518248 systemd[1]: etcd-member.service: Consumed 6.659s CPU time. Jun 5 00:03:47.569768 systemd[1]: Reached target multi-user.target - Multi-User System. Jun 5 00:03:47.654205 systemd[1]: Startup finished in 8.890s (kernel) + 49.141s (initrd) + 4min 47.914s (userspace) = 5min 45.946s. Jun 5 00:03:51.046501 sshd[1709]: pam_unix(sshd:session): session closed for user core Jun 5 00:03:52.445602 systemd[1]: sshd@5-10.0.0.22:22-10.0.0.1:43020.service: Deactivated successfully. Jun 5 00:03:52.497456 systemd[1]: sshd@5-10.0.0.22:22-10.0.0.1:43020.service: Consumed 1.098s CPU time. Jun 5 00:03:53.511504 systemd[1]: session-6.scope: Deactivated successfully. Jun 5 00:03:53.602393 systemd[1]: session-6.scope: Consumed 1.057s CPU time. Jun 5 00:03:53.996558 systemd-logind[1379]: Session 6 logged out. Waiting for processes to exit. Jun 5 00:03:54.606349 systemd[1]: Started sshd@6-10.0.0.22:22-10.0.0.1:36104.service - OpenSSH per-connection server daemon (10.0.0.1:36104). Jun 5 00:03:55.094832 systemd-logind[1379]: Removed session 6. Jun 5 00:03:59.309970 systemd[1]: etcd-member.service: Scheduled restart job, restart counter is at 1. Jun 5 00:04:00.807474 sshd[1728]: Accepted publickey for core from 10.0.0.1 port 36104 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:04:00.810785 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 5 00:04:01.007797 sshd[1728]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:04:04.464715 systemd-logind[1379]: New session 7 of user core. Jun 5 00:04:05.810290 systemd[1]: Started session-7.scope - Session 7 of User core. Jun 5 00:04:06.081574 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 5 00:04:06.103713 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 5 00:04:07.884399 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jun 5 00:04:08.356696 (-wrapper)[1737]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jun 5 00:04:08.808784 sshd[1728]: pam_unix(sshd:session): session closed for user core Jun 5 00:04:11.481678 systemd[1]: sshd@6-10.0.0.22:22-10.0.0.1:36104.service: Deactivated successfully. Jun 5 00:04:11.590243 systemd[1]: sshd@6-10.0.0.22:22-10.0.0.1:36104.service: Consumed 1.573s CPU time. Jun 5 00:04:12.609183 systemd[1]: session-7.scope: Deactivated successfully. Jun 5 00:04:13.013682 systemd-logind[1379]: Session 7 logged out. Waiting for processes to exit. Jun 5 00:04:13.797025 etcd-wrapper[1743]: Error response from daemon: No such container: etcd-member Jun 5 00:04:13.815895 systemd[1]: Started sshd@7-10.0.0.22:22-10.0.0.1:56236.service - OpenSSH per-connection server daemon (10.0.0.1:56236). Jun 5 00:04:14.298756 systemd-logind[1379]: Removed session 7. Jun 5 00:04:17.015789 etcd-wrapper[1754]: Error response from daemon: No such container: etcd-member Jun 5 00:04:17.557121 sshd[1753]: Accepted publickey for core from 10.0.0.1 port 56236 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:04:17.595766 sshd[1753]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:04:22.239112 systemd-logind[1379]: New session 8 of user core. Jun 5 00:04:22.318569 systemd[1]: Started session-8.scope - Session 8 of User core. Jun 5 00:04:23.925336 etcd-wrapper[1772]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Jun 5 00:04:27.297464 sshd[1753]: pam_unix(sshd:session): session closed for user core Jun 5 00:04:30.654540 systemd[1]: sshd@7-10.0.0.22:22-10.0.0.1:56236.service: Deactivated successfully. Jun 5 00:04:30.726695 systemd[1]: sshd@7-10.0.0.22:22-10.0.0.1:56236.service: Consumed 1.326s CPU time. Jun 5 00:04:32.101469 systemd[1]: session-8.scope: Deactivated successfully. Jun 5 00:04:32.119354 systemd[1]: session-8.scope: Consumed 1.553s CPU time. Jun 5 00:04:32.589405 systemd-logind[1379]: Session 8 logged out. Waiting for processes to exit. Jun 5 00:04:33.352198 systemd[1]: Started sshd@8-10.0.0.22:22-10.0.0.1:33698.service - OpenSSH per-connection server daemon (10.0.0.1:33698). Jun 5 00:04:33.799666 systemd-logind[1379]: Removed session 8. Jun 5 00:04:37.365388 sshd[1787]: Accepted publickey for core from 10.0.0.1 port 33698 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:04:37.725081 sshd[1787]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:04:38.109002 etcd-wrapper[1772]: v3.5.24: Pulling from coreos/etcd Jun 5 00:04:43.021434 systemd-logind[1379]: New session 9 of user core. Jun 5 00:04:43.603302 etcd-wrapper[1772]: 804c8aba2cc6: Pulling fs layer Jun 5 00:04:43.791910 etcd-wrapper[1772]: 2ae710cd8bfe: Pulling fs layer Jun 5 00:04:43.784787 systemd[1]: Started session-9.scope - Session 9 of User core. Jun 5 00:04:43.920022 etcd-wrapper[1772]: d462aa345367: Pulling fs layer Jun 5 00:04:43.920022 etcd-wrapper[1772]: 0f8b424aa0b9: Pulling fs layer Jun 5 00:04:44.093885 etcd-wrapper[1772]: d557676654e5: Pulling fs layer Jun 5 00:04:44.164880 etcd-wrapper[1772]: c8022d07192e: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: d858cbc252ad: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: 1069fc2daed1: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: b40161cd83fc: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: 5318d93a3a65: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: 307c1adadb60: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: 49a553fa7ab9: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: 9cde5f0af3dd: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: b9581a18c15b: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: 0f8b424aa0b9: Waiting Jun 5 00:04:44.257208 etcd-wrapper[1772]: 95c11f3cd524: Pulling fs layer Jun 5 00:04:44.257208 etcd-wrapper[1772]: d557676654e5: Waiting Jun 5 00:04:44.384709 etcd-wrapper[1772]: c8022d07192e: Waiting Jun 5 00:04:44.469260 etcd-wrapper[1772]: 9cde5f0af3dd: Waiting Jun 5 00:04:44.807700 etcd-wrapper[1772]: b9581a18c15b: Waiting Jun 5 00:04:45.111476 etcd-wrapper[1772]: d858cbc252ad: Waiting Jun 5 00:04:45.204359 etcd-wrapper[1772]: ed40c9b2e219: Pulling fs layer Jun 5 00:04:45.313486 etcd-wrapper[1772]: 1069fc2daed1: Waiting Jun 5 00:04:45.409490 etcd-wrapper[1772]: b40161cd83fc: Waiting Jun 5 00:04:45.501825 etcd-wrapper[1772]: 95c11f3cd524: Waiting Jun 5 00:04:45.501825 etcd-wrapper[1772]: 5318d93a3a65: Waiting Jun 5 00:04:45.501825 etcd-wrapper[1772]: ed40c9b2e219: Waiting Jun 5 00:04:45.501825 etcd-wrapper[1772]: 49a553fa7ab9: Waiting Jun 5 00:04:45.501825 etcd-wrapper[1772]: 307c1adadb60: Waiting Jun 5 00:04:46.322375 sudo[1795]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jun 5 00:04:46.419807 sudo[1795]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 5 00:04:46.680644 etcd-wrapper[1772]: 804c8aba2cc6: Verifying Checksum Jun 5 00:04:46.811232 etcd-wrapper[1772]: 2ae710cd8bfe: Verifying Checksum Jun 5 00:04:46.840817 etcd-wrapper[1772]: 2ae710cd8bfe: Download complete Jun 5 00:04:46.840817 etcd-wrapper[1772]: 804c8aba2cc6: Download complete Jun 5 00:04:47.075496 sudo[1795]: pam_unix(sudo:session): session closed for user root Jun 5 00:04:47.289748 sshd[1787]: pam_unix(sshd:session): session closed for user core Jun 5 00:04:47.322471 etcd-wrapper[1772]: d462aa345367: Verifying Checksum Jun 5 00:04:47.391768 etcd-wrapper[1772]: d462aa345367: Download complete Jun 5 00:04:48.899248 systemd[1]: sshd@8-10.0.0.22:22-10.0.0.1:33698.service: Deactivated successfully. Jun 5 00:04:48.985741 systemd[1]: sshd@8-10.0.0.22:22-10.0.0.1:33698.service: Consumed 1.484s CPU time. Jun 5 00:04:49.092378 etcd-wrapper[1772]: 0f8b424aa0b9: Verifying Checksum Jun 5 00:04:49.170750 etcd-wrapper[1772]: 0f8b424aa0b9: Download complete Jun 5 00:04:49.599661 systemd[1]: session-9.scope: Deactivated successfully. Jun 5 00:04:49.687618 systemd[1]: session-9.scope: Consumed 1.236s CPU time. Jun 5 00:04:49.850586 etcd-wrapper[1772]: d557676654e5: Verifying Checksum Jun 5 00:04:49.850586 etcd-wrapper[1772]: d557676654e5: Download complete Jun 5 00:04:49.855520 systemd-logind[1379]: Session 9 logged out. Waiting for processes to exit. Jun 5 00:04:50.167301 systemd[1]: Started sshd@9-10.0.0.22:22-10.0.0.1:51190.service - OpenSSH per-connection server daemon (10.0.0.1:51190). Jun 5 00:04:50.319605 etcd-wrapper[1772]: c8022d07192e: Download complete Jun 5 00:04:50.895713 systemd-logind[1379]: Removed session 9. Jun 5 00:04:51.346610 etcd-wrapper[1772]: 1069fc2daed1: Download complete Jun 5 00:04:51.484388 etcd-wrapper[1772]: d858cbc252ad: Verifying Checksum Jun 5 00:04:51.484388 etcd-wrapper[1772]: d858cbc252ad: Download complete Jun 5 00:04:52.469533 etcd-wrapper[1772]: b40161cd83fc: Verifying Checksum Jun 5 00:04:52.569626 etcd-wrapper[1772]: b40161cd83fc: Download complete Jun 5 00:04:52.703086 etcd-wrapper[1772]: 5318d93a3a65: Verifying Checksum Jun 5 00:04:52.786259 etcd-wrapper[1772]: 5318d93a3a65: Download complete Jun 5 00:04:52.819137 sshd[1805]: Accepted publickey for core from 10.0.0.1 port 51190 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:04:52.977544 etcd-wrapper[1772]: 307c1adadb60: Download complete Jun 5 00:04:53.078051 sshd[1805]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:04:56.282275 systemd-logind[1379]: New session 10 of user core. Jun 5 00:04:56.895626 systemd[1]: Started session-10.scope - Session 10 of User core. Jun 5 00:04:59.689136 sudo[1810]: 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 Jun 5 00:04:59.722086 sudo[1810]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 5 00:05:00.939908 sudo[1810]: pam_unix(sudo:session): session closed for user root Jun 5 00:05:02.239119 sudo[1809]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Jun 5 00:05:02.239570 sudo[1809]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 5 00:05:02.804643 etcd-wrapper[1772]: b9581a18c15b: Download complete Jun 5 00:05:03.682551 etcd-wrapper[1772]: 804c8aba2cc6: Pull complete Jun 5 00:05:04.585340 etcd-wrapper[1772]: 9cde5f0af3dd: Verifying Checksum Jun 5 00:05:04.905768 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Jun 5 00:05:05.203577 etcd-wrapper[1772]: 9cde5f0af3dd: Download complete Jun 5 00:05:05.442115 auditctl[1817]: No rules Jun 5 00:05:05.508832 systemd[1]: audit-rules.service: Deactivated successfully. Jun 5 00:05:05.573165 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Jun 5 00:05:05.764805 etcd-wrapper[1772]: 95c11f3cd524: Verifying Checksum Jun 5 00:05:05.801135 etcd-wrapper[1772]: 95c11f3cd524: Download complete Jun 5 00:05:07.341325 etcd-wrapper[1772]: ed40c9b2e219: Download complete Jun 5 00:05:07.341620 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jun 5 00:05:08.298674 etcd-wrapper[1772]: 49a553fa7ab9: Download complete Jun 5 00:05:08.389589 systemd[1]: var-lib-docker-overlay2-5c9dd5ab80b2d3c17642afa120f7ec8c4b8efacdef71b53ff2ca7e9abc697008-merged.mount: Deactivated successfully. Jun 5 00:05:08.790683 etcd-wrapper[1772]: 2ae710cd8bfe: Pull complete Jun 5 00:05:10.052899 augenrules[1840]: No rules Jun 5 00:05:12.103189 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jun 5 00:05:12.415693 sudo[1809]: pam_unix(sudo:session): session closed for user root Jun 5 00:05:12.550358 sshd[1805]: pam_unix(sshd:session): session closed for user core Jun 5 00:05:15.573915 systemd[1]: sshd@9-10.0.0.22:22-10.0.0.1:51190.service: Deactivated successfully. Jun 5 00:05:15.597695 systemd[1]: sshd@9-10.0.0.22:22-10.0.0.1:51190.service: Consumed 1.251s CPU time. Jun 5 00:05:17.896424 systemd[1]: session-10.scope: Deactivated successfully. Jun 5 00:05:17.975485 systemd[1]: session-10.scope: Consumed 2.734s CPU time. Jun 5 00:05:19.089692 systemd-logind[1379]: Session 10 logged out. Waiting for processes to exit. Jun 5 00:05:19.857283 systemd[1]: Started sshd@10-10.0.0.22:22-10.0.0.1:57014.service - OpenSSH per-connection server daemon (10.0.0.1:57014). Jun 5 00:05:20.388617 systemd-logind[1379]: Removed session 10. Jun 5 00:05:24.488385 sshd[1848]: Accepted publickey for core from 10.0.0.1 port 57014 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:05:24.978482 sshd[1848]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:05:28.219988 systemd-logind[1379]: New session 11 of user core. Jun 5 00:05:28.973647 systemd[1]: Started session-11.scope - Session 11 of User core. Jun 5 00:05:30.267656 sshd[1848]: pam_unix(sshd:session): session closed for user core Jun 5 00:05:31.679431 systemd[1]: sshd@10-10.0.0.22:22-10.0.0.1:57014.service: Deactivated successfully. Jun 5 00:05:31.686029 systemd[1]: sshd@10-10.0.0.22:22-10.0.0.1:57014.service: Consumed 2.402s CPU time. Jun 5 00:05:31.741214 systemd[1]: session-11.scope: Deactivated successfully. Jun 5 00:05:31.791977 systemd-logind[1379]: Session 11 logged out. Waiting for processes to exit. Jun 5 00:05:31.850402 systemd[1]: Started sshd@11-10.0.0.22:22-10.0.0.1:56800.service - OpenSSH per-connection server daemon (10.0.0.1:56800). Jun 5 00:05:32.042467 systemd-logind[1379]: Removed session 11. Jun 5 00:05:35.928131 sshd[1855]: Accepted publickey for core from 10.0.0.1 port 56800 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:05:36.586748 sshd[1855]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:05:37.855816 systemd-logind[1379]: New session 12 of user core. Jun 5 00:05:38.162922 systemd[1]: Started session-12.scope - Session 12 of User core. Jun 5 00:05:49.213621 sshd[1855]: pam_unix(sshd:session): session closed for user core Jun 5 00:05:51.151299 systemd[1]: sshd@11-10.0.0.22:22-10.0.0.1:56800.service: Deactivated successfully. Jun 5 00:05:51.256868 systemd[1]: sshd@11-10.0.0.22:22-10.0.0.1:56800.service: Consumed 2.429s CPU time. Jun 5 00:05:51.804250 systemd[1]: session-12.scope: Deactivated successfully. Jun 5 00:05:51.884447 systemd[1]: session-12.scope: Consumed 3.816s CPU time. Jun 5 00:05:52.234620 systemd-logind[1379]: Session 12 logged out. Waiting for processes to exit. Jun 5 00:05:53.008230 systemd-logind[1379]: Removed session 12. Jun 5 00:06:00.775031 systemd[1]: Started sshd@12-10.0.0.22:22-10.0.0.1:53140.service - OpenSSH per-connection server daemon (10.0.0.1:53140). Jun 5 00:06:03.800281 update_engine[1384]: I20260605 00:06:03.796546 1384 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Jun 5 00:06:03.800281 update_engine[1384]: I20260605 00:06:03.798522 1384 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Jun 5 00:06:03.804082 update_engine[1384]: I20260605 00:06:03.804015 1384 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Jun 5 00:06:03.816600 update_engine[1384]: I20260605 00:06:03.810526 1384 omaha_request_params.cc:62] Current group set to lts Jun 5 00:06:03.877146 update_engine[1384]: I20260605 00:06:03.874836 1384 update_attempter.cc:499] Already updated boot flags. Skipping. Jun 5 00:06:03.900414 update_engine[1384]: I20260605 00:06:03.883383 1384 update_attempter.cc:643] Scheduling an action processor start. Jun 5 00:06:03.900414 update_engine[1384]: I20260605 00:06:03.888769 1384 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jun 5 00:06:03.900414 update_engine[1384]: I20260605 00:06:03.889271 1384 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Jun 5 00:06:03.900414 update_engine[1384]: I20260605 00:06:03.889433 1384 omaha_request_action.cc:271] Posting an Omaha request to disabled Jun 5 00:06:03.900414 update_engine[1384]: I20260605 00:06:03.889442 1384 omaha_request_action.cc:272] Request: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: Jun 5 00:06:03.900414 update_engine[1384]: I20260605 00:06:03.889470 1384 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jun 5 00:06:03.909768 locksmithd[1457]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Jun 5 00:06:04.202890 update_engine[1384]: I20260605 00:06:04.202262 1384 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jun 5 00:06:04.720945 update_engine[1384]: I20260605 00:06:04.709590 1384 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jun 5 00:06:04.887759 update_engine[1384]: E20260605 00:06:04.883175 1384 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jun 5 00:06:04.955742 update_engine[1384]: I20260605 00:06:04.946727 1384 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Jun 5 00:06:06.779748 sshd[1870]: Accepted publickey for core from 10.0.0.1 port 53140 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:06:07.675687 sshd[1870]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:06:10.177521 systemd-logind[1379]: New session 13 of user core. Jun 5 00:06:10.647630 systemd[1]: Started session-13.scope - Session 13 of User core. Jun 5 00:06:14.715560 update_engine[1384]: I20260605 00:06:14.710182 1384 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jun 5 00:06:14.734380 update_engine[1384]: I20260605 00:06:14.729224 1384 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jun 5 00:06:14.737359 update_engine[1384]: I20260605 00:06:14.737177 1384 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jun 5 00:06:14.869190 update_engine[1384]: E20260605 00:06:14.835727 1384 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jun 5 00:06:14.901428 update_engine[1384]: I20260605 00:06:14.887609 1384 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 Jun 5 00:06:19.999603 sshd[1870]: pam_unix(sshd:session): session closed for user core Jun 5 00:06:20.803738 systemd[1]: sshd@12-10.0.0.22:22-10.0.0.1:53140.service: Deactivated successfully. Jun 5 00:06:20.822476 systemd[1]: sshd@12-10.0.0.22:22-10.0.0.1:53140.service: Consumed 3.205s CPU time. Jun 5 00:06:21.236329 systemd[1]: session-13.scope: Deactivated successfully. Jun 5 00:06:21.286833 systemd[1]: session-13.scope: Consumed 2.735s CPU time. Jun 5 00:06:21.750808 systemd-logind[1379]: Session 13 logged out. Waiting for processes to exit. Jun 5 00:06:22.057445 systemd-logind[1379]: Removed session 13. Jun 5 00:06:24.795328 update_engine[1384]: I20260605 00:06:24.768158 1384 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jun 5 00:06:24.899823 update_engine[1384]: I20260605 00:06:24.814409 1384 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jun 5 00:06:24.939660 update_engine[1384]: I20260605 00:06:24.928691 1384 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jun 5 00:06:24.948260 update_engine[1384]: E20260605 00:06:24.947119 1384 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jun 5 00:06:24.948260 update_engine[1384]: I20260605 00:06:24.948364 1384 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 Jun 5 00:06:30.577749 systemd[1]: Started sshd@13-10.0.0.22:22-10.0.0.1:42856.service - OpenSSH per-connection server daemon (10.0.0.1:42856). Jun 5 00:06:34.774726 update_engine[1384]: I20260605 00:06:34.722585 1384 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jun 5 00:06:34.824976 update_engine[1384]: I20260605 00:06:34.818670 1384 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jun 5 00:06:34.853441 update_engine[1384]: I20260605 00:06:34.852365 1384 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jun 5 00:06:34.916234 update_engine[1384]: E20260605 00:06:34.910369 1384 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jun 5 00:06:34.970094 update_engine[1384]: I20260605 00:06:34.919588 1384 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Jun 5 00:06:34.970094 update_engine[1384]: I20260605 00:06:34.949662 1384 omaha_request_action.cc:617] Omaha request response: Jun 5 00:06:34.986701 update_engine[1384]: E20260605 00:06:34.975453 1384 omaha_request_action.cc:636] Omaha request network transfer failed. Jun 5 00:06:34.989286 update_engine[1384]: I20260605 00:06:34.988878 1384 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Jun 5 00:06:34.989405 update_engine[1384]: I20260605 00:06:34.989307 1384 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jun 5 00:06:34.989405 update_engine[1384]: I20260605 00:06:34.989326 1384 update_attempter.cc:306] Processing Done. Jun 5 00:06:34.993903 update_engine[1384]: E20260605 00:06:34.989540 1384 update_attempter.cc:619] Update failed. Jun 5 00:06:34.993903 update_engine[1384]: I20260605 00:06:34.989615 1384 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Jun 5 00:06:34.993903 update_engine[1384]: I20260605 00:06:34.989624 1384 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Jun 5 00:06:34.993903 update_engine[1384]: I20260605 00:06:34.989632 1384 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Jun 5 00:06:35.127265 update_engine[1384]: I20260605 00:06:35.007067 1384 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jun 5 00:06:35.127265 update_engine[1384]: I20260605 00:06:35.016760 1384 omaha_request_action.cc:271] Posting an Omaha request to disabled Jun 5 00:06:35.127265 update_engine[1384]: I20260605 00:06:35.022544 1384 omaha_request_action.cc:272] Request: Jun 5 00:06:35.127265 update_engine[1384]: Jun 5 00:06:35.127265 update_engine[1384]: Jun 5 00:06:35.127265 update_engine[1384]: Jun 5 00:06:35.127265 update_engine[1384]: Jun 5 00:06:35.127265 update_engine[1384]: Jun 5 00:06:35.127265 update_engine[1384]: Jun 5 00:06:35.127265 update_engine[1384]: I20260605 00:06:35.097563 1384 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Jun 5 00:06:35.128284 locksmithd[1457]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.130445 1384 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.161592 1384 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Jun 5 00:06:35.257235 update_engine[1384]: E20260605 00:06:35.194319 1384 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.206780 1384 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.219655 1384 omaha_request_action.cc:617] Omaha request response: Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.219807 1384 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.219815 1384 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.219821 1384 update_attempter.cc:306] Processing Done. Jun 5 00:06:35.257235 update_engine[1384]: I20260605 00:06:35.222638 1384 update_attempter.cc:310] Error event sent. Jun 5 00:06:35.485074 update_engine[1384]: I20260605 00:06:35.255776 1384 update_check_scheduler.cc:74] Next update check in 42m27s Jun 5 00:06:35.505075 locksmithd[1457]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0 Jun 5 00:06:35.910548 sshd[1883]: Accepted publickey for core from 10.0.0.1 port 42856 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:06:36.184580 sshd[1883]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:06:37.807232 systemd-logind[1379]: New session 14 of user core. Jun 5 00:06:38.008595 systemd[1]: Started session-14.scope - Session 14 of User core. Jun 5 00:06:47.116398 sshd[1883]: pam_unix(sshd:session): session closed for user core Jun 5 00:06:48.907479 systemd[1]: sshd@13-10.0.0.22:22-10.0.0.1:42856.service: Deactivated successfully. Jun 5 00:06:48.933750 systemd[1]: sshd@13-10.0.0.22:22-10.0.0.1:42856.service: Consumed 2.282s CPU time. Jun 5 00:06:49.670657 systemd[1]: session-14.scope: Deactivated successfully. Jun 5 00:06:49.679874 systemd[1]: session-14.scope: Consumed 2.710s CPU time. Jun 5 00:06:49.920189 systemd-logind[1379]: Session 14 logged out. Waiting for processes to exit. Jun 5 00:06:50.807143 systemd-logind[1379]: Removed session 14. Jun 5 00:06:59.913534 systemd[1]: Started sshd@14-10.0.0.22:22-10.0.0.1:48002.service - OpenSSH per-connection server daemon (10.0.0.1:48002). Jun 5 00:07:10.115554 sshd[1897]: Accepted publickey for core from 10.0.0.1 port 48002 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:07:10.380561 sshd[1897]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:07:13.051618 systemd-logind[1379]: New session 15 of user core. Jun 5 00:07:13.419650 systemd[1]: Started session-15.scope - Session 15 of User core. Jun 5 00:07:28.911529 sshd[1897]: pam_unix(sshd:session): session closed for user core Jun 5 00:07:30.182101 systemd[1]: sshd@14-10.0.0.22:22-10.0.0.1:48002.service: Deactivated successfully. Jun 5 00:07:30.190777 systemd[1]: sshd@14-10.0.0.22:22-10.0.0.1:48002.service: Consumed 4.466s CPU time. Jun 5 00:07:30.795360 systemd[1]: session-15.scope: Deactivated successfully. Jun 5 00:07:30.956520 systemd[1]: session-15.scope: Consumed 6.681s CPU time. Jun 5 00:07:31.482038 systemd-logind[1379]: Session 15 logged out. Waiting for processes to exit. Jun 5 00:07:32.410273 systemd-logind[1379]: Removed session 15. Jun 5 00:07:42.783460 systemd[1]: Started sshd@15-10.0.0.22:22-10.0.0.1:39638.service - OpenSSH per-connection server daemon (10.0.0.1:39638). Jun 5 00:07:51.103649 sshd[1911]: Accepted publickey for core from 10.0.0.1 port 39638 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:07:51.257289 sshd[1911]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:07:54.546671 systemd-logind[1379]: New session 16 of user core. Jun 5 00:07:54.846792 systemd[1]: Started session-16.scope - Session 16 of User core. Jun 5 00:08:06.226744 sshd[1911]: pam_unix(sshd:session): session closed for user core Jun 5 00:08:07.578792 systemd[1]: sshd@15-10.0.0.22:22-10.0.0.1:39638.service: Deactivated successfully. Jun 5 00:08:07.618774 systemd[1]: sshd@15-10.0.0.22:22-10.0.0.1:39638.service: Consumed 4.090s CPU time. Jun 5 00:08:08.194890 systemd[1]: session-16.scope: Deactivated successfully. Jun 5 00:08:08.206658 systemd[1]: session-16.scope: Consumed 3.761s CPU time. Jun 5 00:08:08.824646 systemd-logind[1379]: Session 16 logged out. Waiting for processes to exit. Jun 5 00:08:09.605626 systemd-logind[1379]: Removed session 16. Jun 5 00:08:18.262185 systemd[1]: Started sshd@16-10.0.0.22:22-10.0.0.1:44546.service - OpenSSH per-connection server daemon (10.0.0.1:44546). Jun 5 00:08:25.715226 sshd[1926]: Accepted publickey for core from 10.0.0.1 port 44546 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:08:26.191414 sshd[1926]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:08:27.821186 systemd-logind[1379]: New session 17 of user core. Jun 5 00:08:27.859077 systemd[1]: Started session-17.scope - Session 17 of User core. Jun 5 00:08:33.306684 systemd[1]: var-lib-docker-overlay2-9acb980d1f51d9fdfd1b954f87aac0b91dc6da84ef35f68b30ce95c928afe160-merged.mount: Deactivated successfully. Jun 5 00:08:33.454228 etcd-wrapper[1772]: d462aa345367: Pull complete Jun 5 00:08:33.596818 systemd[1]: var-lib-docker-overlay2-fcaa8e9866bdfd14ea36cde1229279591f8a797cabfc3db129064debebb09202-merged.mount: Deactivated successfully. Jun 5 00:08:33.620271 etcd-wrapper[1772]: 0f8b424aa0b9: Pull complete Jun 5 00:08:33.707019 systemd[1]: var-lib-docker-overlay2-b9bc21f4d4324ec572769f68b78006b44fca54375dd0c032a494c2e2a0f4b691-merged.mount: Deactivated successfully. Jun 5 00:08:33.767577 etcd-wrapper[1772]: d557676654e5: Pull complete Jun 5 00:08:33.901146 sshd[1926]: pam_unix(sshd:session): session closed for user core Jun 5 00:08:33.911288 systemd[1]: sshd@16-10.0.0.22:22-10.0.0.1:44546.service: Deactivated successfully. Jun 5 00:08:33.911600 systemd[1]: sshd@16-10.0.0.22:22-10.0.0.1:44546.service: Consumed 3.808s CPU time. Jun 5 00:08:33.918641 etcd-wrapper[1772]: c8022d07192e: Pull complete Jun 5 00:08:33.918513 systemd[1]: session-17.scope: Deactivated successfully. Jun 5 00:08:33.921556 systemd-logind[1379]: Session 17 logged out. Waiting for processes to exit. Jun 5 00:08:33.937313 systemd-logind[1379]: Removed session 17. Jun 5 00:08:34.006391 etcd-wrapper[1772]: d858cbc252ad: Pull complete Jun 5 00:08:34.192685 etcd-wrapper[1772]: 1069fc2daed1: Pull complete Jun 5 00:08:34.325405 systemd[1]: var-lib-docker-overlay2-7fa068e1aacfe47df1f63ae514f04e273a96d46497b9347e82feba28162a7d36-merged.mount: Deactivated successfully. Jun 5 00:08:34.409379 etcd-wrapper[1772]: b40161cd83fc: Pull complete Jun 5 00:08:34.595805 systemd[1]: var-lib-docker-overlay2-f968f249a8c7c1abe7eabd5ae4b170a4e59193657fdfe1eff719bd5d0a4e8511-merged.mount: Deactivated successfully. Jun 5 00:08:34.633317 etcd-wrapper[1772]: 5318d93a3a65: Pull complete Jun 5 00:08:34.835544 etcd-wrapper[1772]: 307c1adadb60: Pull complete Jun 5 00:08:35.822606 systemd[1]: var-lib-docker-overlay2-df7866c9659e2cf66aef0b8eec6938d4889755a9aefa4d9f3569124d683999c8-merged.mount: Deactivated successfully. Jun 5 00:08:35.993752 etcd-wrapper[1772]: 49a553fa7ab9: Pull complete Jun 5 00:08:36.800005 systemd[1]: var-lib-docker-overlay2-b33aa7476a60ca9e31aad162c5cd18c44b81adcd27cb4fef2bee98309b24e8d4-merged.mount: Deactivated successfully. Jun 5 00:08:36.905328 etcd-wrapper[1772]: 9cde5f0af3dd: Pull complete Jun 5 00:08:37.932516 systemd[1]: var-lib-docker-overlay2-032a1ecbceabdfadfed649153b9e53aece9508cc74b01c7c9eb0cead44474afb-merged.mount: Deactivated successfully. Jun 5 00:08:37.981400 etcd-wrapper[1772]: b9581a18c15b: Pull complete Jun 5 00:08:38.167932 systemd[1]: var-lib-docker-overlay2-61216e1b30f8bfee812ae6177502f5a2e4193e4feb33b563a61943fbcdad060d-merged.mount: Deactivated successfully. Jun 5 00:08:38.224940 etcd-wrapper[1772]: 95c11f3cd524: Pull complete Jun 5 00:08:38.303315 systemd[1]: var-lib-docker-overlay2-7c78f89fa8f808ec087b0f35a49f435faf8f1e9d11f451c22de081836c476bc1-merged.mount: Deactivated successfully. Jun 5 00:08:38.311535 etcd-wrapper[1772]: ed40c9b2e219: Pull complete Jun 5 00:08:38.448145 etcd-wrapper[1772]: Digest: sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594 Jun 5 00:08:38.469588 etcd-wrapper[1772]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.24 Jun 5 00:08:39.301174 containerd[1408]: time="2026-06-05T00:08:39.297207017Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jun 5 00:08:39.301174 containerd[1408]: time="2026-06-05T00:08:39.298260286Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jun 5 00:08:39.301174 containerd[1408]: time="2026-06-05T00:08:39.298329947Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 5 00:08:39.301174 containerd[1408]: time="2026-06-05T00:08:39.300812164Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 5 00:08:39.375696 systemd[1]: Started docker-f73986ea46b8f07b07207428840abd841ca3b3d91ee3472f6707af9259b1e66a.scope - libcontainer container f73986ea46b8f07b07207428840abd841ca3b3d91ee3472f6707af9259b1e66a. Jun 5 00:08:39.634817 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.024612Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.035278Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"55cd5626129e4ef6bb605896bc27adce"} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.035461Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.035473Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.24"} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.035479Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.035484Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.035655Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.035828Z","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.22:2379"]} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.036580Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jun 5 00:08:40.040328 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.036604Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Jun 5 00:08:40.083987 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.058626Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jun 5 00:08:40.083987 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.062351Z","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":"55cd5626129e4ef6bb605896bc27adce","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.22:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"55cd5626129e4ef6bb605896bc27adce=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"} Jun 5 00:08:40.104132 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.084072Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"17.111947ms"} Jun 5 00:08:40.200573 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.176176Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Jun 5 00:08:40.200573 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.183233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Jun 5 00:08:40.200573 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.185367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Jun 5 00:08:40.200573 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.185535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jun 5 00:08:40.200573 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.185552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Jun 5 00:08:40.200573 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.187823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jun 5 00:08:40.222825 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:08:40.214664Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Jun 5 00:08:40.225728 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.224999Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Jun 5 00:08:40.225728 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.225232Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Jun 5 00:08:40.227131 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.226612Z","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"} Jun 5 00:08:40.228233 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.227727Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.24","cluster-version":"to_be_decided"} Jun 5 00:08:40.228684 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.228166Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jun 5 00:08:40.230791 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.229560Z","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.22:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jun 5 00:08:40.231058 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.229751Z","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"} Jun 5 00:08:40.231058 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.230030Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Jun 5 00:08:40.231058 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.230056Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Jun 5 00:08:40.231058 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.230108Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Jun 5 00:08:40.231058 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.230257Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Jun 5 00:08:40.231058 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.230273Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Jun 5 00:08:40.242469 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.231593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jun 5 00:08:40.242469 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.231752Z","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} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.904416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.906733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.910624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.911064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.911078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.911086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Jun 5 00:08:40.915690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.911093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Jun 5 00:08:40.921307 systemd[1]: Started etcd-member.service - etcd (System Application Container). Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.914629Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:55cd5626129e4ef6bb605896bc27adce ClientURLs:[http://10.0.0.22:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.914663Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.915220Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.917971Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.920046Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.920058Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.920299Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.920503Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.921221Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jun 5 00:08:40.925280 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:08:40.922313Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Jun 5 00:08:43.977045 systemd[1]: Started sshd@17-10.0.0.22:22-10.0.0.1:40186.service - OpenSSH per-connection server daemon (10.0.0.1:40186). Jun 5 00:08:44.209032 sshd[2056]: Accepted publickey for core from 10.0.0.1 port 40186 ssh2: RSA SHA256:cAUQhHm3DmOY38ofIl8/0rZzI35NIaZ5jTlETs83Rk4 Jun 5 00:08:44.210559 sshd[2056]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 5 00:08:44.387075 systemd-logind[1379]: New session 18 of user core. Jun 5 00:08:44.421776 systemd[1]: Started session-18.scope - Session 18 of User core. Jun 5 00:08:44.878524 sshd[2056]: pam_unix(sshd:session): session closed for user core Jun 5 00:08:44.907780 systemd[1]: sshd@17-10.0.0.22:22-10.0.0.1:40186.service: Deactivated successfully. Jun 5 00:08:44.921163 systemd[1]: session-18.scope: Deactivated successfully. Jun 5 00:08:44.935603 systemd-logind[1379]: Session 18 logged out. Waiting for processes to exit. Jun 5 00:08:44.938435 systemd-logind[1379]: Removed session 18. Jun 5 00:08:47.618393 kernel: clocksource: timekeeping watchdog on CPU2: kvm-clock wd-wd read-back delay of 206903ns Jun 5 00:08:47.636794 kernel: clocksource: wd-tsc-wd read-back delay of 7432984ns, clock-skew test skipped! Jun 5 00:11:43.754718 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.722802Z","caller":"traceutil/trace.go:171","msg":"trace[109559266] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"103.39942ms","start":"2026-06-05T00:11:43.616155Z","end":"2026-06-05T00:11:43.719555Z","steps":["trace[109559266] 'process raft request' (duration: 86.460984ms)","trace[109559266] 'compare' (duration: 14.603055ms)"],"step_count":2} Jun 5 00:11:43.754718 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.722791Z","caller":"traceutil/trace.go:171","msg":"trace[1153562682] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"101.033342ms","start":"2026-06-05T00:11:43.620662Z","end":"2026-06-05T00:11:43.721695Z","steps":["trace[1153562682] 'process raft request' (duration: 98.553336ms)"],"step_count":1} Jun 5 00:11:43.754718 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.739810Z","caller":"traceutil/trace.go:171","msg":"trace[802979162] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"122.658093ms","start":"2026-06-05T00:11:43.617027Z","end":"2026-06-05T00:11:43.739685Z","steps":["trace[802979162] 'process raft request' (duration: 101.680645ms)"],"step_count":1} Jun 5 00:11:43.754718 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.739736Z","caller":"traceutil/trace.go:171","msg":"trace[109538516] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"117.884769ms","start":"2026-06-05T00:11:43.620285Z","end":"2026-06-05T00:11:43.738170Z","steps":["trace[109538516] 'process raft request' (duration: 98.813793ms)"],"step_count":1} Jun 5 00:11:43.788661 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.749299Z","caller":"traceutil/trace.go:171","msg":"trace[1845002913] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"122.504401ms","start":"2026-06-05T00:11:43.626727Z","end":"2026-06-05T00:11:43.749232Z","steps":["trace[1845002913] 'process raft request' (duration: 92.704393ms)"],"step_count":1} Jun 5 00:11:43.788661 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.749754Z","caller":"traceutil/trace.go:171","msg":"trace[339996082] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"121.371677ms","start":"2026-06-05T00:11:43.628373Z","end":"2026-06-05T00:11:43.749745Z","steps":["trace[339996082] 'process raft request' (duration: 91.124665ms)"],"step_count":1} Jun 5 00:11:43.788661 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:11:43.751715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.166861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" limit:1 ","response":"range_response_count:0 size:4"} Jun 5 00:11:43.788661 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.753504Z","caller":"traceutil/trace.go:171","msg":"trace[1129323002] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:36; }","duration":"125.019199ms","start":"2026-06-05T00:11:43.628379Z","end":"2026-06-05T00:11:43.753398Z","steps":["trace[1129323002] 'agreement among raft nodes before linearized reading' (duration: 121.409491ms)"],"step_count":1} Jun 5 00:11:43.788661 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.753505Z","caller":"traceutil/trace.go:171","msg":"trace[1754719351] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"108.449783ms","start":"2026-06-05T00:11:43.626775Z","end":"2026-06-05T00:11:43.735225Z","steps":["trace[1754719351] 'process raft request' (duration: 92.640711ms)"],"step_count":1} Jun 5 00:11:43.838130 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:11:43.761803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.01424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" limit:1 ","response":"range_response_count:0 size:4"} Jun 5 00:11:43.838130 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:43.764725Z","caller":"traceutil/trace.go:171","msg":"trace[885854569] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:37; }","duration":"135.788855ms","start":"2026-06-05T00:11:43.628769Z","end":"2026-06-05T00:11:43.764558Z","steps":["trace[885854569] 'agreement among raft nodes before linearized reading' (duration: 132.914272ms)"],"step_count":1} Jun 5 00:11:44.326713 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:44.315148Z","caller":"traceutil/trace.go:171","msg":"trace[1398114231] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"101.552568ms","start":"2026-06-05T00:11:44.211624Z","end":"2026-06-05T00:11:44.313177Z","steps":["trace[1398114231] 'process raft request' (duration: 81.598788ms)","trace[1398114231] 'store kv pair into bolt db' {req_type:put; key:/registry/flowschemas/system-node-high; req_size:693; } (duration: 15.989994ms)"],"step_count":2} Jun 5 00:11:47.066232 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:11:47.004107Z","caller":"traceutil/trace.go:171","msg":"trace[565716147] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"104.412274ms","start":"2026-06-05T00:11:46.899544Z","end":"2026-06-05T00:11:47.003956Z","steps":["trace[565716147] 'process raft request' (duration: 62.073748ms)","trace[565716147] 'compare' (duration: 36.155623ms)"],"step_count":2} Jun 5 00:12:20.236546 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:12:20.223249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.753466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Jun 5 00:12:20.236546 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:12:20.225734Z","caller":"traceutil/trace.go:171","msg":"trace[164526397] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"140.29427ms","start":"2026-06-05T00:12:20.085217Z","end":"2026-06-05T00:12:20.225512Z","steps":["trace[164526397] 'process raft request' (duration: 13.88205ms)","trace[164526397] 'compare' (duration: 104.624626ms)"],"step_count":2} Jun 5 00:13:13.256448 systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories... Jun 5 00:13:13.579497 systemd-tmpfiles[2076]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 5 00:13:13.586768 systemd-tmpfiles[2076]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 5 00:13:13.594345 systemd-tmpfiles[2076]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 5 00:13:13.595115 systemd-tmpfiles[2076]: ACLs are not supported, ignoring. Jun 5 00:13:13.595154 systemd-tmpfiles[2076]: ACLs are not supported, ignoring. Jun 5 00:13:13.613499 systemd-tmpfiles[2076]: Detected autofs mount point /boot during canonicalization of boot. Jun 5 00:13:13.613701 systemd-tmpfiles[2076]: Skipping /boot Jun 5 00:13:13.660483 systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. Jun 5 00:13:13.663723 systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories. Jun 5 00:13:49.424933 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:13:49.400430Z","caller":"traceutil/trace.go:171","msg":"trace[2042317333] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"104.278663ms","start":"2026-06-05T00:13:49.293955Z","end":"2026-06-05T00:13:49.398233Z","steps":["trace[2042317333] 'process raft request' (duration: 37.816848ms)","trace[2042317333] 'compare' (duration: 61.711198ms)"],"step_count":2} Jun 5 00:15:05.851087 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:15:05.792425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.114616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} Jun 5 00:15:05.851087 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:05.812580Z","caller":"traceutil/trace.go:171","msg":"trace[1611619433] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:826; }","duration":"136.454448ms","start":"2026-06-05T00:15:05.669798Z","end":"2026-06-05T00:15:05.806252Z","steps":["trace[1611619433] 'agreement among raft nodes before linearized reading' (duration: 42.711146ms)","trace[1611619433] 'range keys from in-memory index tree' (duration: 27.21565ms)","trace[1611619433] 'filter and sort the key-value pairs' (duration: 40.926808ms)"],"step_count":3} Jun 5 00:15:17.788468 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:17.772503Z","caller":"traceutil/trace.go:171","msg":"trace[761731372] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"106.974475ms","start":"2026-06-05T00:15:17.665281Z","end":"2026-06-05T00:15:17.772256Z","steps":["trace[761731372] 'process raft request' (duration: 10.51013ms)","trace[761731372] 'compare' (duration: 92.418394ms)"],"step_count":2} Jun 5 00:15:17.788468 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:17.772493Z","caller":"traceutil/trace.go:171","msg":"trace[1411107030] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:917; }","duration":"105.725782ms","start":"2026-06-05T00:15:17.666506Z","end":"2026-06-05T00:15:17.772232Z","steps":["trace[1411107030] 'read index received' (duration: 9.316404ms)","trace[1411107030] 'applied index is now lower than readState.Index' (duration: 96.378972ms)"],"step_count":2} Jun 5 00:15:17.788468 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:15:17.775522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.351634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas\" limit:1 ","response":"range_response_count:0 size:5"} Jun 5 00:15:17.788468 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:17.778795Z","caller":"traceutil/trace.go:171","msg":"trace[1048008215] range","detail":"{range_begin:/registry/flowschemas; range_end:; response_count:0; response_revision:834; }","duration":"109.351017ms","start":"2026-06-05T00:15:17.666423Z","end":"2026-06-05T00:15:17.775774Z","steps":["trace[1048008215] 'agreement among raft nodes before linearized reading' (duration: 106.279411ms)"],"step_count":1} Jun 5 00:15:29.872171 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:15:29.846501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.136853ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jun 5 00:15:29.872171 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:29.855833Z","caller":"traceutil/trace.go:171","msg":"trace[506508206] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"154.117383ms","start":"2026-06-05T00:15:29.701169Z","end":"2026-06-05T00:15:29.855286Z","steps":["trace[506508206] 'process raft request' (duration: 20.36675ms)","trace[506508206] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/masterleases/10.0.0.25; req_size:108; } (duration: 77.857698ms)","trace[506508206] 'store kv pair into bolt db' {req_type:put; key:/registry/masterleases/10.0.0.25; req_size:108; } (duration: 27.827282ms)"],"step_count":3} Jun 5 00:15:36.109785 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:36.100909Z","caller":"traceutil/trace.go:171","msg":"trace[387605442] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"107.289993ms","start":"2026-06-05T00:15:35.993472Z","end":"2026-06-05T00:15:36.100762Z","steps":["trace[387605442] 'process raft request' (duration: 28.259012ms)","trace[387605442] 'compare' (duration: 74.432532ms)"],"step_count":2} Jun 5 00:15:36.109785 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:15:36.101286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.596906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" limit:1 ","response":"range_response_count:1 size:214"} Jun 5 00:15:36.109785 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:36.101320Z","caller":"traceutil/trace.go:171","msg":"trace[1100599882] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:850; }","duration":"107.737802ms","start":"2026-06-05T00:15:35.993573Z","end":"2026-06-05T00:15:36.101311Z","steps":["trace[1100599882] 'agreement among raft nodes before linearized reading' (duration: 107.34869ms)"],"step_count":1} Jun 5 00:15:36.109785 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:15:36.100782Z","caller":"traceutil/trace.go:171","msg":"trace[1557320477] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:939; }","duration":"107.11572ms","start":"2026-06-05T00:15:35.993581Z","end":"2026-06-05T00:15:36.100696Z","steps":["trace[1557320477] 'read index received' (duration: 895.588µs)","trace[1557320477] 'applied index is now lower than readState.Index' (duration: 106.216945ms)"],"step_count":2} Jun 5 00:16:18.255809 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:16:18.241091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.288874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:491"} Jun 5 00:16:18.255809 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:16:18.247769Z","caller":"traceutil/trace.go:171","msg":"trace[1401889175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:916; }","duration":"126.241387ms","start":"2026-06-05T00:16:18.121305Z","end":"2026-06-05T00:16:18.247547Z","steps":["trace[1401889175] 'range keys from in-memory index tree' (duration: 92.569242ms)","trace[1401889175] 'range keys from bolt db' (duration: 18.228193ms)"],"step_count":2} Jun 5 00:16:43.568739 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:16:43.465676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.806777ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:16:55.906170 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:16:55.811132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.50379ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:17:05.628734 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:17:05.503528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.380154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 revision:933 ","response":"range_response_count:8 size:59837"} Jun 5 00:17:05.628734 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:17:05.513385Z","caller":"traceutil/trace.go:171","msg":"trace[1452992828] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:8; response_revision:941; }","duration":"117.4432ms","start":"2026-06-05T00:17:05.393103Z","end":"2026-06-05T00:17:05.510547Z","steps":["trace[1452992828] 'agreement among raft nodes before linearized reading' (duration: 16.36283ms)","trace[1452992828] 'range keys from bolt db' (duration: 88.373067ms)"],"step_count":2} Jun 5 00:17:47.557515 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:17:47.513758Z","caller":"traceutil/trace.go:171","msg":"trace[1496073713] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"134.266522ms","start":"2026-06-05T00:17:47.378521Z","end":"2026-06-05T00:17:47.512787Z","steps":["trace[1496073713] 'process raft request' (duration: 123.269826ms)"],"step_count":1} Jun 5 00:17:56.172487 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:17:56.135555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.564637ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:17:56.702979 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:17:56.621228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.448292ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:18:01.918384 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:01.910937Z","caller":"traceutil/trace.go:171","msg":"trace[187200271] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"113.286137ms","start":"2026-06-05T00:18:01.794286Z","end":"2026-06-05T00:18:01.907572Z","steps":["trace[187200271] 'process raft request' (duration: 32.05226ms)","trace[187200271] 'compare' (duration: 70.311961ms)"],"step_count":2} Jun 5 00:18:03.506690 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:03.424062Z","caller":"traceutil/trace.go:171","msg":"trace[1521859145] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"109.006369ms","start":"2026-06-05T00:18:03.307228Z","end":"2026-06-05T00:18:03.416234Z","steps":["trace[1521859145] 'process raft request' (duration: 95.402679ms)"],"step_count":1} Jun 5 00:18:12.297706 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:12.211569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.259003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jun 5 00:18:12.537671 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:12.229255Z","caller":"traceutil/trace.go:171","msg":"trace[764081800] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"143.679611ms","start":"2026-06-05T00:18:12.085040Z","end":"2026-06-05T00:18:12.228719Z","steps":["trace[764081800] 'process raft request' (duration: 23.396058ms)","trace[764081800] 'compare' (duration: 24.123525ms)","trace[764081800] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/masterleases/10.0.0.25; req_size:108; } (duration: 46.115543ms)","trace[764081800] 'store kv pair into bolt db' {req_type:put; key:/registry/masterleases/10.0.0.25; req_size:108; } (duration: 24.103533ms)"],"step_count":4} Jun 5 00:18:17.199132 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:17.169208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.550823ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:18:22.519265 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:22.477810Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.471268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Jun 5 00:18:22.519265 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:22.495345Z","caller":"traceutil/trace.go:171","msg":"trace[115676856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:990; }","duration":"151.723689ms","start":"2026-06-05T00:18:22.339571Z","end":"2026-06-05T00:18:22.491295Z","steps":["trace[115676856] 'agreement among raft nodes before linearized reading' (duration: 92.01362ms)","trace[115676856] 'range keys from in-memory index tree' (duration: 41.123011ms)"],"step_count":2} Jun 5 00:18:26.602666 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:26.518131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.025901ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:18:26.602666 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:26.536310Z","caller":"traceutil/trace.go:171","msg":"trace[1262157368] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1142; }","duration":"258.481645ms","start":"2026-06-05T00:18:26.277548Z","end":"2026-06-05T00:18:26.536030Z","steps":["trace[1262157368] 'read index received' (duration: 29.877997ms)","trace[1262157368] 'applied index is now lower than readState.Index' (duration: 228.522728ms)"],"step_count":2} Jun 5 00:18:26.602666 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:26.560529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.956938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" limit:10000 revision:973 ","response":"range_response_count:2 size:8283"} Jun 5 00:18:27.005520 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:26.576590Z","caller":"traceutil/trace.go:171","msg":"trace[845759941] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:2; response_revision:993; }","duration":"298.576488ms","start":"2026-06-05T00:18:26.277440Z","end":"2026-06-05T00:18:26.576016Z","steps":["trace[845759941] 'agreement among raft nodes before linearized reading' (duration: 264.185637ms)"],"step_count":1} Jun 5 00:18:27.005520 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:26.596784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T00:18:26.275456Z","time spent":"314.763852ms","remote":"10.0.0.25:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":2,"response size":8307,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" limit:10000 revision:973 "} Jun 5 00:18:33.621448 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:33.557736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.285255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:417"} Jun 5 00:18:33.621448 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:33.573688Z","caller":"traceutil/trace.go:171","msg":"trace[579156448] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:997; }","duration":"156.703065ms","start":"2026-06-05T00:18:33.415704Z","end":"2026-06-05T00:18:33.572407Z","steps":["trace[579156448] 'range keys from bolt db' (duration: 103.249024ms)"],"step_count":1} Jun 5 00:18:42.937482 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:18:42.873673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.167377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints\" limit:1 ","response":"range_response_count:0 size:5"} Jun 5 00:18:42.937482 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:42.887500Z","caller":"traceutil/trace.go:171","msg":"trace[1625802275] range","detail":"{range_begin:/registry/services/endpoints; range_end:; response_count:0; response_revision:1005; }","duration":"163.226299ms","start":"2026-06-05T00:18:42.721553Z","end":"2026-06-05T00:18:42.884780Z","steps":["trace[1625802275] 'range keys from in-memory index tree' (duration: 143.648234ms)"],"step_count":1} Jun 5 00:18:55.265661 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:55.244313Z","caller":"traceutil/trace.go:171","msg":"trace[1460554407] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"130.75908ms","start":"2026-06-05T00:18:55.109764Z","end":"2026-06-05T00:18:55.240523Z","steps":["trace[1460554407] 'process raft request' (duration: 97.886405ms)"],"step_count":1} Jun 5 00:18:58.805414 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:18:58.791399Z","caller":"traceutil/trace.go:171","msg":"trace[818037666] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"157.066404ms","start":"2026-06-05T00:18:58.634179Z","end":"2026-06-05T00:18:58.791245Z","steps":["trace[818037666] 'process raft request' (duration: 112.095728ms)","trace[818037666] 'compare' (duration: 43.340487ms)"],"step_count":2} Jun 5 00:19:00.634759 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:19:00.515460Z","caller":"traceutil/trace.go:171","msg":"trace[1361515987] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"101.999793ms","start":"2026-06-05T00:19:00.410703Z","end":"2026-06-05T00:19:00.512703Z","steps":["trace[1361515987] 'process raft request' (duration: 20.783061ms)","trace[1361515987] 'compare' (duration: 44.109272ms)","trace[1361515987] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/events/kube-system/kube-apiserver-localhost.18b606f4edcbc50a; req_size:799; } (duration: 10.385499ms)","trace[1361515987] 'store kv pair into bolt db' {req_type:put; key:/registry/events/kube-system/kube-apiserver-localhost.18b606f4edcbc50a; req_size:799; } (duration: 11.294154ms)"],"step_count":4} Jun 5 00:19:22.512383 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:19:22.499679Z","caller":"traceutil/trace.go:171","msg":"trace[1201466047] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"129.86302ms","start":"2026-06-05T00:19:22.369730Z","end":"2026-06-05T00:19:22.499593Z","steps":["trace[1201466047] 'process raft request' (duration: 65.269108ms)","trace[1201466047] 'compare' (duration: 60.245585ms)"],"step_count":2} Jun 5 00:20:23.910546 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:20:23.889632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.752986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jun 5 00:20:23.910546 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:20:23.898790Z","caller":"traceutil/trace.go:171","msg":"trace[2095250252] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"216.897272ms","start":"2026-06-05T00:20:23.681575Z","end":"2026-06-05T00:20:23.898473Z","steps":["trace[2095250252] 'process raft request' (duration: 39.871916ms)","trace[2095250252] 'compare' (duration: 165.739384ms)"],"step_count":2} Jun 5 00:20:33.760832 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:20:33.745750Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.822713ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jun 5 00:20:33.760832 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:20:33.746529Z","caller":"traceutil/trace.go:171","msg":"trace[629129267] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"130.964896ms","start":"2026-06-05T00:20:33.615488Z","end":"2026-06-05T00:20:33.746452Z","steps":["trace[629129267] 'process raft request' (duration: 20.995228ms)","trace[629129267] 'compare' (duration: 66.218326ms)","trace[629129267] 'store kv pair into bolt db' {req_type:put; key:/registry/masterleases/10.0.0.25; req_size:108; } (duration: 28.531178ms)"],"step_count":3} Jun 5 00:20:38.301735 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:20:38.249381Z","caller":"traceutil/trace.go:171","msg":"trace[1471359441] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"115.413025ms","start":"2026-06-05T00:20:38.132418Z","end":"2026-06-05T00:20:38.247831Z","steps":["trace[1471359441] 'process raft request' (duration: 94.098763ms)"],"step_count":1} Jun 5 00:20:49.374654 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:20:49.235163Z","caller":"traceutil/trace.go:171","msg":"trace[476633513] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"111.303543ms","start":"2026-06-05T00:20:49.116012Z","end":"2026-06-05T00:20:49.227315Z","steps":["trace[476633513] 'process raft request' (duration: 76.650629ms)","trace[476633513] 'compare' (duration: 16.444381ms)","trace[476633513] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:462; } (duration: 14.844764ms)"],"step_count":3} Jun 5 00:20:58.479733 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:20:58.413748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.994398ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:21:05.404409 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:21:05.321506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.631438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jun 5 00:21:05.404409 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:21:05.372246Z","caller":"traceutil/trace.go:171","msg":"trace[1335957147] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"262.485504ms","start":"2026-06-05T00:21:05.108057Z","end":"2026-06-05T00:21:05.370542Z","steps":["trace[1335957147] 'process raft request' (duration: 98.196853ms)","trace[1335957147] 'compare' (duration: 90.912002ms)"],"step_count":2} Jun 5 00:21:33.472422 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:21:33.424764Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":934} Jun 5 00:21:33.522170 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:21:33.515309Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":934,"took":"82.628164ms","hash":2789442267,"current-db-size-bytes":4349952,"current-db-size":"4.3 MB","current-db-size-in-use-bytes":4349952,"current-db-size-in-use":"4.3 MB"} Jun 5 00:21:33.522170 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:21:33.518691Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":2789442267,"revision":934,"compact-revision":-1} Jun 5 00:21:37.472215 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:21:37.436385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.435037ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:21:40.024770 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:21:40.002418Z","caller":"traceutil/trace.go:171","msg":"trace[174508667] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"111.019402ms","start":"2026-06-05T00:21:39.891150Z","end":"2026-06-05T00:21:40.002170Z","steps":["trace[174508667] 'process raft request' (duration: 25.647941ms)","trace[174508667] 'compare' (duration: 76.878804ms)"],"step_count":2} Jun 5 00:21:46.143635 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:21:46.113055Z","caller":"traceutil/trace.go:171","msg":"trace[623015329] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"226.166696ms","start":"2026-06-05T00:21:45.885639Z","end":"2026-06-05T00:21:46.111806Z","steps":["trace[623015329] 'process raft request' (duration: 138.558361ms)","trace[623015329] 'compare' (duration: 11.914054ms)","trace[623015329] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-node-lease/localhost; req_size:522; } (duration: 71.096396ms)"],"step_count":3} Jun 5 00:22:05.559194 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:22:05.515179Z","caller":"traceutil/trace.go:171","msg":"trace[1038836672] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"107.573155ms","start":"2026-06-05T00:22:05.407091Z","end":"2026-06-05T00:22:05.514664Z","steps":["trace[1038836672] 'process raft request' (duration: 20.204399ms)","trace[1038836672] 'compare' (duration: 16.41108ms)","trace[1038836672] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-node-lease/localhost; req_size:522; } (duration: 57.853765ms)"],"step_count":3} Jun 5 00:22:13.965258 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:22:13.826378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.286568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/peerserverleases/apiserver-l2yubf4cvcl5c7a3wrubrwqdve\" limit:1 ","response":"range_response_count:1 size:234"} Jun 5 00:22:13.965258 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:22:13.901283Z","caller":"traceutil/trace.go:171","msg":"trace[714394040] range","detail":"{range_begin:/registry/peerserverleases/apiserver-l2yubf4cvcl5c7a3wrubrwqdve; range_end:; response_count:1; response_revision:1178; }","duration":"187.799443ms","start":"2026-06-05T00:22:13.713281Z","end":"2026-06-05T00:22:13.901080Z","steps":["trace[714394040] 'agreement among raft nodes before linearized reading' (duration: 105.666321ms)"],"step_count":1} Jun 5 00:22:17.216820 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:22:17.101088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.707415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jun 5 00:22:17.274448 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:22:17.122152Z","caller":"traceutil/trace.go:171","msg":"trace[309264040] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"215.567062ms","start":"2026-06-05T00:22:16.898510Z","end":"2026-06-05T00:22:17.114077Z","steps":["trace[309264040] 'process raft request' (duration: 32.581335ms)","trace[309264040] 'check requests' (duration: 41.630307ms)","trace[309264040] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/peerserverleases/apiserver-l2yubf4cvcl5c7a3wrubrwqdve; req_size:216; } (duration: 20.36602ms)","trace[309264040] 'store kv pair into bolt db' {req_type:put; key:/registry/peerserverleases/apiserver-l2yubf4cvcl5c7a3wrubrwqdve; req_size:216; } (duration: 60.284713ms)"],"step_count":4} Jun 5 00:22:37.357722 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:22:37.306559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.392757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} Jun 5 00:22:37.357722 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:22:37.312940Z","caller":"traceutil/trace.go:171","msg":"trace[1487026251] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:1188; }","duration":"116.009479ms","start":"2026-06-05T00:22:37.196559Z","end":"2026-06-05T00:22:37.312569Z","steps":["trace[1487026251] 'agreement among raft nodes before linearized reading' (duration: 38.271503ms)","trace[1487026251] 'range keys from in-memory index tree' (duration: 67.063688ms)"],"step_count":2} Jun 5 00:22:53.263349 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:22:53.212579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.907855ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:23:02.027797 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:23:02.003310Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.435714ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} Jun 5 00:23:12.421269 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:23:12.399750Z","caller":"traceutil/trace.go:171","msg":"trace[1304090089] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"128.308491ms","start":"2026-06-05T00:23:12.271112Z","end":"2026-06-05T00:23:12.399421Z","steps":["trace[1304090089] 'process raft request' (duration: 45.022201ms)","trace[1304090089] 'compare' (duration: 14.494841ms)","trace[1304090089] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/leases/kube-node-lease/localhost; req_size:522; } (duration: 37.953353ms)","trace[1304090089] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-node-lease/localhost; req_size:522; } (duration: 18.904518ms)"],"step_count":4} Jun 5 00:23:13.329408 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:23:13.301282Z","caller":"traceutil/trace.go:171","msg":"trace[494984233] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1207; }","duration":"121.701153ms","start":"2026-06-05T00:23:13.061797Z","end":"2026-06-05T00:23:13.183498Z","steps":["trace[494984233] 'agreement among raft nodes before linearized reading' (duration: 50.501461ms)"],"step_count":1} Jun 5 00:23:19.954982 etcd-wrapper[1772]: {"level":"info","ts":"2026-06-05T00:23:19.834456Z","caller":"traceutil/trace.go:171","msg":"trace[1968411500] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"175.322824ms","start":"2026-06-05T00:23:19.658997Z","end":"2026-06-05T00:23:19.834320Z","steps":["trace[1968411500] 'process raft request' (duration: 124.411687ms)","trace[1968411500] 'compare' (duration: 11.409375ms)","trace[1968411500] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/peerserverleases/apiserver-l2yubf4cvcl5c7a3wrubrwqdve; req_size:216; } (duration: 21.796897ms)"],"step_count":3} Jun 5 00:24:22.932604 etcd-wrapper[1772]: {"level":"warn","ts":"2026-06-05T00:24:22.906159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.664576ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"}