Mar 3 14:05:26.871837 kernel: Linux version 6.12.74-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Tue Mar 3 10:59:45 -00 2026 Mar 3 14:05:26.871867 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=51ade538e3d3c371f07ae1ec6fa9803fff0566ec060cf4b56dc685fc36d0e01c Mar 3 14:05:26.871879 kernel: BIOS-provided physical RAM map: Mar 3 14:05:26.871885 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Mar 3 14:05:26.871891 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Mar 3 14:05:26.871897 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Mar 3 14:05:26.871961 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Mar 3 14:05:26.871975 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Mar 3 14:05:26.871985 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Mar 3 14:05:26.871995 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Mar 3 14:05:26.872006 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Mar 3 14:05:26.872023 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Mar 3 14:05:26.872032 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Mar 3 14:05:26.872043 kernel: NX (Execute Disable) protection: active Mar 3 14:05:26.872056 kernel: APIC: Static calls initialized Mar 3 14:05:26.872068 kernel: SMBIOS 2.8 present. Mar 3 14:05:26.872139 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Mar 3 14:05:26.872152 kernel: DMI: Memory slots populated: 1/1 Mar 3 14:05:26.872160 kernel: Hypervisor detected: KVM Mar 3 14:05:26.872169 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Mar 3 14:05:26.872178 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Mar 3 14:05:26.872186 kernel: kvm-clock: using sched offset of 16963820942 cycles Mar 3 14:05:26.872280 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Mar 3 14:05:26.872290 kernel: tsc: Detected 2445.426 MHz processor Mar 3 14:05:26.872299 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Mar 3 14:05:26.872311 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Mar 3 14:05:26.872325 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Mar 3 14:05:26.872334 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Mar 3 14:05:26.872343 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Mar 3 14:05:26.872353 kernel: Using GB pages for direct mapping Mar 3 14:05:26.872363 kernel: ACPI: Early table checksum verification disabled Mar 3 14:05:26.872372 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Mar 3 14:05:26.872381 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872391 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872402 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872416 kernel: ACPI: FACS 0x000000009CFE0000 000040 Mar 3 14:05:26.872563 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872573 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872582 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872591 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 3 14:05:26.872609 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Mar 3 14:05:26.872622 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Mar 3 14:05:26.872631 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Mar 3 14:05:26.872640 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Mar 3 14:05:26.872651 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Mar 3 14:05:26.872663 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Mar 3 14:05:26.872673 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Mar 3 14:05:26.872682 kernel: No NUMA configuration found Mar 3 14:05:26.872691 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Mar 3 14:05:26.872707 kernel: NODE_DATA(0) allocated [mem 0x9cfd4dc0-0x9cfdbfff] Mar 3 14:05:26.872717 kernel: Zone ranges: Mar 3 14:05:26.872727 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Mar 3 14:05:26.872736 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Mar 3 14:05:26.872745 kernel: Normal empty Mar 3 14:05:26.872757 kernel: Device empty Mar 3 14:05:26.872769 kernel: Movable zone start for each node Mar 3 14:05:26.872779 kernel: Early memory node ranges Mar 3 14:05:26.872788 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Mar 3 14:05:26.872797 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Mar 3 14:05:26.872812 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Mar 3 14:05:26.872897 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 3 14:05:26.873049 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Mar 3 14:05:26.873113 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Mar 3 14:05:26.873123 kernel: ACPI: PM-Timer IO Port: 0x608 Mar 3 14:05:26.873130 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Mar 3 14:05:26.873141 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Mar 3 14:05:26.873154 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Mar 3 14:05:26.873165 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Mar 3 14:05:26.873181 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Mar 3 14:05:26.873190 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Mar 3 14:05:26.873199 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Mar 3 14:05:26.873212 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Mar 3 14:05:26.873223 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Mar 3 14:05:26.873235 kernel: TSC deadline timer available Mar 3 14:05:26.873246 kernel: CPU topo: Max. logical packages: 1 Mar 3 14:05:26.873257 kernel: CPU topo: Max. logical dies: 1 Mar 3 14:05:26.873269 kernel: CPU topo: Max. dies per package: 1 Mar 3 14:05:26.873335 kernel: CPU topo: Max. threads per core: 1 Mar 3 14:05:26.873346 kernel: CPU topo: Num. cores per package: 4 Mar 3 14:05:26.873355 kernel: CPU topo: Num. threads per package: 4 Mar 3 14:05:26.873365 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Mar 3 14:05:26.873374 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Mar 3 14:05:26.873386 kernel: kvm-guest: KVM setup pv remote TLB flush Mar 3 14:05:26.873398 kernel: kvm-guest: setup PV sched yield Mar 3 14:05:26.873407 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Mar 3 14:05:26.873417 kernel: Booting paravirtualized kernel on KVM Mar 3 14:05:26.873433 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Mar 3 14:05:26.873445 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Mar 3 14:05:26.877279 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Mar 3 14:05:26.877291 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Mar 3 14:05:26.877301 kernel: pcpu-alloc: [0] 0 1 2 3 Mar 3 14:05:26.877313 kernel: kvm-guest: PV spinlocks enabled Mar 3 14:05:26.877323 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Mar 3 14:05:26.877334 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=51ade538e3d3c371f07ae1ec6fa9803fff0566ec060cf4b56dc685fc36d0e01c Mar 3 14:05:26.877354 kernel: random: crng init done Mar 3 14:05:26.877364 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 3 14:05:26.877374 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Mar 3 14:05:26.877386 kernel: Fallback order for Node 0: 0 Mar 3 14:05:26.877398 kernel: Built 1 zonelists, mobility grouping on. Total pages: 642938 Mar 3 14:05:26.877407 kernel: Policy zone: DMA32 Mar 3 14:05:26.877417 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 3 14:05:26.877428 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Mar 3 14:05:26.877441 kernel: ftrace: allocating 40099 entries in 157 pages Mar 3 14:05:26.877634 kernel: ftrace: allocated 157 pages with 5 groups Mar 3 14:05:26.877648 kernel: Dynamic Preempt: voluntary Mar 3 14:05:26.877661 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 3 14:05:26.877674 kernel: rcu: RCU event tracing is enabled. Mar 3 14:05:26.877684 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Mar 3 14:05:26.877694 kernel: Trampoline variant of Tasks RCU enabled. Mar 3 14:05:26.877760 kernel: Rude variant of Tasks RCU enabled. Mar 3 14:05:26.877774 kernel: Tracing variant of Tasks RCU enabled. Mar 3 14:05:26.877784 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 3 14:05:26.877793 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Mar 3 14:05:26.877809 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Mar 3 14:05:26.877822 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Mar 3 14:05:26.877834 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Mar 3 14:05:26.877846 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Mar 3 14:05:26.877857 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 3 14:05:26.877878 kernel: Console: colour VGA+ 80x25 Mar 3 14:05:26.877891 kernel: printk: legacy console [ttyS0] enabled Mar 3 14:05:26.877959 kernel: ACPI: Core revision 20240827 Mar 3 14:05:26.877972 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Mar 3 14:05:26.877983 kernel: APIC: Switch to symmetric I/O mode setup Mar 3 14:05:26.877996 kernel: x2apic enabled Mar 3 14:05:26.878015 kernel: APIC: Switched APIC routing to: physical x2apic Mar 3 14:05:26.878025 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Mar 3 14:05:26.878036 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Mar 3 14:05:26.878045 kernel: kvm-guest: setup PV IPIs Mar 3 14:05:26.878056 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Mar 3 14:05:26.878074 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x233fd7ba1b0, max_idle_ns: 440795295779 ns Mar 3 14:05:26.878087 kernel: Calibrating delay loop (skipped) preset value.. 4890.85 BogoMIPS (lpj=2445426) Mar 3 14:05:26.878097 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Mar 3 14:05:26.878107 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Mar 3 14:05:26.878117 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Mar 3 14:05:26.878128 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Mar 3 14:05:26.878140 kernel: Spectre V2 : Mitigation: Retpolines Mar 3 14:05:26.878153 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Mar 3 14:05:26.878163 kernel: Speculative Store Bypass: Vulnerable Mar 3 14:05:26.878177 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Mar 3 14:05:26.878188 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Mar 3 14:05:26.878201 kernel: active return thunk: srso_alias_return_thunk Mar 3 14:05:26.880999 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Mar 3 14:05:26.881022 kernel: Transient Scheduler Attacks: Forcing mitigation on in a VM Mar 3 14:05:26.881034 kernel: Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode Mar 3 14:05:26.881046 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Mar 3 14:05:26.881058 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Mar 3 14:05:26.881078 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Mar 3 14:05:26.881090 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Mar 3 14:05:26.881103 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Mar 3 14:05:26.881116 kernel: Freeing SMP alternatives memory: 32K Mar 3 14:05:26.881129 kernel: pid_max: default: 32768 minimum: 301 Mar 3 14:05:26.881141 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Mar 3 14:05:26.881153 kernel: landlock: Up and running. Mar 3 14:05:26.881165 kernel: SELinux: Initializing. Mar 3 14:05:26.881172 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 3 14:05:26.881184 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 3 14:05:26.881240 kernel: smpboot: CPU0: AMD EPYC 7763 64-Core Processor (family: 0x19, model: 0x1, stepping: 0x1) Mar 3 14:05:26.881254 kernel: Performance Events: PMU not available due to virtualization, using software events only. Mar 3 14:05:26.881267 kernel: signal: max sigframe size: 1776 Mar 3 14:05:26.881280 kernel: rcu: Hierarchical SRCU implementation. Mar 3 14:05:26.881294 kernel: rcu: Max phase no-delay instances is 400. Mar 3 14:05:26.881306 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Mar 3 14:05:26.881320 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Mar 3 14:05:26.881332 kernel: smp: Bringing up secondary CPUs ... Mar 3 14:05:26.881349 kernel: smpboot: x86: Booting SMP configuration: Mar 3 14:05:26.881362 kernel: .... node #0, CPUs: #1 #2 #3 Mar 3 14:05:26.881374 kernel: smp: Brought up 1 node, 4 CPUs Mar 3 14:05:26.881386 kernel: smpboot: Total of 4 processors activated (19563.40 BogoMIPS) Mar 3 14:05:26.881400 kernel: Memory: 2420720K/2571752K available (14336K kernel code, 2445K rwdata, 26064K rodata, 46200K init, 2560K bss, 145096K reserved, 0K cma-reserved) Mar 3 14:05:26.881411 kernel: devtmpfs: initialized Mar 3 14:05:26.881420 kernel: x86/mm: Memory block size: 128MB Mar 3 14:05:26.881434 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 3 14:05:26.881568 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Mar 3 14:05:26.881591 kernel: pinctrl core: initialized pinctrl subsystem Mar 3 14:05:26.881602 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 3 14:05:26.881612 kernel: audit: initializing netlink subsys (disabled) Mar 3 14:05:26.881624 kernel: audit: type=2000 audit(1772546714.839:1): state=initialized audit_enabled=0 res=1 Mar 3 14:05:26.881637 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 3 14:05:26.881649 kernel: thermal_sys: Registered thermal governor 'user_space' Mar 3 14:05:26.881662 kernel: cpuidle: using governor menu Mar 3 14:05:26.881672 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 3 14:05:26.881682 kernel: dca service started, version 1.12.1 Mar 3 14:05:26.881697 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Mar 3 14:05:26.881709 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Mar 3 14:05:26.881722 kernel: PCI: Using configuration type 1 for base access Mar 3 14:05:26.881733 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 3 14:05:26.881743 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 3 14:05:26.881753 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Mar 3 14:05:26.881762 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 3 14:05:26.881773 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Mar 3 14:05:26.881786 kernel: ACPI: Added _OSI(Module Device) Mar 3 14:05:26.881804 kernel: ACPI: Added _OSI(Processor Device) Mar 3 14:05:26.881816 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 3 14:05:26.881828 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 3 14:05:26.881841 kernel: ACPI: Interpreter enabled Mar 3 14:05:26.881853 kernel: ACPI: PM: (supports S0 S3 S5) Mar 3 14:05:26.881865 kernel: ACPI: Using IOAPIC for interrupt routing Mar 3 14:05:26.881877 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Mar 3 14:05:26.881887 kernel: PCI: Using E820 reservations for host bridge windows Mar 3 14:05:26.881898 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Mar 3 14:05:26.881976 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Mar 3 14:05:26.883125 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Mar 3 14:05:26.883335 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Mar 3 14:05:26.883655 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Mar 3 14:05:26.883675 kernel: PCI host bridge to bus 0000:00 Mar 3 14:05:26.884146 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Mar 3 14:05:26.884359 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Mar 3 14:05:26.884660 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Mar 3 14:05:26.884856 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Mar 3 14:05:26.885126 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Mar 3 14:05:26.885327 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Mar 3 14:05:26.885745 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Mar 3 14:05:26.886251 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Mar 3 14:05:26.886683 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Mar 3 14:05:26.886892 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Mar 3 14:05:26.887362 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Mar 3 14:05:26.887640 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Mar 3 14:05:26.887874 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Mar 3 14:05:26.888137 kernel: pci 0000:00:01.0: pci_fixup_video+0x0/0x100 took 16601 usecs Mar 3 14:05:26.888547 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Mar 3 14:05:26.888890 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Mar 3 14:05:26.889153 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Mar 3 14:05:26.889631 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Mar 3 14:05:26.889972 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Mar 3 14:05:26.890233 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Mar 3 14:05:26.890556 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Mar 3 14:05:26.890771 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Mar 3 14:05:26.891283 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Mar 3 14:05:26.891605 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Mar 3 14:05:26.891813 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Mar 3 14:05:26.892079 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Mar 3 14:05:26.892270 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Mar 3 14:05:26.892739 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Mar 3 14:05:26.893017 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Mar 3 14:05:26.893616 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Mar 3 14:05:26.894045 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Mar 3 14:05:26.894256 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Mar 3 14:05:26.894816 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Mar 3 14:05:26.895098 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Mar 3 14:05:26.895119 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Mar 3 14:05:26.895139 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Mar 3 14:05:26.895151 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Mar 3 14:05:26.895164 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Mar 3 14:05:26.895175 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Mar 3 14:05:26.895185 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Mar 3 14:05:26.895197 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Mar 3 14:05:26.895209 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Mar 3 14:05:26.895222 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Mar 3 14:05:26.895232 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Mar 3 14:05:26.895251 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Mar 3 14:05:26.895262 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Mar 3 14:05:26.895275 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Mar 3 14:05:26.895285 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Mar 3 14:05:26.895298 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Mar 3 14:05:26.895310 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Mar 3 14:05:26.895323 kernel: iommu: Default domain type: Translated Mar 3 14:05:26.895333 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Mar 3 14:05:26.895346 kernel: PCI: Using ACPI for IRQ routing Mar 3 14:05:26.895362 kernel: PCI: pci_cache_line_size set to 64 bytes Mar 3 14:05:26.895374 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Mar 3 14:05:26.895385 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Mar 3 14:05:26.895711 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Mar 3 14:05:26.895991 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Mar 3 14:05:26.896200 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Mar 3 14:05:26.896221 kernel: vgaarb: loaded Mar 3 14:05:26.896233 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Mar 3 14:05:26.896245 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Mar 3 14:05:26.896264 kernel: clocksource: Switched to clocksource kvm-clock Mar 3 14:05:26.896277 kernel: VFS: Disk quotas dquot_6.6.0 Mar 3 14:05:26.896287 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 3 14:05:26.896298 kernel: pnp: PnP ACPI init Mar 3 14:05:26.896822 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Mar 3 14:05:26.896845 kernel: pnp: PnP ACPI: found 6 devices Mar 3 14:05:26.896858 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Mar 3 14:05:26.896870 kernel: NET: Registered PF_INET protocol family Mar 3 14:05:26.896890 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Mar 3 14:05:26.896963 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Mar 3 14:05:26.896976 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 3 14:05:26.896987 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Mar 3 14:05:26.896997 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Mar 3 14:05:26.897007 kernel: TCP: Hash tables configured (established 32768 bind 32768) Mar 3 14:05:26.897019 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Mar 3 14:05:26.897032 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Mar 3 14:05:26.897043 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 3 14:05:26.897058 kernel: NET: Registered PF_XDP protocol family Mar 3 14:05:26.897263 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Mar 3 14:05:26.897566 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Mar 3 14:05:26.897772 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Mar 3 14:05:26.898095 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Mar 3 14:05:26.898296 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Mar 3 14:05:26.898725 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Mar 3 14:05:26.898746 kernel: PCI: CLS 0 bytes, default 64 Mar 3 14:05:26.898764 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x233fd7ba1b0, max_idle_ns: 440795295779 ns Mar 3 14:05:26.898778 kernel: Initialise system trusted keyrings Mar 3 14:05:26.898789 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Mar 3 14:05:26.898802 kernel: Key type asymmetric registered Mar 3 14:05:26.898813 kernel: Asymmetric key parser 'x509' registered Mar 3 14:05:26.898825 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Mar 3 14:05:26.898837 kernel: io scheduler mq-deadline registered Mar 3 14:05:26.898850 kernel: io scheduler kyber registered Mar 3 14:05:26.898861 kernel: io scheduler bfq registered Mar 3 14:05:26.898872 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Mar 3 14:05:26.898890 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Mar 3 14:05:26.898964 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Mar 3 14:05:26.898979 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Mar 3 14:05:26.898991 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 3 14:05:26.899004 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Mar 3 14:05:26.899014 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Mar 3 14:05:26.899025 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Mar 3 14:05:26.899038 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Mar 3 14:05:26.899550 kernel: rtc_cmos 00:04: RTC can wake from S4 Mar 3 14:05:26.899771 kernel: rtc_cmos 00:04: registered as rtc0 Mar 3 14:05:26.900038 kernel: rtc_cmos 00:04: setting system clock to 2026-03-03T14:05:25 UTC (1772546725) Mar 3 14:05:26.900056 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Mar 3 14:05:26.900251 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Mar 3 14:05:26.900272 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Mar 3 14:05:26.900286 kernel: NET: Registered PF_INET6 protocol family Mar 3 14:05:26.900297 kernel: Segment Routing with IPv6 Mar 3 14:05:26.900314 kernel: In-situ OAM (IOAM) with IPv6 Mar 3 14:05:26.900327 kernel: NET: Registered PF_PACKET protocol family Mar 3 14:05:26.900339 kernel: Key type dns_resolver registered Mar 3 14:05:26.900351 kernel: IPI shorthand broadcast: enabled Mar 3 14:05:26.900361 kernel: sched_clock: Marking stable (9307046547, 1090999439)->(11137511339, -739465353) Mar 3 14:05:26.900373 kernel: registered taskstats version 1 Mar 3 14:05:26.900385 kernel: Loading compiled-in X.509 certificates Mar 3 14:05:26.900398 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.74-flatcar: bf135b2a3d3664cc6742f4e1848867384c1e52f1' Mar 3 14:05:26.900408 kernel: Demotion targets for Node 0: null Mar 3 14:05:26.900425 kernel: Key type .fscrypt registered Mar 3 14:05:26.900436 kernel: Key type fscrypt-provisioning registered Mar 3 14:05:26.900555 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 3 14:05:26.900570 kernel: ima: Allocated hash algorithm: sha1 Mar 3 14:05:26.900580 kernel: ima: No architecture policies found Mar 3 14:05:26.900590 kernel: clk: Disabling unused clocks Mar 3 14:05:26.900602 kernel: Warning: unable to open an initial console. Mar 3 14:05:26.900615 kernel: Freeing unused kernel image (initmem) memory: 46200K Mar 3 14:05:26.900628 kernel: Write protecting the kernel read-only data: 40960k Mar 3 14:05:26.900644 kernel: Freeing unused kernel image (rodata/data gap) memory: 560K Mar 3 14:05:26.900657 kernel: Run /init as init process Mar 3 14:05:26.900669 kernel: with arguments: Mar 3 14:05:26.900681 kernel: /init Mar 3 14:05:26.900693 kernel: with environment: Mar 3 14:05:26.900704 kernel: HOME=/ Mar 3 14:05:26.900713 kernel: TERM=linux Mar 3 14:05:26.900725 systemd[1]: Successfully made /usr/ read-only. Mar 3 14:05:26.900740 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 3 14:05:26.900760 systemd[1]: Detected virtualization kvm. Mar 3 14:05:26.900771 systemd[1]: Detected architecture x86-64. Mar 3 14:05:26.900781 systemd[1]: Running in initrd. Mar 3 14:05:26.900791 systemd[1]: No hostname configured, using default hostname. Mar 3 14:05:26.900803 systemd[1]: Hostname set to . Mar 3 14:05:26.900816 systemd[1]: Initializing machine ID from VM UUID. Mar 3 14:05:26.900829 systemd[1]: Queued start job for default target initrd.target. Mar 3 14:05:26.900860 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 3 14:05:26.900878 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 3 14:05:26.900892 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 3 14:05:26.900966 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 3 14:05:26.900981 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 3 14:05:26.901001 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 3 14:05:26.901014 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Mar 3 14:05:26.901027 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Mar 3 14:05:26.901040 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 3 14:05:26.901054 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 3 14:05:26.901066 systemd[1]: Reached target paths.target - Path Units. Mar 3 14:05:26.901077 systemd[1]: Reached target slices.target - Slice Units. Mar 3 14:05:26.901091 systemd[1]: Reached target swap.target - Swaps. Mar 3 14:05:26.901109 systemd[1]: Reached target timers.target - Timer Units. Mar 3 14:05:26.901121 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 3 14:05:26.901133 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 3 14:05:26.901147 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 3 14:05:26.901160 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Mar 3 14:05:26.901172 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 3 14:05:26.901184 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 3 14:05:26.901198 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 3 14:05:26.901212 systemd[1]: Reached target sockets.target - Socket Units. Mar 3 14:05:26.901228 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 3 14:05:26.901242 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 3 14:05:26.901254 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 3 14:05:26.901268 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Mar 3 14:05:26.901279 systemd[1]: Starting systemd-fsck-usr.service... Mar 3 14:05:26.901293 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 3 14:05:26.901306 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 3 14:05:26.901319 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:05:26.901381 systemd-journald[204]: Collecting audit messages is disabled. Mar 3 14:05:26.901424 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 3 14:05:26.901440 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 3 14:05:26.901555 systemd-journald[204]: Journal started Mar 3 14:05:26.901588 systemd-journald[204]: Runtime Journal (/run/log/journal/94e26666fba540da88d03496fc98e952) is 6M, max 48.3M, 42.2M free. Mar 3 14:05:26.920206 systemd[1]: Started systemd-journald.service - Journal Service. Mar 3 14:05:26.929632 systemd[1]: Finished systemd-fsck-usr.service. Mar 3 14:05:26.953749 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 3 14:05:26.956670 systemd-modules-load[205]: Inserted module 'overlay' Mar 3 14:05:27.475186 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Mar 3 14:05:27.475232 kernel: Bridge firewalling registered Mar 3 14:05:26.981751 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 3 14:05:27.077191 systemd-modules-load[205]: Inserted module 'br_netfilter' Mar 3 14:05:27.480154 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 3 14:05:27.504250 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:05:27.536261 systemd-tmpfiles[217]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Mar 3 14:05:27.547767 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 3 14:05:27.568647 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 3 14:05:27.609842 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 3 14:05:27.614781 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 3 14:05:27.642764 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 3 14:05:27.684990 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 3 14:05:27.714712 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 3 14:05:27.737645 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 3 14:05:27.745416 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 3 14:05:27.793709 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 3 14:05:27.829249 dracut-cmdline[241]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=51ade538e3d3c371f07ae1ec6fa9803fff0566ec060cf4b56dc685fc36d0e01c Mar 3 14:05:27.936533 systemd-resolved[243]: Positive Trust Anchors: Mar 3 14:05:27.936830 systemd-resolved[243]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 3 14:05:27.936872 systemd-resolved[243]: 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 Mar 3 14:05:27.942141 systemd-resolved[243]: Defaulting to hostname 'linux'. Mar 3 14:05:27.974216 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 3 14:05:28.021038 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 3 14:05:28.378845 kernel: SCSI subsystem initialized Mar 3 14:05:28.404172 kernel: Loading iSCSI transport class v2.0-870. Mar 3 14:05:28.443566 kernel: iscsi: registered transport (tcp) Mar 3 14:05:28.488490 kernel: iscsi: registered transport (qla4xxx) Mar 3 14:05:28.488662 kernel: QLogic iSCSI HBA Driver Mar 3 14:05:28.564988 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 3 14:05:28.630144 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 3 14:05:28.635827 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 3 14:05:28.825236 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 3 14:05:28.842055 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 3 14:05:28.949702 kernel: raid6: avx2x4 gen() 19823 MB/s Mar 3 14:05:28.969895 kernel: raid6: avx2x2 gen() 19170 MB/s Mar 3 14:05:28.994874 kernel: raid6: avx2x1 gen() 11452 MB/s Mar 3 14:05:28.995042 kernel: raid6: using algorithm avx2x4 gen() 19823 MB/s Mar 3 14:05:29.018161 kernel: raid6: .... xor() 4743 MB/s, rmw enabled Mar 3 14:05:29.018277 kernel: raid6: using avx2x2 recovery algorithm Mar 3 14:05:29.060026 kernel: xor: automatically using best checksumming function avx Mar 3 14:05:29.542261 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 3 14:05:29.563645 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 3 14:05:29.572627 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 3 14:05:29.635790 systemd-udevd[455]: Using default interface naming scheme 'v255'. Mar 3 14:05:29.649257 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 3 14:05:29.660765 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 3 14:05:29.723688 dracut-pre-trigger[465]: rd.md=0: removing MD RAID activation Mar 3 14:05:29.814623 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 3 14:05:29.820821 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 3 14:05:30.021368 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 3 14:05:30.028869 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 3 14:05:30.127668 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Mar 3 14:05:30.134863 kernel: cryptd: max_cpu_qlen set to 1000 Mar 3 14:05:30.153700 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Mar 3 14:05:30.172578 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 3 14:05:30.208576 kernel: libata version 3.00 loaded. Mar 3 14:05:30.222582 kernel: AES CTR mode by8 optimization enabled Mar 3 14:05:30.253777 kernel: ahci 0000:00:1f.2: version 3.0 Mar 3 14:05:30.254444 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 3 14:05:30.310127 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Mar 3 14:05:30.310159 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Mar 3 14:05:30.310177 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Mar 3 14:05:30.315064 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Mar 3 14:05:30.315281 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Mar 3 14:05:30.315535 kernel: scsi host0: ahci Mar 3 14:05:30.315738 kernel: scsi host1: ahci Mar 3 14:05:30.257049 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:05:30.329651 kernel: scsi host2: ahci Mar 3 14:05:30.330440 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:05:30.362673 kernel: scsi host3: ahci Mar 3 14:05:30.356352 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:05:30.426374 kernel: scsi host4: ahci Mar 3 14:05:30.426766 kernel: scsi host5: ahci Mar 3 14:05:30.427163 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 lpm-pol 1 Mar 3 14:05:30.427192 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 lpm-pol 1 Mar 3 14:05:30.427211 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 lpm-pol 1 Mar 3 14:05:30.427230 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 lpm-pol 1 Mar 3 14:05:30.427248 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 lpm-pol 1 Mar 3 14:05:30.427266 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 lpm-pol 1 Mar 3 14:05:30.423782 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 3 14:05:30.471280 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Mar 3 14:05:30.956783 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Mar 3 14:05:30.956828 kernel: ata1: SATA link down (SStatus 0 SControl 300) Mar 3 14:05:30.956846 kernel: ata2: SATA link down (SStatus 0 SControl 300) Mar 3 14:05:30.956862 kernel: ata5: SATA link down (SStatus 0 SControl 300) Mar 3 14:05:30.956879 kernel: ata3.00: LPM support broken, forcing max_power Mar 3 14:05:30.956896 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Mar 3 14:05:30.956983 kernel: ata3.00: applying bridge limits Mar 3 14:05:30.957004 kernel: ata4: SATA link down (SStatus 0 SControl 300) Mar 3 14:05:30.957021 kernel: ata6: SATA link down (SStatus 0 SControl 300) Mar 3 14:05:30.957035 kernel: ata3.00: LPM support broken, forcing max_power Mar 3 14:05:30.957050 kernel: ata3.00: configured for UDMA/100 Mar 3 14:05:30.957067 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Mar 3 14:05:30.957423 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Mar 3 14:05:30.957811 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Mar 3 14:05:30.957839 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Mar 3 14:05:30.490284 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Mar 3 14:05:30.962546 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:05:30.989845 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Mar 3 14:05:30.993814 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Mar 3 14:05:31.025618 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Mar 3 14:05:31.033161 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 3 14:05:31.096604 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 3 14:05:31.357792 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 3 14:05:31.365182 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 3 14:05:31.378260 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 3 14:05:31.398362 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 3 14:05:31.427308 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 3 14:05:31.476029 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 3 14:05:32.136401 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 3 14:05:32.163599 disk-uuid[625]: The operation has completed successfully. Mar 3 14:05:32.301669 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 3 14:05:32.302019 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 3 14:05:32.396580 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Mar 3 14:05:32.484407 sh[651]: Success Mar 3 14:05:32.615023 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 3 14:05:32.615229 kernel: device-mapper: uevent: version 1.0.3 Mar 3 14:05:32.617084 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Mar 3 14:05:32.706737 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Mar 3 14:05:32.835797 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Mar 3 14:05:32.871629 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Mar 3 14:05:32.916720 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Mar 3 14:05:32.983897 kernel: BTRFS: device fsid f550cb98-648e-4600-9237-4b15eb09827b devid 1 transid 41 /dev/mapper/usr (253:0) scanned by mount (663) Mar 3 14:05:32.984001 kernel: BTRFS info (device dm-0): first mount of filesystem f550cb98-648e-4600-9237-4b15eb09827b Mar 3 14:05:32.984021 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:05:33.062199 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Mar 3 14:05:33.062352 kernel: BTRFS info (device dm-0 state E): enabling free space tree Mar 3 14:05:33.077784 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Mar 3 14:05:33.093896 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Mar 3 14:05:33.114088 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 3 14:05:33.130374 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 3 14:05:33.164409 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 3 14:05:33.268723 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (694) Mar 3 14:05:33.288262 kernel: BTRFS info (device vda6): first mount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:05:33.288566 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:05:33.330879 kernel: BTRFS info (device vda6): turning on async discard Mar 3 14:05:33.331082 kernel: BTRFS info (device vda6): enabling free space tree Mar 3 14:05:33.374848 kernel: BTRFS info (device vda6): last unmount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:05:33.401736 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 3 14:05:33.413140 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 3 14:05:33.714606 ignition[752]: Ignition 2.22.0 Mar 3 14:05:33.714796 ignition[752]: Stage: fetch-offline Mar 3 14:05:33.715238 ignition[752]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:05:33.715252 ignition[752]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Mar 3 14:05:33.715441 ignition[752]: parsed url from cmdline: "" Mar 3 14:05:33.715609 ignition[752]: no config URL provided Mar 3 14:05:33.715621 ignition[752]: reading system config file "/usr/lib/ignition/user.ign" Mar 3 14:05:33.715635 ignition[752]: no config at "/usr/lib/ignition/user.ign" Mar 3 14:05:33.715815 ignition[752]: op(1): [started] loading QEMU firmware config module Mar 3 14:05:33.715823 ignition[752]: op(1): executing: "modprobe" "qemu_fw_cfg" Mar 3 14:05:33.797324 ignition[752]: op(1): [finished] loading QEMU firmware config module Mar 3 14:05:33.798550 ignition[752]: parsing config with SHA512: 1404133f5d9a9909fa85a62ce18f9cc535bedb13f99f2aceecfcffe7fff1918cceaaf9a9bf777a14c7435ed57d1e48a14e647788d3ca5dc8d2ca76ccae2d8f68 Mar 3 14:05:33.819843 unknown[752]: fetched base config from "system" Mar 3 14:05:33.819861 unknown[752]: fetched user config from "qemu" Mar 3 14:05:33.820171 ignition[752]: fetch-offline: fetch-offline passed Mar 3 14:05:33.828086 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 3 14:05:33.820285 ignition[752]: Ignition finished successfully Mar 3 14:05:33.895585 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 3 14:05:33.912125 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 3 14:05:34.075685 systemd-networkd[842]: lo: Link UP Mar 3 14:05:34.075758 systemd-networkd[842]: lo: Gained carrier Mar 3 14:05:34.079382 systemd-networkd[842]: Enumeration completed Mar 3 14:05:34.081112 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 3 14:05:34.086133 systemd-networkd[842]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:05:34.086141 systemd-networkd[842]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 3 14:05:34.091868 systemd-networkd[842]: eth0: Link UP Mar 3 14:05:34.103019 systemd-networkd[842]: eth0: Gained carrier Mar 3 14:05:34.103041 systemd-networkd[842]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:05:34.181038 systemd[1]: Reached target network.target - Network. Mar 3 14:05:34.188547 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Mar 3 14:05:34.200928 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 3 14:05:34.249175 systemd-networkd[842]: eth0: DHCPv4 address 10.0.0.136/16, gateway 10.0.0.1 acquired from 10.0.0.1 Mar 3 14:05:34.379126 ignition[845]: Ignition 2.22.0 Mar 3 14:05:34.379196 ignition[845]: Stage: kargs Mar 3 14:05:34.379419 ignition[845]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:05:34.379435 ignition[845]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Mar 3 14:05:34.395631 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 3 14:05:34.380750 ignition[845]: kargs: kargs passed Mar 3 14:05:34.401096 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 3 14:05:34.380829 ignition[845]: Ignition finished successfully Mar 3 14:05:34.535437 ignition[854]: Ignition 2.22.0 Mar 3 14:05:34.537617 ignition[854]: Stage: disks Mar 3 14:05:34.538318 ignition[854]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:05:34.538340 ignition[854]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Mar 3 14:05:34.566367 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 3 14:05:34.544852 ignition[854]: disks: disks passed Mar 3 14:05:34.575100 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 3 14:05:34.544926 ignition[854]: Ignition finished successfully Mar 3 14:05:34.589763 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 3 14:05:34.599288 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 3 14:05:34.606324 systemd[1]: Reached target sysinit.target - System Initialization. Mar 3 14:05:34.623442 systemd[1]: Reached target basic.target - Basic System. Mar 3 14:05:34.676766 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 3 14:05:34.798293 systemd-fsck[864]: ROOT: clean, 15/553520 files, 52789/553472 blocks Mar 3 14:05:34.819396 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 3 14:05:34.871781 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 3 14:05:35.332143 systemd-networkd[842]: eth0: Gained IPv6LL Mar 3 14:05:35.641805 kernel: EXT4-fs (vda9): mounted filesystem f0c751de-febc-4e57-b330-c926d38ed5ec r/w with ordered data mode. Quota mode: none. Mar 3 14:05:35.649310 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 3 14:05:35.670389 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 3 14:05:35.694672 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 3 14:05:35.748236 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 3 14:05:35.776714 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Mar 3 14:05:35.790726 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 3 14:05:35.890314 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (872) Mar 3 14:05:35.791180 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 3 14:05:35.924739 kernel: BTRFS info (device vda6): first mount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:05:35.924801 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:05:35.937786 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 3 14:05:35.982275 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 3 14:05:36.022388 kernel: BTRFS info (device vda6): turning on async discard Mar 3 14:05:36.022439 kernel: BTRFS info (device vda6): enabling free space tree Mar 3 14:05:36.010384 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 3 14:05:36.431711 kernel: hrtimer: interrupt took 11681626 ns Mar 3 14:05:38.227016 initrd-setup-root[897]: cut: /sysroot/etc/passwd: No such file or directory Mar 3 14:05:38.339308 initrd-setup-root[904]: cut: /sysroot/etc/group: No such file or directory Mar 3 14:05:38.420164 initrd-setup-root[911]: cut: /sysroot/etc/shadow: No such file or directory Mar 3 14:05:38.500434 initrd-setup-root[918]: cut: /sysroot/etc/gshadow: No such file or directory Mar 3 14:05:39.781831 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 3 14:05:39.807716 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 3 14:05:39.819885 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 3 14:05:39.911875 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 3 14:05:39.956722 kernel: BTRFS info (device vda6): last unmount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:05:40.066624 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 3 14:05:40.488396 ignition[986]: INFO : Ignition 2.22.0 Mar 3 14:05:40.488396 ignition[986]: INFO : Stage: mount Mar 3 14:05:40.504261 ignition[986]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 3 14:05:40.504261 ignition[986]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Mar 3 14:05:40.560564 ignition[986]: INFO : mount: mount passed Mar 3 14:05:40.569910 ignition[986]: INFO : Ignition finished successfully Mar 3 14:05:40.588206 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 3 14:05:40.604364 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 3 14:05:40.698441 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 3 14:05:40.767148 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1000) Mar 3 14:05:40.793316 kernel: BTRFS info (device vda6): first mount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:05:40.793668 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:05:40.851618 kernel: BTRFS info (device vda6): turning on async discard Mar 3 14:05:40.851906 kernel: BTRFS info (device vda6): enabling free space tree Mar 3 14:05:40.859776 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 3 14:05:41.078280 ignition[1017]: INFO : Ignition 2.22.0 Mar 3 14:05:41.078280 ignition[1017]: INFO : Stage: files Mar 3 14:05:41.089082 ignition[1017]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 3 14:05:41.089082 ignition[1017]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Mar 3 14:05:41.109344 ignition[1017]: DEBUG : files: compiled without relabeling support, skipping Mar 3 14:05:41.109344 ignition[1017]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 3 14:05:41.109344 ignition[1017]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 3 14:05:41.152065 ignition[1017]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 3 14:05:41.152065 ignition[1017]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 3 14:05:41.152065 ignition[1017]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 3 14:05:41.152065 ignition[1017]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Mar 3 14:05:41.152065 ignition[1017]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Mar 3 14:05:41.152065 ignition[1017]: INFO : files: op(4): [started] processing unit "etcd-member.service" Mar 3 14:05:41.152065 ignition[1017]: 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" Mar 3 14:05:41.115390 unknown[1017]: wrote ssh authorized keys file for user: core Mar 3 14:05:41.242778 ignition[1017]: 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" Mar 3 14:05:41.242778 ignition[1017]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Mar 3 14:05:41.242778 ignition[1017]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Mar 3 14:05:41.242778 ignition[1017]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Mar 3 14:05:41.242778 ignition[1017]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Mar 3 14:05:41.242778 ignition[1017]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Mar 3 14:05:41.242778 ignition[1017]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Mar 3 14:05:41.410392 ignition[1017]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Mar 3 14:05:41.496172 ignition[1017]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Mar 3 14:05:41.512702 ignition[1017]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Mar 3 14:05:41.512702 ignition[1017]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Mar 3 14:05:41.512702 ignition[1017]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Mar 3 14:05:41.562165 ignition[1017]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 3 14:05:41.562165 ignition[1017]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 3 14:05:41.562165 ignition[1017]: INFO : files: files passed Mar 3 14:05:41.562165 ignition[1017]: INFO : Ignition finished successfully Mar 3 14:05:41.562119 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 3 14:05:41.606669 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 3 14:05:41.614798 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 3 14:05:41.681846 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 3 14:05:41.682240 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 3 14:05:41.712342 initrd-setup-root-after-ignition[1045]: grep: /sysroot/oem/oem-release: No such file or directory Mar 3 14:05:41.743234 initrd-setup-root-after-ignition[1052]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 3 14:05:41.767286 initrd-setup-root-after-ignition[1048]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 3 14:05:41.767286 initrd-setup-root-after-ignition[1048]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 3 14:05:41.794318 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 3 14:05:41.821239 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 3 14:05:41.829301 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 3 14:05:42.017432 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 3 14:05:42.017858 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 3 14:05:42.038733 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 3 14:05:42.088350 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 3 14:05:42.097811 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 3 14:05:42.123656 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 3 14:05:42.233417 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 3 14:05:42.247656 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 3 14:05:42.332045 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 3 14:05:42.345604 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 3 14:05:42.373157 systemd[1]: Stopped target timers.target - Timer Units. Mar 3 14:05:42.398215 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 3 14:05:42.398763 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 3 14:05:42.422304 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 3 14:05:42.431224 systemd[1]: Stopped target basic.target - Basic System. Mar 3 14:05:42.439117 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 3 14:05:42.458630 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 3 14:05:42.474136 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 3 14:05:42.488350 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Mar 3 14:05:42.504387 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 3 14:05:42.519143 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 3 14:05:42.541891 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 3 14:05:42.557829 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 3 14:05:42.572224 systemd[1]: Stopped target swap.target - Swaps. Mar 3 14:05:42.578423 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 3 14:05:42.578798 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 3 14:05:42.609181 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 3 14:05:42.616737 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 3 14:05:42.621731 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 3 14:05:42.622051 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 3 14:05:42.633173 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 3 14:05:42.635822 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 3 14:05:42.664256 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 3 14:05:42.664685 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 3 14:05:42.675386 systemd[1]: Stopped target paths.target - Path Units. Mar 3 14:05:42.682035 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 3 14:05:42.686742 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 3 14:05:42.709814 systemd[1]: Stopped target slices.target - Slice Units. Mar 3 14:05:42.718890 systemd[1]: Stopped target sockets.target - Socket Units. Mar 3 14:05:42.740851 systemd[1]: iscsid.socket: Deactivated successfully. Mar 3 14:05:42.741076 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 3 14:05:42.749650 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 3 14:05:42.749805 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 3 14:05:42.768708 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 3 14:05:42.768895 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 3 14:05:42.779813 systemd[1]: ignition-files.service: Deactivated successfully. Mar 3 14:05:42.779936 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 3 14:05:42.802395 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 3 14:05:42.810179 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 3 14:05:42.810429 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 3 14:05:42.871709 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 3 14:05:42.882748 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 3 14:05:42.883218 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 3 14:05:42.895066 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 3 14:05:42.895305 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 3 14:05:42.945941 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 3 14:05:42.946249 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 3 14:05:42.981866 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 3 14:05:43.817256 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 3 14:05:43.817657 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 3 14:05:43.948736 ignition[1072]: INFO : Ignition 2.22.0 Mar 3 14:05:43.948736 ignition[1072]: INFO : Stage: umount Mar 3 14:05:43.969286 ignition[1072]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 3 14:05:43.969286 ignition[1072]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Mar 3 14:05:43.969286 ignition[1072]: INFO : umount: umount passed Mar 3 14:05:43.969286 ignition[1072]: INFO : Ignition finished successfully Mar 3 14:05:44.004752 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 3 14:05:44.005310 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 3 14:05:44.026428 systemd[1]: Stopped target network.target - Network. Mar 3 14:05:44.055878 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 3 14:05:44.056102 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 3 14:05:44.060645 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 3 14:05:44.060800 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 3 14:05:44.072170 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 3 14:05:44.072339 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 3 14:05:44.085420 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 3 14:05:44.085666 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 3 14:05:44.109773 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 3 14:05:44.110189 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 3 14:05:44.123830 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 3 14:05:44.135369 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 3 14:05:44.206144 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 3 14:05:44.207259 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 3 14:05:44.372083 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Mar 3 14:05:44.393052 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 3 14:05:44.393690 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 3 14:05:44.426380 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Mar 3 14:05:44.440286 systemd[1]: Stopped target network-pre.target - Preparation for Network. Mar 3 14:05:44.472857 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 3 14:05:44.473085 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 3 14:05:44.482067 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 3 14:05:44.486193 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 3 14:05:44.486274 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 3 14:05:44.486639 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 3 14:05:44.486707 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 3 14:05:44.516588 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 3 14:05:44.516695 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 3 14:05:44.532350 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 3 14:05:44.532647 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 3 14:05:44.562210 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 3 14:05:44.574825 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Mar 3 14:05:44.574946 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Mar 3 14:05:44.679801 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 3 14:05:44.680348 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 3 14:05:44.708608 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 3 14:05:44.711753 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 3 14:05:44.755928 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 3 14:05:44.756107 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 3 14:05:44.770838 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Mar 3 14:05:44.770907 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Mar 3 14:05:44.780579 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 3 14:05:44.780844 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 3 14:05:44.802405 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 3 14:05:44.802635 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 3 14:05:44.850860 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 3 14:05:44.867354 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 3 14:05:44.882149 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 3 14:05:44.903317 systemd[1]: systemd-network-generator.service: Deactivated successfully. Mar 3 14:05:44.903442 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Mar 3 14:05:44.969697 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 3 14:05:44.969809 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 3 14:05:45.032606 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 3 14:05:45.032824 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:05:45.093773 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Mar 3 14:05:45.093939 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Mar 3 14:05:45.094089 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 3 14:05:45.096646 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 3 14:05:45.096867 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 3 14:05:45.158307 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 3 14:05:45.190573 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 3 14:05:45.301042 systemd[1]: Switching root. Mar 3 14:05:45.398581 systemd-journald[204]: Received SIGTERM from PID 1 (systemd). Mar 3 14:05:45.398783 systemd-journald[204]: Journal stopped Mar 3 14:05:48.756178 kernel: SELinux: policy capability network_peer_controls=1 Mar 3 14:05:48.756277 kernel: SELinux: policy capability open_perms=1 Mar 3 14:05:48.756346 kernel: SELinux: policy capability extended_socket_class=1 Mar 3 14:05:48.756366 kernel: SELinux: policy capability always_check_network=0 Mar 3 14:05:48.756440 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 3 14:05:48.756541 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 3 14:05:48.756564 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 3 14:05:48.756580 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 3 14:05:48.756597 kernel: SELinux: policy capability userspace_initial_context=0 Mar 3 14:05:48.756615 kernel: audit: type=1403 audit(1772546745.737:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Mar 3 14:05:48.756647 systemd[1]: Successfully loaded SELinux policy in 154.032ms. Mar 3 14:05:48.756678 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 19.429ms. Mar 3 14:05:48.756697 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 3 14:05:48.756727 systemd[1]: Detected virtualization kvm. Mar 3 14:05:48.756747 systemd[1]: Detected architecture x86-64. Mar 3 14:05:48.756766 systemd[1]: Detected first boot. Mar 3 14:05:48.756782 systemd[1]: Initializing machine ID from VM UUID. Mar 3 14:05:48.756801 zram_generator::config[1117]: No configuration found. Mar 3 14:05:48.756826 kernel: Guest personality initialized and is inactive Mar 3 14:05:48.756843 kernel: VMCI host device registered (name=vmci, major=10, minor=258) Mar 3 14:05:48.756859 kernel: Initialized host personality Mar 3 14:05:48.756877 kernel: NET: Registered PF_VSOCK protocol family Mar 3 14:05:48.756893 systemd[1]: Populated /etc with preset unit settings. Mar 3 14:05:48.756964 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Mar 3 14:05:48.756985 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 3 14:05:48.757048 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 3 14:05:48.757067 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 3 14:05:48.757091 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 3 14:05:48.757109 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 3 14:05:48.757130 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 3 14:05:48.757146 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 3 14:05:48.757165 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 3 14:05:48.757186 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 3 14:05:48.757203 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 3 14:05:48.757220 systemd[1]: Created slice user.slice - User and Session Slice. Mar 3 14:05:48.757244 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 3 14:05:48.757261 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 3 14:05:48.757281 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 3 14:05:48.757300 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 3 14:05:48.757317 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 3 14:05:48.757337 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 3 14:05:48.757354 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Mar 3 14:05:48.757371 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 3 14:05:48.757396 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 3 14:05:48.757539 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 3 14:05:48.757558 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 3 14:05:48.757578 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 3 14:05:48.757594 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 3 14:05:48.757612 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 3 14:05:48.757631 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 3 14:05:48.757649 systemd[1]: Reached target slices.target - Slice Units. Mar 3 14:05:48.757666 systemd[1]: Reached target swap.target - Swaps. Mar 3 14:05:48.757694 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 3 14:05:48.757715 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 3 14:05:48.757734 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Mar 3 14:05:48.757751 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 3 14:05:48.757769 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 3 14:05:48.757788 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 3 14:05:48.757808 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 3 14:05:48.757825 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 3 14:05:48.757844 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 3 14:05:48.757867 systemd[1]: Mounting media.mount - External Media Directory... Mar 3 14:05:48.757886 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:05:48.757904 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 3 14:05:48.757923 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 3 14:05:48.758038 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 3 14:05:48.758061 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). Mar 3 14:05:48.758081 systemd[1]: Reached target machines.target - Containers. Mar 3 14:05:48.758098 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 3 14:05:48.758121 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 3 14:05:48.758140 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 3 14:05:48.758156 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 3 14:05:48.758175 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 3 14:05:48.758195 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 3 14:05:48.758211 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 3 14:05:48.758228 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 3 14:05:48.758247 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 3 14:05:48.758263 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 3 14:05:48.758289 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 3 14:05:48.758308 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 3 14:05:48.758323 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 3 14:05:48.758343 systemd[1]: Stopped systemd-fsck-usr.service. Mar 3 14:05:48.758360 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 3 14:05:48.758378 kernel: fuse: init (API version 7.41) Mar 3 14:05:48.758396 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 3 14:05:48.758413 kernel: ACPI: bus type drm_connector registered Mar 3 14:05:48.758565 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 3 14:05:48.758584 kernel: loop: module loaded Mar 3 14:05:48.758602 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 3 14:05:48.758622 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 3 14:05:48.758677 systemd-journald[1202]: Collecting audit messages is disabled. Mar 3 14:05:48.758712 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Mar 3 14:05:48.758734 systemd-journald[1202]: Journal started Mar 3 14:05:48.758772 systemd-journald[1202]: Runtime Journal (/run/log/journal/94e26666fba540da88d03496fc98e952) is 6M, max 48.3M, 42.2M free. Mar 3 14:05:47.518309 systemd[1]: Queued start job for default target multi-user.target. Mar 3 14:05:47.556372 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Mar 3 14:05:47.560108 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 3 14:05:47.561182 systemd[1]: systemd-journald.service: Consumed 2.701s CPU time. Mar 3 14:05:48.780902 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 3 14:05:48.781050 systemd[1]: verity-setup.service: Deactivated successfully. Mar 3 14:05:48.784689 systemd[1]: Stopped verity-setup.service. Mar 3 14:05:48.793351 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:05:48.817794 systemd[1]: Started systemd-journald.service - Journal Service. Mar 3 14:05:48.819730 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 3 14:05:48.825765 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 3 14:05:48.830926 systemd[1]: Mounted media.mount - External Media Directory. Mar 3 14:05:48.835324 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 3 14:05:48.840581 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 3 14:05:48.845835 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 3 14:05:48.851363 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 3 14:05:48.858767 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 3 14:05:48.865430 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 3 14:05:48.865944 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 3 14:05:48.872100 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 3 14:05:48.872618 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 3 14:05:48.883260 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 3 14:05:48.883740 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 3 14:05:48.893049 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 3 14:05:48.893549 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 3 14:05:48.902796 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 3 14:05:48.904163 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 3 14:05:48.913767 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 3 14:05:48.914400 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 3 14:05:48.923578 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 3 14:05:48.935774 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 3 14:05:48.942820 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 3 14:05:48.958586 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Mar 3 14:05:48.984876 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 3 14:05:49.002725 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 3 14:05:49.012335 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 3 14:05:49.023068 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 3 14:05:49.031666 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 3 14:05:49.031722 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 3 14:05:49.043550 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Mar 3 14:05:49.055109 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 3 14:05:49.060819 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 3 14:05:49.067049 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 3 14:05:49.076146 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 3 14:05:49.084410 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 3 14:05:49.087979 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 3 14:05:49.098952 systemd-journald[1202]: Time spent on flushing to /var/log/journal/94e26666fba540da88d03496fc98e952 is 127.778ms for 947 entries. Mar 3 14:05:49.098952 systemd-journald[1202]: System Journal (/var/log/journal/94e26666fba540da88d03496fc98e952) is 8M, max 195.6M, 187.6M free. Mar 3 14:05:49.300121 systemd-journald[1202]: Received client request to flush runtime journal. Mar 3 14:05:49.111687 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 3 14:05:49.122357 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 3 14:05:49.141860 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 3 14:05:49.171202 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 3 14:05:49.205442 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 3 14:05:49.214693 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 3 14:05:49.227354 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 3 14:05:49.237690 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 3 14:05:49.255359 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Mar 3 14:05:49.266246 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 3 14:05:49.308413 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 3 14:05:49.344935 kernel: loop0: detected capacity change from 0 to 110984 Mar 3 14:05:49.377086 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 3 14:05:49.378822 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Mar 3 14:05:49.423184 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 3 14:05:49.431813 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 3 14:05:49.438676 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 3 14:05:49.485570 kernel: loop1: detected capacity change from 0 to 128560 Mar 3 14:05:49.512328 systemd-tmpfiles[1255]: ACLs are not supported, ignoring. Mar 3 14:05:49.512356 systemd-tmpfiles[1255]: ACLs are not supported, ignoring. Mar 3 14:05:49.524819 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 3 14:05:49.593551 kernel: loop2: detected capacity change from 0 to 110984 Mar 3 14:05:49.650608 kernel: loop3: detected capacity change from 0 to 128560 Mar 3 14:05:49.725882 (sd-merge)[1260]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Mar 3 14:05:49.727741 (sd-merge)[1260]: Merged extensions into '/usr'. Mar 3 14:05:49.739664 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 3 14:05:49.753323 systemd[1]: Starting ensure-sysext.service... Mar 3 14:05:49.760668 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 3 14:05:49.814555 systemd-tmpfiles[1263]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Mar 3 14:05:49.814647 systemd-tmpfiles[1263]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Mar 3 14:05:49.815825 systemd-tmpfiles[1263]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 3 14:05:49.816529 systemd-tmpfiles[1263]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Mar 3 14:05:49.816953 systemd[1]: Reload requested from client PID 1262 ('systemctl') (unit ensure-sysext.service)... Mar 3 14:05:49.816968 systemd[1]: Reloading... Mar 3 14:05:49.818516 systemd-tmpfiles[1263]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Mar 3 14:05:49.818914 systemd-tmpfiles[1263]: ACLs are not supported, ignoring. Mar 3 14:05:49.819064 systemd-tmpfiles[1263]: ACLs are not supported, ignoring. Mar 3 14:05:49.839210 systemd-tmpfiles[1263]: Detected autofs mount point /boot during canonicalization of boot. Mar 3 14:05:49.839228 systemd-tmpfiles[1263]: Skipping /boot Mar 3 14:05:49.867157 systemd-tmpfiles[1263]: Detected autofs mount point /boot during canonicalization of boot. Mar 3 14:05:49.867441 systemd-tmpfiles[1263]: Skipping /boot Mar 3 14:05:49.992581 zram_generator::config[1294]: No configuration found. Mar 3 14:05:50.271257 ldconfig[1232]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 3 14:05:50.367563 systemd[1]: Reloading finished in 549 ms. Mar 3 14:05:50.412879 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 3 14:05:50.420579 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 3 14:05:50.465108 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 3 14:05:50.497837 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 3 14:05:50.529192 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 3 14:05:50.541891 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 3 14:05:50.562955 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 3 14:05:50.589809 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 3 14:05:50.614671 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 3 14:05:50.654718 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:05:50.655195 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 3 14:05:50.660833 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 3 14:05:50.672669 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 3 14:05:50.683360 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 3 14:05:50.687855 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 3 14:05:50.688141 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 3 14:05:50.693413 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 3 14:05:50.702650 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:05:50.716195 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 3 14:05:50.727287 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 3 14:05:50.729586 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 3 14:05:50.737970 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 3 14:05:50.738417 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 3 14:05:50.740773 systemd-udevd[1341]: Using default interface naming scheme 'v255'. Mar 3 14:05:50.743861 augenrules[1360]: No rules Mar 3 14:05:50.749203 systemd[1]: audit-rules.service: Deactivated successfully. Mar 3 14:05:50.749648 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 3 14:05:50.758856 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 3 14:05:50.759331 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 3 14:05:50.775534 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 3 14:05:50.804660 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:05:50.807761 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 3 14:05:50.815348 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 3 14:05:50.830324 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 3 14:05:50.841757 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 3 14:05:50.859903 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 3 14:05:50.881115 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 3 14:05:50.887910 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 3 14:05:50.888142 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 3 14:05:50.893437 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 3 14:05:50.899669 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:05:50.906175 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 3 14:05:50.914429 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 3 14:05:50.926988 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 3 14:05:50.927376 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 3 14:05:50.939125 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 3 14:05:50.939986 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 3 14:05:50.951976 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 3 14:05:50.952377 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 3 14:05:50.967245 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 3 14:05:50.969765 augenrules[1371]: /sbin/augenrules: No change Mar 3 14:05:50.969958 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 3 14:05:50.981049 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 3 14:05:51.000306 systemd[1]: Finished ensure-sysext.service. Mar 3 14:05:51.005955 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 3 14:05:51.022067 augenrules[1428]: No rules Mar 3 14:05:51.024760 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 3 14:05:51.030682 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 3 14:05:51.030787 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 3 14:05:51.033786 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Mar 3 14:05:51.039688 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). Mar 3 14:05:51.040432 systemd[1]: audit-rules.service: Deactivated successfully. Mar 3 14:05:51.040948 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 3 14:05:51.175268 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Mar 3 14:05:51.230333 systemd-resolved[1335]: Positive Trust Anchors: Mar 3 14:05:51.231613 systemd-resolved[1335]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 3 14:05:51.231709 systemd-resolved[1335]: 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 Mar 3 14:05:51.238330 systemd-resolved[1335]: Defaulting to hostname 'linux'. Mar 3 14:05:51.243231 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 3 14:05:51.248815 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 3 14:05:51.307681 systemd-networkd[1436]: lo: Link UP Mar 3 14:05:51.308212 systemd-networkd[1436]: lo: Gained carrier Mar 3 14:05:51.311829 systemd-networkd[1436]: Enumeration completed Mar 3 14:05:51.312086 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Mar 3 14:05:51.318736 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 3 14:05:51.324716 systemd[1]: Reached target network.target - Network. Mar 3 14:05:51.325854 systemd-networkd[1436]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:05:51.325862 systemd-networkd[1436]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 3 14:05:51.327603 systemd-networkd[1436]: eth0: Link UP Mar 3 14:05:51.327895 systemd-networkd[1436]: eth0: Gained carrier Mar 3 14:05:51.327917 systemd-networkd[1436]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:05:51.345582 systemd-networkd[1436]: eth0: DHCPv4 address 10.0.0.136/16, gateway 10.0.0.1 acquired from 10.0.0.1 Mar 3 14:05:51.346161 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 3 14:05:51.355710 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Mar 3 14:05:51.386606 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Mar 3 14:05:51.386680 kernel: mousedev: PS/2 mouse device common for all mice Mar 3 14:05:51.369724 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 3 14:05:51.374885 systemd-timesyncd[1438]: Contacted time server 10.0.0.1:123 (10.0.0.1). Mar 3 14:05:51.375071 systemd-timesyncd[1438]: Initial clock synchronization to Tue 2026-03-03 14:05:51.542279 UTC. Mar 3 14:05:51.377191 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Mar 3 14:05:51.391988 systemd[1]: Reached target sysinit.target - System Initialization. Mar 3 14:05:51.398602 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 3 14:05:51.406249 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Mar 3 14:05:51.413697 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Mar 3 14:05:51.419062 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 3 14:05:51.425244 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 3 14:05:51.425340 systemd[1]: Reached target paths.target - Path Units. Mar 3 14:05:51.430165 systemd[1]: Reached target time-set.target - System Time Set. Mar 3 14:05:51.437789 kernel: ACPI: button: Power Button [PWRF] Mar 3 14:05:51.440163 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 3 14:05:51.446676 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 3 14:05:51.454136 systemd[1]: Reached target timers.target - Timer Units. Mar 3 14:05:51.476239 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 3 14:05:51.487431 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 3 14:05:51.501938 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Mar 3 14:05:51.511136 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Mar 3 14:05:51.520185 systemd[1]: Reached target ssh-access.target - SSH Access Available. Mar 3 14:05:51.537755 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 3 14:05:51.544285 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Mar 3 14:05:51.554518 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Mar 3 14:05:51.556106 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 3 14:05:51.568211 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Mar 3 14:05:51.571612 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Mar 3 14:05:51.579692 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 3 14:05:51.589803 systemd[1]: Reached target sockets.target - Socket Units. Mar 3 14:05:51.596264 systemd[1]: Reached target basic.target - Basic System. Mar 3 14:05:51.602184 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 3 14:05:51.602275 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 3 14:05:51.606652 systemd[1]: Starting containerd.service - containerd container runtime... Mar 3 14:05:51.614868 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 3 14:05:51.622430 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 3 14:05:51.644406 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 3 14:05:51.653849 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 3 14:05:51.660824 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). Mar 3 14:05:51.666655 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Mar 3 14:05:51.671392 jq[1479]: false Mar 3 14:05:51.720182 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 3 14:05:51.731964 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 3 14:05:51.737748 google_oslogin_nss_cache[1481]: oslogin_cache_refresh[1481]: Refreshing passwd entry cache Mar 3 14:05:51.737703 oslogin_cache_refresh[1481]: Refreshing passwd entry cache Mar 3 14:05:51.743982 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 3 14:05:51.763243 extend-filesystems[1480]: Found /dev/vda6 Mar 3 14:05:51.771189 google_oslogin_nss_cache[1481]: oslogin_cache_refresh[1481]: Failure getting users, quitting Mar 3 14:05:51.771189 google_oslogin_nss_cache[1481]: oslogin_cache_refresh[1481]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Mar 3 14:05:51.771189 google_oslogin_nss_cache[1481]: oslogin_cache_refresh[1481]: Refreshing group entry cache Mar 3 14:05:51.771298 extend-filesystems[1480]: Found /dev/vda9 Mar 3 14:05:51.770571 oslogin_cache_refresh[1481]: Failure getting users, quitting Mar 3 14:05:51.775825 extend-filesystems[1480]: Checking size of /dev/vda9 Mar 3 14:05:51.770605 oslogin_cache_refresh[1481]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Mar 3 14:05:51.770681 oslogin_cache_refresh[1481]: Refreshing group entry cache Mar 3 14:05:51.786881 google_oslogin_nss_cache[1481]: oslogin_cache_refresh[1481]: Failure getting groups, quitting Mar 3 14:05:51.786881 google_oslogin_nss_cache[1481]: oslogin_cache_refresh[1481]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Mar 3 14:05:51.786847 oslogin_cache_refresh[1481]: Failure getting groups, quitting Mar 3 14:05:51.786867 oslogin_cache_refresh[1481]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Mar 3 14:05:51.789861 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 3 14:05:51.793259 extend-filesystems[1480]: Old size kept for /dev/vda9 Mar 3 14:05:51.808157 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 3 14:05:51.814974 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Mar 3 14:05:51.816427 systemd[1]: Starting update-engine.service - Update Engine... Mar 3 14:05:51.833840 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 3 14:05:51.863647 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 3 14:05:51.875337 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 3 14:05:51.879157 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 3 14:05:51.879874 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 3 14:05:51.881409 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 3 14:05:51.890818 jq[1499]: true Mar 3 14:05:51.890843 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Mar 3 14:05:51.891409 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Mar 3 14:05:51.901144 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 3 14:05:51.901707 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 3 14:05:51.906529 update_engine[1497]: I20260303 14:05:51.904183 1497 main.cc:92] Flatcar Update Engine starting Mar 3 14:05:51.915899 systemd[1]: motdgen.service: Deactivated successfully. Mar 3 14:05:51.916582 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 3 14:05:51.974209 (ntainerd)[1509]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Mar 3 14:05:51.978894 jq[1508]: true Mar 3 14:05:52.063032 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:05:52.073644 systemd-logind[1492]: Watching system buttons on /dev/input/event2 (Power Button) Mar 3 14:05:52.074252 dbus-daemon[1477]: [system] SELinux support is enabled Mar 3 14:05:52.073725 systemd-logind[1492]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Mar 3 14:05:52.075181 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 3 14:05:52.076167 systemd-logind[1492]: New seat seat0. Mar 3 14:05:52.085409 systemd[1]: Started systemd-logind.service - User Login Management. Mar 3 14:05:52.091714 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). Mar 3 14:05:52.091777 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 3 14:05:52.098209 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). Mar 3 14:05:52.098316 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 3 14:05:52.118690 dbus-daemon[1477]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 3 14:05:52.126255 systemd[1]: Started update-engine.service - Update Engine. Mar 3 14:05:52.135928 update_engine[1497]: I20260303 14:05:52.130563 1497 update_check_scheduler.cc:74] Next update check in 9m36s Mar 3 14:05:52.140069 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 3 14:05:52.369954 sshd_keygen[1498]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 3 14:05:52.378371 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 3 14:05:52.428746 kernel: kvm_amd: TSC scaling supported Mar 3 14:05:52.428906 kernel: kvm_amd: Nested Virtualization enabled Mar 3 14:05:52.428991 kernel: kvm_amd: Nested Paging enabled Mar 3 14:05:52.429042 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Mar 3 14:05:52.432015 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 3 14:05:52.435101 kernel: kvm_amd: PMU virtualization is disabled Mar 3 14:05:52.456969 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 3 14:05:52.467640 bash[1540]: Updated "/home/core/.ssh/authorized_keys" Mar 3 14:05:52.471834 systemd[1]: Started sshd@0-10.0.0.136:22-10.0.0.1:51770.service - OpenSSH per-connection server daemon (10.0.0.1:51770). Mar 3 14:05:52.563704 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 3 14:05:52.595951 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Mar 3 14:05:52.640646 systemd[1]: issuegen.service: Deactivated successfully. Mar 3 14:05:52.641360 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 3 14:05:52.648422 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 3 14:05:52.697113 locksmithd[1532]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 3 14:05:52.774763 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 3 14:05:52.783242 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 3 14:05:52.790409 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Mar 3 14:05:52.808133 systemd[1]: Reached target getty.target - Login Prompts. Mar 3 14:05:52.876707 kernel: EDAC MC: Ver: 3.0.0 Mar 3 14:05:53.330615 systemd-networkd[1436]: eth0: Gained IPv6LL Mar 3 14:05:53.393834 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 3 14:05:53.566104 systemd[1]: Reached target network-online.target - Network is Online. Mar 3 14:05:53.812799 sshd[1552]: Accepted publickey for core from 10.0.0.1 port 51770 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:05:53.817218 sshd-session[1552]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:05:53.898078 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Mar 3 14:05:54.450352 containerd[1509]: time="2026-03-03T14:05:54Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Mar 3 14:05:54.452892 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 3 14:05:54.453773 containerd[1509]: time="2026-03-03T14:05:54.453565374Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.524301829Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="157.353µs" Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.524394787Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.524534987Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.524869167Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.524892568Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.525036424Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.525118184Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525520 containerd[1509]: time="2026-03-03T14:05:54.525130023Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525876 containerd[1509]: time="2026-03-03T14:05:54.525650993Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525876 containerd[1509]: time="2026-03-03T14:05:54.525671037Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525876 containerd[1509]: time="2026-03-03T14:05:54.525685359Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525876 containerd[1509]: time="2026-03-03T14:05:54.525695966Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Mar 3 14:05:54.525876 containerd[1509]: time="2026-03-03T14:05:54.525817131Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Mar 3 14:05:54.526642 containerd[1509]: time="2026-03-03T14:05:54.526451744Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Mar 3 14:05:54.526690 containerd[1509]: time="2026-03-03T14:05:54.526668493Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Mar 3 14:05:54.526690 containerd[1509]: time="2026-03-03T14:05:54.526686104Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Mar 3 14:05:54.526789 containerd[1509]: time="2026-03-03T14:05:54.526725172Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Mar 3 14:05:54.538147 containerd[1509]: time="2026-03-03T14:05:54.537103025Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Mar 3 14:05:54.538147 containerd[1509]: time="2026-03-03T14:05:54.537311926Z" level=info msg="metadata content store policy set" policy=shared Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.554732459Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.554962960Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.554985732Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.554999597Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555062108Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555132865Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555153773Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555172716Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555189696Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555273442Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555359214Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.555387369Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.556082082Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Mar 3 14:05:54.557569 containerd[1509]: time="2026-03-03T14:05:54.556192242Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556264384Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556288905Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556365068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556670775Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556700091Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556716948Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556736168Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556753523Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.556771692Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.557176649Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.557248669Z" level=info msg="Start snapshots syncer" Mar 3 14:05:54.558071 containerd[1509]: time="2026-03-03T14:05:54.557376369Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Mar 3 14:05:54.558555 containerd[1509]: time="2026-03-03T14:05:54.558224820Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Mar 3 14:05:54.558803 containerd[1509]: time="2026-03-03T14:05:54.558557400Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Mar 3 14:05:54.558803 containerd[1509]: time="2026-03-03T14:05:54.558651580Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Mar 3 14:05:54.559269 containerd[1509]: time="2026-03-03T14:05:54.559198314Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Mar 3 14:05:54.559559 containerd[1509]: time="2026-03-03T14:05:54.559308027Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Mar 3 14:05:54.559559 containerd[1509]: time="2026-03-03T14:05:54.559327664Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Mar 3 14:05:54.559559 containerd[1509]: time="2026-03-03T14:05:54.559344571Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Mar 3 14:05:54.559559 containerd[1509]: time="2026-03-03T14:05:54.559420337Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Mar 3 14:05:54.559559 containerd[1509]: time="2026-03-03T14:05:54.559438109Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Mar 3 14:05:54.559559 containerd[1509]: time="2026-03-03T14:05:54.559452309Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559573016Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559594658Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559610507Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559700177Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559723183Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559735673Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 3 14:05:54.559749 containerd[1509]: time="2026-03-03T14:05:54.559748336Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 3 14:05:54.559948 containerd[1509]: time="2026-03-03T14:05:54.559760337Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Mar 3 14:05:54.559948 containerd[1509]: time="2026-03-03T14:05:54.559773113Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Mar 3 14:05:54.559948 containerd[1509]: time="2026-03-03T14:05:54.559797095Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Mar 3 14:05:54.560037 containerd[1509]: time="2026-03-03T14:05:54.559994188Z" level=info msg="runtime interface created" Mar 3 14:05:54.560037 containerd[1509]: time="2026-03-03T14:05:54.560006719Z" level=info msg="created NRI interface" Mar 3 14:05:54.560089 containerd[1509]: time="2026-03-03T14:05:54.560067378Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Mar 3 14:05:54.560226 containerd[1509]: time="2026-03-03T14:05:54.560090250Z" level=info msg="Connect containerd service" Mar 3 14:05:54.560226 containerd[1509]: time="2026-03-03T14:05:54.560118692Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 3 14:05:54.563645 containerd[1509]: time="2026-03-03T14:05:54.562986608Z" 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" Mar 3 14:05:54.797852 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 3 14:05:55.439977 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 3 14:05:55.887888 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:05:55.899675 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 3 14:05:55.973255 systemd-logind[1492]: New session 1 of user core. Mar 3 14:05:55.991444 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 3 14:05:55.999862 systemd[1]: coreos-metadata.service: Deactivated successfully. Mar 3 14:05:56.000883 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Mar 3 14:05:56.018831 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.020958025Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.021053803Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.021183840Z" level=info msg="Start subscribing containerd event" Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.021308989Z" level=info msg="Start recovering state" Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.022098603Z" level=info msg="Start event monitor" Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.022159828Z" level=info msg="Start cni network conf syncer for default" Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.022215871Z" level=info msg="Start streaming server" Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.022278547Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.022335746Z" level=info msg="runtime interface starting up..." Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.022390390Z" level=info msg="starting plugins..." Mar 3 14:05:56.026901 containerd[1509]: time="2026-03-03T14:05:56.026859328Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Mar 3 14:05:56.028031 containerd[1509]: time="2026-03-03T14:05:56.027153589Z" level=info msg="containerd successfully booted in 1.961158s" Mar 3 14:05:56.028291 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 3 14:05:56.043909 (-wrapper)[1610]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Mar 3 14:05:56.050720 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 3 14:05:56.132208 systemd[1]: Started containerd.service - containerd container runtime. Mar 3 14:05:56.358672 (systemd)[1611]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Mar 3 14:05:56.370182 systemd-logind[1492]: New session c1 of user core. Mar 3 14:05:57.169046 systemd[1611]: Queued start job for default target default.target. Mar 3 14:05:57.188189 systemd[1611]: Created slice app.slice - User Application Slice. Mar 3 14:05:57.188281 systemd[1611]: Reached target paths.target - Paths. Mar 3 14:05:57.189407 systemd[1611]: Reached target timers.target - Timers. Mar 3 14:05:57.192974 systemd[1611]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 3 14:05:57.261285 systemd[1611]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 3 14:05:57.261646 systemd[1611]: Reached target sockets.target - Sockets. Mar 3 14:05:57.261769 systemd[1611]: Reached target basic.target - Basic System. Mar 3 14:05:57.261851 systemd[1611]: Reached target default.target - Main User Target. Mar 3 14:05:57.261909 systemd[1611]: Startup finished in 857ms. Mar 3 14:05:57.262078 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 3 14:05:57.279870 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 3 14:05:57.375795 systemd[1]: Started sshd@1-10.0.0.136:22-10.0.0.1:51776.service - OpenSSH per-connection server daemon (10.0.0.1:51776). Mar 3 14:05:57.552410 sshd[1631]: Accepted publickey for core from 10.0.0.1 port 51776 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:05:57.555051 sshd-session[1631]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:05:57.564960 systemd[1]: Starting docker.service - Docker Application Container Engine... Mar 3 14:05:57.581797 systemd-logind[1492]: New session 2 of user core. Mar 3 14:05:57.591178 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 3 14:05:57.593263 (dockerd)[1637]: 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 Mar 3 14:05:58.134392 sshd[1638]: Connection closed by 10.0.0.1 port 51776 Mar 3 14:05:58.138707 sshd-session[1631]: pam_unix(sshd:session): session closed for user core Mar 3 14:05:58.184041 systemd[1]: sshd@1-10.0.0.136:22-10.0.0.1:51776.service: Deactivated successfully. Mar 3 14:05:58.188391 systemd[1]: session-2.scope: Deactivated successfully. Mar 3 14:05:58.190525 systemd-logind[1492]: Session 2 logged out. Waiting for processes to exit. Mar 3 14:05:58.199380 systemd[1]: Started sshd@2-10.0.0.136:22-10.0.0.1:51786.service - OpenSSH per-connection server daemon (10.0.0.1:51786). Mar 3 14:05:58.204707 systemd-logind[1492]: Removed session 2. Mar 3 14:05:58.505228 sshd[1646]: Accepted publickey for core from 10.0.0.1 port 51786 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:05:58.506584 sshd-session[1646]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:05:58.527613 systemd-logind[1492]: New session 3 of user core. Mar 3 14:05:58.570071 systemd[1]: Started session-3.scope - Session 3 of User core. Mar 3 14:05:59.169337 sshd[1657]: Connection closed by 10.0.0.1 port 51786 Mar 3 14:05:59.172014 sshd-session[1646]: pam_unix(sshd:session): session closed for user core Mar 3 14:05:59.184740 systemd[1]: sshd@2-10.0.0.136:22-10.0.0.1:51786.service: Deactivated successfully. Mar 3 14:05:59.190279 systemd[1]: session-3.scope: Deactivated successfully. Mar 3 14:05:59.198869 systemd-logind[1492]: Session 3 logged out. Waiting for processes to exit. Mar 3 14:05:59.203756 systemd-logind[1492]: Removed session 3. Mar 3 14:05:59.609956 dockerd[1637]: time="2026-03-03T14:05:59.606993148Z" level=info msg="Starting up" Mar 3 14:05:59.618015 dockerd[1637]: time="2026-03-03T14:05:59.610913663Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Mar 3 14:05:59.685242 dockerd[1637]: time="2026-03-03T14:05:59.684916767Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Mar 3 14:05:59.850771 dockerd[1637]: time="2026-03-03T14:05:59.849848129Z" level=info msg="Loading containers: start." Mar 3 14:05:59.885406 kernel: Initializing XFRM netlink socket Mar 3 14:06:00.943374 systemd-networkd[1436]: docker0: Link UP Mar 3 14:06:00.962205 dockerd[1637]: time="2026-03-03T14:06:00.962010437Z" level=info msg="Loading containers: done." Mar 3 14:06:01.007742 dockerd[1637]: time="2026-03-03T14:06:01.007581013Z" 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 Mar 3 14:06:01.007971 dockerd[1637]: time="2026-03-03T14:06:01.007791612Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Mar 3 14:06:01.009343 dockerd[1637]: time="2026-03-03T14:06:01.009039063Z" level=info msg="Initializing buildkit" Mar 3 14:06:01.095052 dockerd[1637]: time="2026-03-03T14:06:01.094624505Z" level=info msg="Completed buildkit initialization" Mar 3 14:06:01.101321 dockerd[1637]: time="2026-03-03T14:06:01.100730606Z" level=info msg="Daemon has completed initialization" Mar 3 14:06:01.101528 systemd[1]: Started docker.service - Docker Application Container Engine. Mar 3 14:06:01.102762 dockerd[1637]: time="2026-03-03T14:06:01.101327036Z" level=info msg="API listen on /run/docker.sock" Mar 3 14:06:01.115588 etcd-wrapper[1615]: Error response from daemon: No such container: etcd-member Mar 3 14:06:01.200044 etcd-wrapper[1857]: Error response from daemon: No such container: etcd-member Mar 3 14:06:01.284924 etcd-wrapper[1880]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Mar 3 14:06:01.979031 etcd-wrapper[1880]: v3.5.24: Pulling from coreos/etcd Mar 3 14:06:02.506739 etcd-wrapper[1880]: 804c8aba2cc6: Pulling fs layer Mar 3 14:06:02.506739 etcd-wrapper[1880]: 2ae710cd8bfe: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: d462aa345367: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 0f8b424aa0b9: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: d557676654e5: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: c8022d07192e: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: d858cbc252ad: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 1069fc2daed1: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: b40161cd83fc: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 5318d93a3a65: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 307c1adadb60: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 49a553fa7ab9: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 9cde5f0af3dd: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: b9581a18c15b: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 95c11f3cd524: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: ed40c9b2e219: Pulling fs layer Mar 3 14:06:02.508084 etcd-wrapper[1880]: 0f8b424aa0b9: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: d557676654e5: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: c8022d07192e: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: d858cbc252ad: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: 1069fc2daed1: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: b40161cd83fc: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: 5318d93a3a65: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: 307c1adadb60: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: 49a553fa7ab9: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: b9581a18c15b: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: 95c11f3cd524: Waiting Mar 3 14:06:02.508084 etcd-wrapper[1880]: ed40c9b2e219: Waiting Mar 3 14:06:02.509359 etcd-wrapper[1880]: 9cde5f0af3dd: Waiting Mar 3 14:06:02.647829 etcd-wrapper[1880]: 804c8aba2cc6: Verifying Checksum Mar 3 14:06:02.647829 etcd-wrapper[1880]: 804c8aba2cc6: Download complete Mar 3 14:06:02.653361 etcd-wrapper[1880]: 2ae710cd8bfe: Verifying Checksum Mar 3 14:06:02.653361 etcd-wrapper[1880]: 2ae710cd8bfe: Download complete Mar 3 14:06:02.789789 etcd-wrapper[1880]: 0f8b424aa0b9: Verifying Checksum Mar 3 14:06:02.789789 etcd-wrapper[1880]: 0f8b424aa0b9: Download complete Mar 3 14:06:02.801437 etcd-wrapper[1880]: 804c8aba2cc6: Pull complete Mar 3 14:06:02.825763 etcd-wrapper[1880]: d557676654e5: Verifying Checksum Mar 3 14:06:02.825763 etcd-wrapper[1880]: d557676654e5: Download complete Mar 3 14:06:02.860071 systemd[1]: var-lib-docker-overlay2-f981c3949258178b070b46079e7db5f793e55a3d2013049f7a2cd84b0c8be780-merged.mount: Deactivated successfully. Mar 3 14:06:02.885934 etcd-wrapper[1880]: c8022d07192e: Verifying Checksum Mar 3 14:06:02.885934 etcd-wrapper[1880]: c8022d07192e: Download complete Mar 3 14:06:02.926199 etcd-wrapper[1880]: d858cbc252ad: Verifying Checksum Mar 3 14:06:02.926199 etcd-wrapper[1880]: d858cbc252ad: Download complete Mar 3 14:06:02.946844 etcd-wrapper[1880]: 2ae710cd8bfe: Pull complete Mar 3 14:06:02.989086 etcd-wrapper[1880]: 1069fc2daed1: Verifying Checksum Mar 3 14:06:02.989086 etcd-wrapper[1880]: 1069fc2daed1: Download complete Mar 3 14:06:03.012430 etcd-wrapper[1880]: b40161cd83fc: Verifying Checksum Mar 3 14:06:03.012430 etcd-wrapper[1880]: b40161cd83fc: Download complete Mar 3 14:06:03.131432 etcd-wrapper[1880]: 5318d93a3a65: Verifying Checksum Mar 3 14:06:03.131432 etcd-wrapper[1880]: 5318d93a3a65: Download complete Mar 3 14:06:03.167096 etcd-wrapper[1880]: d462aa345367: Verifying Checksum Mar 3 14:06:03.167096 etcd-wrapper[1880]: d462aa345367: Download complete Mar 3 14:06:03.214975 etcd-wrapper[1880]: 307c1adadb60: Verifying Checksum Mar 3 14:06:03.214975 etcd-wrapper[1880]: 307c1adadb60: Download complete Mar 3 14:06:03.697236 etcd-wrapper[1880]: 9cde5f0af3dd: Verifying Checksum Mar 3 14:06:03.697236 etcd-wrapper[1880]: 9cde5f0af3dd: Download complete Mar 3 14:06:03.797940 etcd-wrapper[1880]: b9581a18c15b: Verifying Checksum Mar 3 14:06:03.799273 etcd-wrapper[1880]: b9581a18c15b: Download complete Mar 3 14:06:03.799790 etcd-wrapper[1880]: 49a553fa7ab9: Verifying Checksum Mar 3 14:06:03.799790 etcd-wrapper[1880]: 49a553fa7ab9: Download complete Mar 3 14:06:03.799790 etcd-wrapper[1880]: 95c11f3cd524: Download complete Mar 3 14:06:03.871236 etcd-wrapper[1880]: ed40c9b2e219: Verifying Checksum Mar 3 14:06:03.871236 etcd-wrapper[1880]: ed40c9b2e219: Download complete Mar 3 14:06:07.224339 systemd[1]: var-lib-docker-overlay2-26e99de166688a8c7059bb9a36b52d85d696b60faff951346fdf65d39fe3f834-merged.mount: Deactivated successfully. Mar 3 14:06:07.477065 etcd-wrapper[1880]: d462aa345367: Pull complete Mar 3 14:06:07.560171 systemd[1]: var-lib-docker-overlay2-3f36ee48c4b7df38a4d5ca5448ff0984e7ac382fa435b50767c8d3710268fa2b-merged.mount: Deactivated successfully. Mar 3 14:06:07.612182 etcd-wrapper[1880]: 0f8b424aa0b9: Pull complete Mar 3 14:06:07.671442 systemd[1]: var-lib-docker-overlay2-d5d23e8e7ed09581cfe6420f7e1da3e1d9c73619f0899303b929f58123e32f3b-merged.mount: Deactivated successfully. Mar 3 14:06:07.711568 etcd-wrapper[1880]: d557676654e5: Pull complete Mar 3 14:06:07.796639 etcd-wrapper[1880]: c8022d07192e: Pull complete Mar 3 14:06:07.878228 etcd-wrapper[1880]: d858cbc252ad: Pull complete Mar 3 14:06:07.974805 etcd-wrapper[1880]: 1069fc2daed1: Pull complete Mar 3 14:06:08.046673 etcd-wrapper[1880]: b40161cd83fc: Pull complete Mar 3 14:06:08.111653 etcd-wrapper[1880]: 5318d93a3a65: Pull complete Mar 3 14:06:08.202826 etcd-wrapper[1880]: 307c1adadb60: Pull complete Mar 3 14:06:09.090430 systemd[1]: var-lib-docker-overlay2-737103f2a64f8b75470ebda4ee6ec08d63a098f633f20d5316b1018bf6ad099f-merged.mount: Deactivated successfully. Mar 3 14:06:09.213107 etcd-wrapper[1880]: 49a553fa7ab9: Pull complete Mar 3 14:06:09.245139 systemd[1]: Started sshd@3-10.0.0.136:22-10.0.0.1:46524.service - OpenSSH per-connection server daemon (10.0.0.1:46524). Mar 3 14:06:09.336871 sshd[1959]: Accepted publickey for core from 10.0.0.1 port 46524 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:09.341136 sshd-session[1959]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:09.355790 systemd-logind[1492]: New session 4 of user core. Mar 3 14:06:09.362071 systemd[1]: Started session-4.scope - Session 4 of User core. Mar 3 14:06:09.398967 sshd[1962]: Connection closed by 10.0.0.1 port 46524 Mar 3 14:06:09.399287 sshd-session[1959]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:09.410142 systemd[1]: sshd@3-10.0.0.136:22-10.0.0.1:46524.service: Deactivated successfully. Mar 3 14:06:09.416095 systemd[1]: session-4.scope: Deactivated successfully. Mar 3 14:06:09.419231 systemd-logind[1492]: Session 4 logged out. Waiting for processes to exit. Mar 3 14:06:09.426336 systemd[1]: Started sshd@4-10.0.0.136:22-10.0.0.1:46530.service - OpenSSH per-connection server daemon (10.0.0.1:46530). Mar 3 14:06:09.429051 systemd-logind[1492]: Removed session 4. Mar 3 14:06:09.531320 sshd[1968]: Accepted publickey for core from 10.0.0.1 port 46530 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:09.531045 sshd-session[1968]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:09.549150 systemd-logind[1492]: New session 5 of user core. Mar 3 14:06:09.559938 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 3 14:06:09.595891 sshd[1971]: Connection closed by 10.0.0.1 port 46530 Mar 3 14:06:09.598902 sshd-session[1968]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:09.608170 systemd[1]: sshd@4-10.0.0.136:22-10.0.0.1:46530.service: Deactivated successfully. Mar 3 14:06:09.612547 systemd[1]: session-5.scope: Deactivated successfully. Mar 3 14:06:09.618323 systemd-logind[1492]: Session 5 logged out. Waiting for processes to exit. Mar 3 14:06:09.621129 systemd-logind[1492]: Removed session 5. Mar 3 14:06:09.689549 systemd[1]: var-lib-docker-overlay2-8967d6905543694f2f1e24c8ff02c582993becb2ad450a243c63902c37ca5141-merged.mount: Deactivated successfully. Mar 3 14:06:09.773709 etcd-wrapper[1880]: 9cde5f0af3dd: Pull complete Mar 3 14:06:10.168080 systemd[1]: var-lib-docker-overlay2-d751118607eea43bd547f21087b178237294df56674f759c167d79f2af0f97a7-merged.mount: Deactivated successfully. Mar 3 14:06:10.235840 etcd-wrapper[1880]: b9581a18c15b: Pull complete Mar 3 14:06:10.271764 systemd[1]: var-lib-docker-overlay2-2fea32afaed2da929f405e7c3828272af83dff7499539f6a372034b0182bb44e-merged.mount: Deactivated successfully. Mar 3 14:06:10.308007 etcd-wrapper[1880]: 95c11f3cd524: Pull complete Mar 3 14:06:10.345271 systemd[1]: var-lib-docker-overlay2-0c4f36726e30ea4658f1bac9accec11305988119daefa370970c295f8814069c-merged.mount: Deactivated successfully. Mar 3 14:06:10.379810 etcd-wrapper[1880]: ed40c9b2e219: Pull complete Mar 3 14:06:10.402608 etcd-wrapper[1880]: Digest: sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594 Mar 3 14:06:10.411660 etcd-wrapper[1880]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.24 Mar 3 14:06:10.449776 systemd[1]: var-lib-docker-overlay2-211fefa1adb131c3995fe33aac6a287f2535e850c661c672d5f7cf31ad76166d\x2dinit-merged.mount: Deactivated successfully. Mar 3 14:06:10.603416 containerd[1509]: time="2026-03-03T14:06:10.603279738Z" level=info msg="connecting to shim 61981262f15499e708c275b880b8c8172cfbe83f74f3d5f97251e0ded68f94b8" address="unix:///run/containerd/s/f0a01aac31f4f9da527c0652cd3d1200a5b9328808bfa0304587dd2509c76405" namespace=moby protocol=ttrpc version=3 Mar 3 14:06:10.682969 systemd[1]: Started docker-61981262f15499e708c275b880b8c8172cfbe83f74f3d5f97251e0ded68f94b8.scope - libcontainer container 61981262f15499e708c275b880b8c8172cfbe83f74f3d5f97251e0ded68f94b8. Mar 3 14:06:10.724634 systemd-resolved[1335]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.855949Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.856205Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"94e26666fba540da88d03496fc98e952"} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.856249Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.856260Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.24"} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.856269Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.856277Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.856306Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.856591Z","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.136:2379"]} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.856693Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Mar 3 14:06:10.857861 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.856762Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Mar 3 14:06:10.870067 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.867707Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Mar 3 14:06:10.870067 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.867994Z","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":"94e26666fba540da88d03496fc98e952","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.136:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"94e26666fba540da88d03496fc98e952=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"} Mar 3 14:06:10.874186 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.873437Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.477311ms"} Mar 3 14:06:10.879666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.878886Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Mar 3 14:06:10.879666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.878990Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Mar 3 14:06:10.879666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.879026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Mar 3 14:06:10.879666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.879036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Mar 3 14:06:10.879666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.879049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Mar 3 14:06:10.879666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.879079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Mar 3 14:06:10.886769 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:06:10.885306Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Mar 3 14:06:10.889986 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.889134Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Mar 3 14:06:10.889986 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.889616Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Mar 3 14:06:10.892075 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.891574Z","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"} Mar 3 14:06:10.893885 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.893227Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.24","cluster-version":"to_be_decided"} Mar 3 14:06:10.895344 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.893711Z","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"} Mar 3 14:06:10.895344 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.893824Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Mar 3 14:06:10.895344 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.893966Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Mar 3 14:06:10.895344 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.893998Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Mar 3 14:06:10.895344 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.894007Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Mar 3 14:06:10.897069 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.896649Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Mar 3 14:06:10.897684 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.896701Z","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.136:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Mar 3 14:06:10.897684 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.896890Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Mar 3 14:06:10.897684 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.897245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Mar 3 14:06:10.898644 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.897557Z","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} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Mar 3 14:06:10.981044 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.979855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Mar 3 14:06:10.982888 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.982055Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:94e26666fba540da88d03496fc98e952 ClientURLs:[http://10.0.0.136:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Mar 3 14:06:10.982888 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.982113Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Mar 3 14:06:10.982888 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.982326Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Mar 3 14:06:10.984042 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.983161Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Mar 3 14:06:10.984042 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.983426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Mar 3 14:06:10.984823 systemd[1]: Started etcd-member.service - etcd (System Application Container). Mar 3 14:06:10.985675 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 3 14:06:10.985816 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.985100Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Mar 3 14:06:10.985877 systemd[1]: Startup finished in 9.545s (kernel) + 19.748s (initrd) + 25.394s (userspace) = 54.689s. Mar 3 14:06:10.987151 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.986644Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Mar 3 14:06:10.988069 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.987229Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Mar 3 14:06:10.988666 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.987843Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} Mar 3 14:06:10.989366 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:06:10.988131Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Mar 3 14:06:19.736593 systemd[1]: Started sshd@5-10.0.0.136:22-10.0.0.1:59612.service - OpenSSH per-connection server daemon (10.0.0.1:59612). Mar 3 14:06:20.063190 sshd[2049]: Accepted publickey for core from 10.0.0.1 port 59612 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:20.068100 sshd-session[2049]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:20.084168 systemd-logind[1492]: New session 6 of user core. Mar 3 14:06:20.094364 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 3 14:06:20.202154 sshd[2052]: Connection closed by 10.0.0.1 port 59612 Mar 3 14:06:20.204769 sshd-session[2049]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:20.243359 systemd[1]: Started sshd@6-10.0.0.136:22-10.0.0.1:49910.service - OpenSSH per-connection server daemon (10.0.0.1:49910). Mar 3 14:06:20.245901 systemd[1]: sshd@5-10.0.0.136:22-10.0.0.1:59612.service: Deactivated successfully. Mar 3 14:06:20.253370 systemd[1]: session-6.scope: Deactivated successfully. Mar 3 14:06:20.258151 systemd-logind[1492]: Session 6 logged out. Waiting for processes to exit. Mar 3 14:06:20.277645 systemd-logind[1492]: Removed session 6. Mar 3 14:06:20.577315 sshd[2055]: Accepted publickey for core from 10.0.0.1 port 49910 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:20.582374 sshd-session[2055]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:20.667576 systemd-logind[1492]: New session 7 of user core. Mar 3 14:06:20.701747 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 3 14:06:20.834233 sshd[2061]: Connection closed by 10.0.0.1 port 49910 Mar 3 14:06:20.833786 sshd-session[2055]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:20.885073 systemd[1]: sshd@6-10.0.0.136:22-10.0.0.1:49910.service: Deactivated successfully. Mar 3 14:06:20.893090 systemd[1]: session-7.scope: Deactivated successfully. Mar 3 14:06:20.904886 systemd-logind[1492]: Session 7 logged out. Waiting for processes to exit. Mar 3 14:06:20.964355 systemd[1]: Started sshd@7-10.0.0.136:22-10.0.0.1:49912.service - OpenSSH per-connection server daemon (10.0.0.1:49912). Mar 3 14:06:20.968860 systemd-logind[1492]: Removed session 7. Mar 3 14:06:21.335176 sshd[2067]: Accepted publickey for core from 10.0.0.1 port 49912 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:21.338069 sshd-session[2067]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:21.383308 systemd-logind[1492]: New session 8 of user core. Mar 3 14:06:21.402163 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 3 14:06:21.479760 sshd[2070]: Connection closed by 10.0.0.1 port 49912 Mar 3 14:06:21.484967 sshd-session[2067]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:21.539442 systemd[1]: Started sshd@8-10.0.0.136:22-10.0.0.1:49920.service - OpenSSH per-connection server daemon (10.0.0.1:49920). Mar 3 14:06:21.540891 systemd[1]: sshd@7-10.0.0.136:22-10.0.0.1:49912.service: Deactivated successfully. Mar 3 14:06:21.545865 systemd[1]: session-8.scope: Deactivated successfully. Mar 3 14:06:21.548985 systemd-logind[1492]: Session 8 logged out. Waiting for processes to exit. Mar 3 14:06:21.583293 systemd-logind[1492]: Removed session 8. Mar 3 14:06:21.830084 sshd[2073]: Accepted publickey for core from 10.0.0.1 port 49920 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:21.809709 sshd-session[2073]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:21.890874 systemd-logind[1492]: New session 9 of user core. Mar 3 14:06:21.905272 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 3 14:06:22.037644 sudo[2080]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Mar 3 14:06:22.039030 sudo[2080]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 3 14:06:22.087978 sudo[2080]: pam_unix(sudo:session): session closed for user root Mar 3 14:06:22.095736 sshd[2079]: Connection closed by 10.0.0.1 port 49920 Mar 3 14:06:22.104240 sshd-session[2073]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:22.144074 systemd[1]: Started sshd@9-10.0.0.136:22-10.0.0.1:49924.service - OpenSSH per-connection server daemon (10.0.0.1:49924). Mar 3 14:06:22.151701 systemd[1]: sshd@8-10.0.0.136:22-10.0.0.1:49920.service: Deactivated successfully. Mar 3 14:06:22.176766 systemd[1]: session-9.scope: Deactivated successfully. Mar 3 14:06:22.186326 systemd-logind[1492]: Session 9 logged out. Waiting for processes to exit. Mar 3 14:06:22.217176 systemd-logind[1492]: Removed session 9. Mar 3 14:06:22.492187 sshd[2083]: Accepted publickey for core from 10.0.0.1 port 49924 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:22.494989 sshd-session[2083]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:22.548660 systemd-logind[1492]: New session 10 of user core. Mar 3 14:06:22.566205 systemd[1]: Started session-10.scope - Session 10 of User core. Mar 3 14:06:22.673700 sudo[2091]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Mar 3 14:06:22.674670 sudo[2091]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 3 14:06:22.702268 sudo[2091]: pam_unix(sudo:session): session closed for user root Mar 3 14:06:22.763117 sudo[2090]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Mar 3 14:06:22.764101 sudo[2090]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 3 14:06:22.897553 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 3 14:06:23.155094 augenrules[2113]: No rules Mar 3 14:06:23.159201 systemd[1]: audit-rules.service: Deactivated successfully. Mar 3 14:06:23.159845 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 3 14:06:23.166844 sudo[2090]: pam_unix(sudo:session): session closed for user root Mar 3 14:06:23.170932 sshd[2089]: Connection closed by 10.0.0.1 port 49924 Mar 3 14:06:23.172363 sshd-session[2083]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:23.189894 systemd[1]: sshd@9-10.0.0.136:22-10.0.0.1:49924.service: Deactivated successfully. Mar 3 14:06:23.197240 systemd[1]: session-10.scope: Deactivated successfully. Mar 3 14:06:23.211820 systemd-logind[1492]: Session 10 logged out. Waiting for processes to exit. Mar 3 14:06:23.235891 systemd[1]: Started sshd@10-10.0.0.136:22-10.0.0.1:49938.service - OpenSSH per-connection server daemon (10.0.0.1:49938). Mar 3 14:06:23.243902 systemd-logind[1492]: Removed session 10. Mar 3 14:06:23.478857 sshd[2122]: Accepted publickey for core from 10.0.0.1 port 49938 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:23.482732 sshd-session[2122]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:23.553963 systemd-logind[1492]: New session 11 of user core. Mar 3 14:06:23.582117 systemd[1]: Started session-11.scope - Session 11 of User core. Mar 3 14:06:23.667595 sshd[2125]: Connection closed by 10.0.0.1 port 49938 Mar 3 14:06:23.668349 sshd-session[2122]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:23.688433 systemd[1]: sshd@10-10.0.0.136:22-10.0.0.1:49938.service: Deactivated successfully. Mar 3 14:06:23.701662 systemd[1]: session-11.scope: Deactivated successfully. Mar 3 14:06:23.750959 systemd-logind[1492]: Session 11 logged out. Waiting for processes to exit. Mar 3 14:06:23.757601 systemd-logind[1492]: Removed session 11. Mar 3 14:06:23.763051 systemd[1]: Started sshd@11-10.0.0.136:22-10.0.0.1:49954.service - OpenSSH per-connection server daemon (10.0.0.1:49954). Mar 3 14:06:23.940267 sshd[2133]: Accepted publickey for core from 10.0.0.1 port 49954 ssh2: RSA SHA256:32UhPjaQWCRIk78qzH4+8SldxGHDt/Mq5Nh3Isholw4 Mar 3 14:06:23.943104 sshd-session[2133]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:06:23.965303 systemd-logind[1492]: New session 12 of user core. Mar 3 14:06:23.993072 systemd[1]: Started session-12.scope - Session 12 of User core. Mar 3 14:06:24.350669 sshd[2136]: Connection closed by 10.0.0.1 port 49954 Mar 3 14:06:24.353924 sshd-session[2133]: pam_unix(sshd:session): session closed for user core Mar 3 14:06:24.390722 systemd[1]: sshd@11-10.0.0.136:22-10.0.0.1:49954.service: Deactivated successfully. Mar 3 14:06:24.402352 systemd[1]: session-12.scope: Deactivated successfully. Mar 3 14:06:24.429996 systemd-logind[1492]: Session 12 logged out. Waiting for processes to exit. Mar 3 14:06:24.436176 systemd-logind[1492]: Removed session 12. Mar 3 14:06:37.340311 update_engine[1497]: I20260303 14:06:37.312150 1497 update_attempter.cc:509] Updating boot flags... Mar 3 14:08:32.744391 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:08:32.733299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.858392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Mar 3 14:08:32.744391 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:08:32.738056Z","caller":"traceutil/trace.go:171","msg":"trace[1333581756] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"280.510889ms","start":"2026-03-03T14:08:32.457413Z","end":"2026-03-03T14:08:32.737923Z","steps":["trace[1333581756] 'process raft request' (duration: 77.547625ms)","trace[1333581756] 'compare' (duration: 196.923838ms)"],"step_count":2} Mar 3 14:08:33.465808 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:08:33.447041Z","caller":"traceutil/trace.go:171","msg":"trace[1151564881] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"114.171168ms","start":"2026-03-03T14:08:33.332851Z","end":"2026-03-03T14:08:33.447022Z","steps":["trace[1151564881] 'process raft request' (duration: 53.941029ms)","trace[1151564881] 'compare' (duration: 59.968771ms)"],"step_count":2} Mar 3 14:08:33.465808 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:08:33.447417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.461338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/operator.tigera.io/goldmanes/\" range_end:\"/registry/operator.tigera.io/goldmanes0\" limit:10000 ","response":"range_response_count:0 size:5"} Mar 3 14:08:33.465808 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:08:33.447589Z","caller":"traceutil/trace.go:171","msg":"trace[559215188] range","detail":"{range_begin:/registry/operator.tigera.io/goldmanes/; range_end:/registry/operator.tigera.io/goldmanes0; response_count:0; response_revision:584; }","duration":"117.505102ms","start":"2026-03-03T14:08:33.329934Z","end":"2026-03-03T14:08:33.447439Z","steps":["trace[559215188] 'agreement among raft nodes before linearized reading' (duration: 117.397857ms)"],"step_count":1} Mar 3 14:08:33.465808 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:08:33.447660Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.735842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/operator.tigera.io/goldmanes/\" range_end:\"/registry/operator.tigera.io/goldmanes0\" count_only:true ","response":"range_response_count:0 size:5"} Mar 3 14:08:33.474094 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:08:33.447680Z","caller":"traceutil/trace.go:171","msg":"trace[1224076269] range","detail":"{range_begin:/registry/operator.tigera.io/goldmanes/; range_end:/registry/operator.tigera.io/goldmanes0; response_count:0; response_revision:584; }","duration":"117.756641ms","start":"2026-03-03T14:08:33.329917Z","end":"2026-03-03T14:08:33.447674Z","steps":["trace[1224076269] 'agreement among raft nodes before linearized reading' (duration: 117.726023ms)"],"step_count":1} Mar 3 14:10:13.435979 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:13.366340Z","caller":"traceutil/trace.go:171","msg":"trace[1277022852] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"113.019634ms","start":"2026-03-03T14:10:13.241035Z","end":"2026-03-03T14:10:13.354054Z","steps":["trace[1277022852] 'process raft request' (duration: 88.954708ms)","trace[1277022852] 'compare' (duration: 12.233237ms)"],"step_count":2} Mar 3 14:10:14.479201 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:14.439209Z","caller":"traceutil/trace.go:171","msg":"trace[975569337] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"158.666424ms","start":"2026-03-03T14:10:14.280321Z","end":"2026-03-03T14:10:14.438988Z","steps":["trace[975569337] 'process raft request' (duration: 91.041452ms)","trace[975569337] 'compare' (duration: 65.852696ms)"],"step_count":2} Mar 3 14:10:18.482079 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:18.473343Z","caller":"traceutil/trace.go:171","msg":"trace[1746413710] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"446.923394ms","start":"2026-03-03T14:10:18.026401Z","end":"2026-03-03T14:10:18.473324Z","steps":["trace[1746413710] 'process raft request' (duration: 446.819931ms)"],"step_count":1} Mar 3 14:10:18.482079 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:18.473907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:18.026381Z","time spent":"447.022298ms","remote":"10.0.0.144:33472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Mar 3 14:10:18.482079 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:18.474874Z","caller":"traceutil/trace.go:171","msg":"trace[1708666254] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1380; }","duration":"336.384023ms","start":"2026-03-03T14:10:18.138040Z","end":"2026-03-03T14:10:18.474424Z","steps":["trace[1708666254] 'read index received' (duration: 336.376388ms)","trace[1708666254] 'applied index is now lower than readState.Index' (duration: 6.582µs)"],"step_count":2} Mar 3 14:10:18.482079 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:18.474987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.933788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Mar 3 14:10:18.496097 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:18.475013Z","caller":"traceutil/trace.go:171","msg":"trace[439069876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1332; }","duration":"336.970677ms","start":"2026-03-03T14:10:18.138035Z","end":"2026-03-03T14:10:18.475005Z","steps":["trace[439069876] 'agreement among raft nodes before linearized reading' (duration: 336.9133ms)"],"step_count":1} Mar 3 14:10:18.496097 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:18.475041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:18.138018Z","time spent":"337.014469ms","remote":"10.0.0.144:33216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} Mar 3 14:10:48.638107 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:48.635111Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7587893244185791987,"retry-timeout":"500ms"} Mar 3 14:10:49.195091 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.136197Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7587893244185791987,"retry-timeout":"500ms"} Mar 3 14:10:49.195091 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.155039Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.319690484s","expected-duration":"1s"} Mar 3 14:10:49.195091 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:49.156275Z","caller":"traceutil/trace.go:171","msg":"trace[619857961] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"1.320978487s","start":"2026-03-03T14:10:47.835279Z","end":"2026-03-03T14:10:49.156257Z","steps":["trace[619857961] 'process raft request' (duration: 1.320893058s)"],"step_count":1} Mar 3 14:10:49.195091 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.156819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:47.835261Z","time spent":"1.321045713s","remote":"10.0.0.144:33472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Mar 3 14:10:49.195091 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:49.161237Z","caller":"traceutil/trace.go:171","msg":"trace[600215402] linearizableReadLoop","detail":"{readStateIndex:1675; appliedIndex:1673; }","duration":"1.026781937s","start":"2026-03-03T14:10:48.134445Z","end":"2026-03-03T14:10:49.161227Z","steps":["trace[600215402] 'read index received' (duration: 1.022610179s)","trace[600215402] 'applied index is now lower than readState.Index' (duration: 4.171277ms)"],"step_count":2} Mar 3 14:10:50.726208 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.162792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028342556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Mar 3 14:10:50.726208 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:49.162826Z","caller":"traceutil/trace.go:171","msg":"trace[1992157252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1477; }","duration":"1.028378182s","start":"2026-03-03T14:10:48.134441Z","end":"2026-03-03T14:10:49.162819Z","steps":["trace[1992157252] 'agreement among raft nodes before linearized reading' (duration: 1.027983987s)"],"step_count":1} Mar 3 14:10:50.726208 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.162848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:48.134427Z","time spent":"1.02841461s","remote":"10.0.0.144:33216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} Mar 3 14:10:50.726208 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:49.162894Z","caller":"traceutil/trace.go:171","msg":"trace[1311945254] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"436.671794ms","start":"2026-03-03T14:10:48.726216Z","end":"2026-03-03T14:10:49.162888Z","steps":["trace[1311945254] 'process raft request' (duration: 434.941179ms)"],"step_count":1} Mar 3 14:10:50.727207 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.162933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:48.726197Z","time spent":"436.710456ms","remote":"10.0.0.144:33472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Mar 3 14:10:50.727207 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:49.162962Z","caller":"traceutil/trace.go:171","msg":"trace[889559684] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"348.770675ms","start":"2026-03-03T14:10:48.814184Z","end":"2026-03-03T14:10:49.162955Z","steps":["trace[889559684] 'process raft request' (duration: 347.019009ms)"],"step_count":1} Mar 3 14:10:50.727207 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.162987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:48.814160Z","time spent":"348.812853ms","remote":"10.0.0.144:33472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Mar 3 14:10:50.727207 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.163046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.925304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions\" limit:1 ","response":"range_response_count:0 size:5"} Mar 3 14:10:50.728360 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:49.163062Z","caller":"traceutil/trace.go:171","msg":"trace[116897188] range","detail":"{range_begin:/registry/minions; range_end:; response_count:0; response_revision:1477; }","duration":"370.941915ms","start":"2026-03-03T14:10:48.792115Z","end":"2026-03-03T14:10:49.163057Z","steps":["trace[116897188] 'agreement among raft nodes before linearized reading' (duration: 370.91766ms)"],"step_count":1} Mar 3 14:10:50.728360 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:49.163078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:48.792098Z","time spent":"370.975468ms","remote":"10.0.0.144:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":29,"request content":"key:\"/registry/minions\" limit:1 "} Mar 3 14:10:50.728360 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.720960Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.429565351s","expected-duration":"1s"} Mar 3 14:10:50.736959 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.726043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.543933421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Mar 3 14:10:50.736959 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:50.726103Z","caller":"traceutil/trace.go:171","msg":"trace[359373462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1477; }","duration":"1.544000716s","start":"2026-03-03T14:10:49.182088Z","end":"2026-03-03T14:10:50.726089Z","steps":["trace[359373462] 'range keys from in-memory index tree' (duration: 1.543880311s)"],"step_count":1} Mar 3 14:10:50.736959 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.726134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:49.182072Z","time spent":"1.544053836s","remote":"10.0.0.144:33216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} Mar 3 14:10:50.741189 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:50.737097Z","caller":"traceutil/trace.go:171","msg":"trace[1605309723] linearizableReadLoop","detail":"{readStateIndex:1677; appliedIndex:1675; }","duration":"486.703631ms","start":"2026-03-03T14:10:50.250377Z","end":"2026-03-03T14:10:50.737081Z","steps":["trace[1605309723] 'read index received' (duration: 472.565613ms)","trace[1605309723] 'applied index is now lower than readState.Index' (duration: 14.136976ms)"],"step_count":2} Mar 3 14:10:50.741189 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:50.737405Z","caller":"traceutil/trace.go:171","msg":"trace[645737170] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"671.377408ms","start":"2026-03-03T14:10:50.066018Z","end":"2026-03-03T14:10:50.737395Z","steps":["trace[645737170] 'process raft request' (duration: 670.977412ms)"],"step_count":1} Mar 3 14:10:50.741189 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.738170Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:50.065998Z","time spent":"671.429445ms","remote":"10.0.0.144:33472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Mar 3 14:10:50.741189 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.738257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.303193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/calico-system/calico-node\" limit:1 ","response":"range_response_count:1 size:13078"} Mar 3 14:10:50.742125 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:50.738294Z","caller":"traceutil/trace.go:171","msg":"trace[1736104022] range","detail":"{range_begin:/registry/daemonsets/calico-system/calico-node; range_end:; response_count:1; response_revision:1478; }","duration":"201.342026ms","start":"2026-03-03T14:10:50.536945Z","end":"2026-03-03T14:10:50.738288Z","steps":["trace[1736104022] 'agreement among raft nodes before linearized reading' (duration: 201.282715ms)"],"step_count":1} Mar 3 14:10:50.742125 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.738378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.999888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 ","response":"range_response_count:1 size:886"} Mar 3 14:10:50.742125 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:10:50.738396Z","caller":"traceutil/trace.go:171","msg":"trace[559169127] range","detail":"{range_begin:/registry/crd.projectcalico.org/clusterinformations/default; range_end:; response_count:1; response_revision:1478; }","duration":"488.016889ms","start":"2026-03-03T14:10:50.250373Z","end":"2026-03-03T14:10:50.738390Z","steps":["trace[559169127] 'agreement among raft nodes before linearized reading' (duration: 487.986823ms)"],"step_count":1} Mar 3 14:10:50.742125 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:10:50.738414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:10:50.250360Z","time spent":"488.046685ms","remote":"10.0.0.144:45132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":910,"request content":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 "} Mar 3 14:11:13.661061 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:11:13.659039Z","caller":"traceutil/trace.go:171","msg":"trace[170448018] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"311.888362ms","start":"2026-03-03T14:11:13.347132Z","end":"2026-03-03T14:11:13.659020Z","steps":["trace[170448018] 'process raft request' (duration: 311.793855ms)"],"step_count":1} Mar 3 14:11:13.661061 etcd-wrapper[1880]: {"level":"warn","ts":"2026-03-03T14:11:13.659159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-03T14:11:13.347114Z","time spent":"311.98901ms","remote":"10.0.0.144:33472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Mar 3 14:11:13.668167 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:11:13.664051Z","caller":"traceutil/trace.go:171","msg":"trace[647795001] transaction","detail":"{read_only:false; response_revision:1599; number_of_response:1; }","duration":"293.812114ms","start":"2026-03-03T14:11:13.370228Z","end":"2026-03-03T14:11:13.664040Z","steps":["trace[647795001] 'process raft request' (duration: 293.637779ms)"],"step_count":1} Mar 3 14:11:13.668167 etcd-wrapper[1880]: {"level":"info","ts":"2026-03-03T14:11:13.664128Z","caller":"traceutil/trace.go:171","msg":"trace[1158193298] transaction","detail":"{read_only:false; response_revision:1600; number_of_response:1; }","duration":"284.268276ms","start":"2026-03-03T14:11:13.379848Z","end":"2026-03-03T14:11:13.664116Z","steps":["trace[1158193298] 'process raft request' (duration: 284.061109ms)"],"step_count":1}