Jul 7 06:04:49.850801 kernel: Linux version 6.12.35-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Sun Jul 6 21:56:00 -00 2025 Jul 7 06:04:49.850826 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=2e0b2c30526b1d273b6d599d4c30389a93a14ce36aaa5af83a05b11c5ea5ae50 Jul 7 06:04:49.850835 kernel: BIOS-provided physical RAM map: Jul 7 06:04:49.850842 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jul 7 06:04:49.850848 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jul 7 06:04:49.850855 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jul 7 06:04:49.850862 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Jul 7 06:04:49.850871 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Jul 7 06:04:49.850881 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jul 7 06:04:49.850887 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Jul 7 06:04:49.850894 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jul 7 06:04:49.850900 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jul 7 06:04:49.850907 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jul 7 06:04:49.850913 kernel: NX (Execute Disable) protection: active Jul 7 06:04:49.850924 kernel: APIC: Static calls initialized Jul 7 06:04:49.850931 kernel: SMBIOS 2.8 present. Jul 7 06:04:49.850941 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Jul 7 06:04:49.850948 kernel: DMI: Memory slots populated: 1/1 Jul 7 06:04:49.850955 kernel: Hypervisor detected: KVM Jul 7 06:04:49.850962 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jul 7 06:04:49.850969 kernel: kvm-clock: using sched offset of 4416757132 cycles Jul 7 06:04:49.850977 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jul 7 06:04:49.850984 kernel: tsc: Detected 2794.746 MHz processor Jul 7 06:04:49.850994 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 7 06:04:49.851002 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 7 06:04:49.851009 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Jul 7 06:04:49.851017 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Jul 7 06:04:49.851024 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 7 06:04:49.851031 kernel: Using GB pages for direct mapping Jul 7 06:04:49.851038 kernel: ACPI: Early table checksum verification disabled Jul 7 06:04:49.851046 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Jul 7 06:04:49.851053 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851063 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851070 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851077 kernel: ACPI: FACS 0x000000009CFE0000 000040 Jul 7 06:04:49.851085 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851092 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851099 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851106 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 7 06:04:49.851113 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Jul 7 06:04:49.851126 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Jul 7 06:04:49.851133 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Jul 7 06:04:49.851141 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Jul 7 06:04:49.851148 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Jul 7 06:04:49.851156 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Jul 7 06:04:49.851163 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Jul 7 06:04:49.851181 kernel: No NUMA configuration found Jul 7 06:04:49.851189 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Jul 7 06:04:49.851196 kernel: NODE_DATA(0) allocated [mem 0x9cfd4dc0-0x9cfdbfff] Jul 7 06:04:49.851204 kernel: Zone ranges: Jul 7 06:04:49.851211 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 7 06:04:49.851219 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Jul 7 06:04:49.851226 kernel: Normal empty Jul 7 06:04:49.851233 kernel: Device empty Jul 7 06:04:49.851241 kernel: Movable zone start for each node Jul 7 06:04:49.851249 kernel: Early memory node ranges Jul 7 06:04:49.851258 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jul 7 06:04:49.851266 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Jul 7 06:04:49.851273 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Jul 7 06:04:49.851280 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 7 06:04:49.851288 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jul 7 06:04:49.851295 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Jul 7 06:04:49.851302 kernel: ACPI: PM-Timer IO Port: 0x608 Jul 7 06:04:49.851312 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jul 7 06:04:49.851320 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 7 06:04:49.851329 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jul 7 06:04:49.851337 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jul 7 06:04:49.851347 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 7 06:04:49.851355 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jul 7 06:04:49.851362 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jul 7 06:04:49.851369 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 7 06:04:49.851377 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jul 7 06:04:49.851384 kernel: TSC deadline timer available Jul 7 06:04:49.851391 kernel: CPU topo: Max. logical packages: 1 Jul 7 06:04:49.851401 kernel: CPU topo: Max. logical dies: 1 Jul 7 06:04:49.851408 kernel: CPU topo: Max. dies per package: 1 Jul 7 06:04:49.851416 kernel: CPU topo: Max. threads per core: 1 Jul 7 06:04:49.851423 kernel: CPU topo: Num. cores per package: 4 Jul 7 06:04:49.851430 kernel: CPU topo: Num. threads per package: 4 Jul 7 06:04:49.851438 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Jul 7 06:04:49.851445 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jul 7 06:04:49.851452 kernel: kvm-guest: KVM setup pv remote TLB flush Jul 7 06:04:49.851460 kernel: kvm-guest: setup PV sched yield Jul 7 06:04:49.851467 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Jul 7 06:04:49.851491 kernel: Booting paravirtualized kernel on KVM Jul 7 06:04:49.851499 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 7 06:04:49.851506 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jul 7 06:04:49.851514 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Jul 7 06:04:49.851521 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Jul 7 06:04:49.851528 kernel: pcpu-alloc: [0] 0 1 2 3 Jul 7 06:04:49.851536 kernel: kvm-guest: PV spinlocks enabled Jul 7 06:04:49.851543 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 7 06:04:49.851551 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=2e0b2c30526b1d273b6d599d4c30389a93a14ce36aaa5af83a05b11c5ea5ae50 Jul 7 06:04:49.851562 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 7 06:04:49.851570 kernel: random: crng init done Jul 7 06:04:49.851577 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 7 06:04:49.851584 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 7 06:04:49.851592 kernel: Fallback order for Node 0: 0 Jul 7 06:04:49.851599 kernel: Built 1 zonelists, mobility grouping on. Total pages: 642938 Jul 7 06:04:49.851607 kernel: Policy zone: DMA32 Jul 7 06:04:49.851614 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 7 06:04:49.851623 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 7 06:04:49.851631 kernel: ftrace: allocating 40095 entries in 157 pages Jul 7 06:04:49.851638 kernel: ftrace: allocated 157 pages with 5 groups Jul 7 06:04:49.851645 kernel: Dynamic Preempt: voluntary Jul 7 06:04:49.851653 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 7 06:04:49.851662 kernel: rcu: RCU event tracing is enabled. Jul 7 06:04:49.851672 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 7 06:04:49.851682 kernel: Trampoline variant of Tasks RCU enabled. Jul 7 06:04:49.851695 kernel: Rude variant of Tasks RCU enabled. Jul 7 06:04:49.851705 kernel: Tracing variant of Tasks RCU enabled. Jul 7 06:04:49.851713 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 7 06:04:49.851720 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 7 06:04:49.851727 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 7 06:04:49.851735 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 7 06:04:49.851742 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 7 06:04:49.851750 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jul 7 06:04:49.851758 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 7 06:04:49.851774 kernel: Console: colour VGA+ 80x25 Jul 7 06:04:49.851782 kernel: printk: legacy console [ttyS0] enabled Jul 7 06:04:49.851789 kernel: ACPI: Core revision 20240827 Jul 7 06:04:49.851797 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jul 7 06:04:49.851807 kernel: APIC: Switch to symmetric I/O mode setup Jul 7 06:04:49.851815 kernel: x2apic enabled Jul 7 06:04:49.851825 kernel: APIC: Switched APIC routing to: physical x2apic Jul 7 06:04:49.851832 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jul 7 06:04:49.851841 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jul 7 06:04:49.851851 kernel: kvm-guest: setup PV IPIs Jul 7 06:04:49.851859 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jul 7 06:04:49.851867 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns Jul 7 06:04:49.851875 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794746) Jul 7 06:04:49.851883 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jul 7 06:04:49.851890 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jul 7 06:04:49.851898 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jul 7 06:04:49.851906 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 7 06:04:49.851916 kernel: Spectre V2 : Mitigation: Retpolines Jul 7 06:04:49.851924 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 7 06:04:49.851932 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Jul 7 06:04:49.851939 kernel: RETBleed: Mitigation: untrained return thunk Jul 7 06:04:49.851947 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jul 7 06:04:49.851957 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jul 7 06:04:49.851965 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Jul 7 06:04:49.851975 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Jul 7 06:04:49.851992 kernel: x86/bugs: return thunk changed Jul 7 06:04:49.852006 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Jul 7 06:04:49.852014 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 7 06:04:49.852031 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 7 06:04:49.852047 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 7 06:04:49.852056 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 7 06:04:49.852064 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jul 7 06:04:49.852071 kernel: Freeing SMP alternatives memory: 32K Jul 7 06:04:49.852079 kernel: pid_max: default: 32768 minimum: 301 Jul 7 06:04:49.852090 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 7 06:04:49.852098 kernel: landlock: Up and running. Jul 7 06:04:49.852106 kernel: SELinux: Initializing. Jul 7 06:04:49.852117 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 7 06:04:49.852128 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 7 06:04:49.852136 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Jul 7 06:04:49.852144 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Jul 7 06:04:49.852152 kernel: ... version: 0 Jul 7 06:04:49.852159 kernel: ... bit width: 48 Jul 7 06:04:49.852178 kernel: ... generic registers: 6 Jul 7 06:04:49.852186 kernel: ... value mask: 0000ffffffffffff Jul 7 06:04:49.852193 kernel: ... max period: 00007fffffffffff Jul 7 06:04:49.852201 kernel: ... fixed-purpose events: 0 Jul 7 06:04:49.852209 kernel: ... event mask: 000000000000003f Jul 7 06:04:49.852216 kernel: signal: max sigframe size: 1776 Jul 7 06:04:49.852224 kernel: rcu: Hierarchical SRCU implementation. Jul 7 06:04:49.852232 kernel: rcu: Max phase no-delay instances is 400. Jul 7 06:04:49.852240 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 7 06:04:49.852247 kernel: smp: Bringing up secondary CPUs ... Jul 7 06:04:49.852258 kernel: smpboot: x86: Booting SMP configuration: Jul 7 06:04:49.852266 kernel: .... node #0, CPUs: #1 #2 #3 Jul 7 06:04:49.852273 kernel: smp: Brought up 1 node, 4 CPUs Jul 7 06:04:49.852281 kernel: smpboot: Total of 4 processors activated (22357.96 BogoMIPS) Jul 7 06:04:49.852289 kernel: Memory: 2428904K/2571752K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54432K init, 2536K bss, 136908K reserved, 0K cma-reserved) Jul 7 06:04:49.852297 kernel: devtmpfs: initialized Jul 7 06:04:49.852305 kernel: x86/mm: Memory block size: 128MB Jul 7 06:04:49.852312 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 7 06:04:49.852320 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 7 06:04:49.852330 kernel: pinctrl core: initialized pinctrl subsystem Jul 7 06:04:49.852338 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 7 06:04:49.852346 kernel: audit: initializing netlink subsys (disabled) Jul 7 06:04:49.852353 kernel: audit: type=2000 audit(1751868286.924:1): state=initialized audit_enabled=0 res=1 Jul 7 06:04:49.852361 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 7 06:04:49.852369 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 7 06:04:49.852376 kernel: cpuidle: using governor menu Jul 7 06:04:49.852384 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 7 06:04:49.852392 kernel: dca service started, version 1.12.1 Jul 7 06:04:49.852402 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Jul 7 06:04:49.852409 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Jul 7 06:04:49.852417 kernel: PCI: Using configuration type 1 for base access Jul 7 06:04:49.852425 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 7 06:04:49.852433 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 7 06:04:49.852440 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 7 06:04:49.852448 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 7 06:04:49.852456 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 7 06:04:49.852466 kernel: ACPI: Added _OSI(Module Device) Jul 7 06:04:49.852485 kernel: ACPI: Added _OSI(Processor Device) Jul 7 06:04:49.852493 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 7 06:04:49.852501 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 7 06:04:49.852508 kernel: ACPI: Interpreter enabled Jul 7 06:04:49.852516 kernel: ACPI: PM: (supports S0 S3 S5) Jul 7 06:04:49.852523 kernel: ACPI: Using IOAPIC for interrupt routing Jul 7 06:04:49.852531 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 7 06:04:49.852539 kernel: PCI: Using E820 reservations for host bridge windows Jul 7 06:04:49.852547 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jul 7 06:04:49.852557 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 7 06:04:49.852806 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 7 06:04:49.852961 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jul 7 06:04:49.853162 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jul 7 06:04:49.853186 kernel: PCI host bridge to bus 0000:00 Jul 7 06:04:49.853329 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jul 7 06:04:49.853460 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jul 7 06:04:49.853612 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jul 7 06:04:49.853732 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jul 7 06:04:49.853848 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jul 7 06:04:49.853964 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Jul 7 06:04:49.854081 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 7 06:04:49.854266 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Jul 7 06:04:49.854424 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Jul 7 06:04:49.854580 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Jul 7 06:04:49.854709 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Jul 7 06:04:49.854835 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Jul 7 06:04:49.854961 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jul 7 06:04:49.855116 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jul 7 06:04:49.855268 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Jul 7 06:04:49.855402 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Jul 7 06:04:49.855546 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Jul 7 06:04:49.855691 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Jul 7 06:04:49.855816 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Jul 7 06:04:49.855938 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Jul 7 06:04:49.856059 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Jul 7 06:04:49.856232 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Jul 7 06:04:49.856365 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Jul 7 06:04:49.856513 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Jul 7 06:04:49.856638 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Jul 7 06:04:49.856765 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Jul 7 06:04:49.856907 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Jul 7 06:04:49.857052 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jul 7 06:04:49.857224 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Jul 7 06:04:49.857356 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Jul 7 06:04:49.857506 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Jul 7 06:04:49.857654 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Jul 7 06:04:49.857783 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Jul 7 06:04:49.857795 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jul 7 06:04:49.857805 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jul 7 06:04:49.857818 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jul 7 06:04:49.857827 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jul 7 06:04:49.857837 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jul 7 06:04:49.857846 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jul 7 06:04:49.857855 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jul 7 06:04:49.857864 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jul 7 06:04:49.857873 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jul 7 06:04:49.857882 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jul 7 06:04:49.857891 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jul 7 06:04:49.857903 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jul 7 06:04:49.857912 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jul 7 06:04:49.857921 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jul 7 06:04:49.857930 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jul 7 06:04:49.857939 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jul 7 06:04:49.857948 kernel: iommu: Default domain type: Translated Jul 7 06:04:49.857957 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 7 06:04:49.857966 kernel: PCI: Using ACPI for IRQ routing Jul 7 06:04:49.857975 kernel: PCI: pci_cache_line_size set to 64 bytes Jul 7 06:04:49.857987 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jul 7 06:04:49.857997 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Jul 7 06:04:49.858128 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jul 7 06:04:49.858267 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jul 7 06:04:49.858394 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jul 7 06:04:49.858406 kernel: vgaarb: loaded Jul 7 06:04:49.858415 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jul 7 06:04:49.858424 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jul 7 06:04:49.858437 kernel: clocksource: Switched to clocksource kvm-clock Jul 7 06:04:49.858446 kernel: VFS: Disk quotas dquot_6.6.0 Jul 7 06:04:49.858455 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 7 06:04:49.858464 kernel: pnp: PnP ACPI init Jul 7 06:04:49.858661 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jul 7 06:04:49.858676 kernel: pnp: PnP ACPI: found 6 devices Jul 7 06:04:49.858686 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 7 06:04:49.858695 kernel: NET: Registered PF_INET protocol family Jul 7 06:04:49.858709 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 7 06:04:49.858718 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 7 06:04:49.858727 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 7 06:04:49.858736 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 7 06:04:49.858746 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 7 06:04:49.858755 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 7 06:04:49.858764 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 7 06:04:49.858773 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 7 06:04:49.858782 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 7 06:04:49.858793 kernel: NET: Registered PF_XDP protocol family Jul 7 06:04:49.858912 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jul 7 06:04:49.859030 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jul 7 06:04:49.859146 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jul 7 06:04:49.859276 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jul 7 06:04:49.859403 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jul 7 06:04:49.859539 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Jul 7 06:04:49.859552 kernel: PCI: CLS 0 bytes, default 64 Jul 7 06:04:49.859565 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns Jul 7 06:04:49.859574 kernel: Initialise system trusted keyrings Jul 7 06:04:49.859583 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 7 06:04:49.859592 kernel: Key type asymmetric registered Jul 7 06:04:49.859601 kernel: Asymmetric key parser 'x509' registered Jul 7 06:04:49.859610 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 7 06:04:49.859620 kernel: io scheduler mq-deadline registered Jul 7 06:04:49.859628 kernel: io scheduler kyber registered Jul 7 06:04:49.859638 kernel: io scheduler bfq registered Jul 7 06:04:49.859646 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 7 06:04:49.859658 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jul 7 06:04:49.859667 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jul 7 06:04:49.859676 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jul 7 06:04:49.859685 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 7 06:04:49.859695 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 7 06:04:49.859711 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jul 7 06:04:49.859720 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jul 7 06:04:49.859729 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jul 7 06:04:49.859884 kernel: rtc_cmos 00:04: RTC can wake from S4 Jul 7 06:04:49.860019 kernel: rtc_cmos 00:04: registered as rtc0 Jul 7 06:04:49.860144 kernel: rtc_cmos 00:04: setting system clock to 2025-07-07T06:04:49 UTC (1751868289) Jul 7 06:04:49.860292 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jul 7 06:04:49.860304 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jul 7 06:04:49.860312 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Jul 7 06:04:49.860320 kernel: NET: Registered PF_INET6 protocol family Jul 7 06:04:49.860328 kernel: Segment Routing with IPv6 Jul 7 06:04:49.860340 kernel: In-situ OAM (IOAM) with IPv6 Jul 7 06:04:49.860347 kernel: NET: Registered PF_PACKET protocol family Jul 7 06:04:49.860355 kernel: Key type dns_resolver registered Jul 7 06:04:49.860363 kernel: IPI shorthand broadcast: enabled Jul 7 06:04:49.860371 kernel: sched_clock: Marking stable (3088003782, 132271758)->(3273339598, -53064058) Jul 7 06:04:49.860379 kernel: registered taskstats version 1 Jul 7 06:04:49.860386 kernel: Loading compiled-in X.509 certificates Jul 7 06:04:49.860394 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.35-flatcar: b8e96f4c6a9e663230fc9c12b186cf91fcc7a64e' Jul 7 06:04:49.860402 kernel: Demotion targets for Node 0: null Jul 7 06:04:49.860412 kernel: Key type .fscrypt registered Jul 7 06:04:49.860420 kernel: Key type fscrypt-provisioning registered Jul 7 06:04:49.860428 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 7 06:04:49.860436 kernel: ima: Allocated hash algorithm: sha1 Jul 7 06:04:49.860444 kernel: ima: No architecture policies found Jul 7 06:04:49.860451 kernel: clk: Disabling unused clocks Jul 7 06:04:49.860459 kernel: Warning: unable to open an initial console. Jul 7 06:04:49.860467 kernel: Freeing unused kernel image (initmem) memory: 54432K Jul 7 06:04:49.860489 kernel: Write protecting the kernel read-only data: 24576k Jul 7 06:04:49.860500 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jul 7 06:04:49.860508 kernel: Run /init as init process Jul 7 06:04:49.860515 kernel: with arguments: Jul 7 06:04:49.860523 kernel: /init Jul 7 06:04:49.860530 kernel: with environment: Jul 7 06:04:49.860538 kernel: HOME=/ Jul 7 06:04:49.860545 kernel: TERM=linux Jul 7 06:04:49.860553 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 7 06:04:49.860562 systemd[1]: Successfully made /usr/ read-only. Jul 7 06:04:49.860575 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) Jul 7 06:04:49.860597 systemd[1]: Detected virtualization kvm. Jul 7 06:04:49.860605 systemd[1]: Detected architecture x86-64. Jul 7 06:04:49.860613 systemd[1]: Running in initrd. Jul 7 06:04:49.860622 systemd[1]: No hostname configured, using default hostname. Jul 7 06:04:49.860633 systemd[1]: Hostname set to . Jul 7 06:04:49.860641 systemd[1]: Initializing machine ID from VM UUID. Jul 7 06:04:49.860649 systemd[1]: Queued start job for default target initrd.target. Jul 7 06:04:49.860658 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 7 06:04:49.860666 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 7 06:04:49.860676 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 7 06:04:49.860685 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 7 06:04:49.860693 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 7 06:04:49.860705 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 7 06:04:49.860715 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 7 06:04:49.860723 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 7 06:04:49.860732 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 7 06:04:49.860740 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 7 06:04:49.860749 systemd[1]: Reached target paths.target - Path Units. Jul 7 06:04:49.860757 systemd[1]: Reached target slices.target - Slice Units. Jul 7 06:04:49.860768 systemd[1]: Reached target swap.target - Swaps. Jul 7 06:04:49.860776 systemd[1]: Reached target timers.target - Timer Units. Jul 7 06:04:49.860785 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 7 06:04:49.860793 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 7 06:04:49.860802 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 7 06:04:49.860810 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 7 06:04:49.860819 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 7 06:04:49.860827 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 7 06:04:49.860836 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 7 06:04:49.860846 systemd[1]: Reached target sockets.target - Socket Units. Jul 7 06:04:49.860855 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 7 06:04:49.860863 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 7 06:04:49.860872 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 7 06:04:49.860881 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). Jul 7 06:04:49.860894 systemd[1]: Starting systemd-fsck-usr.service... Jul 7 06:04:49.860902 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 7 06:04:49.860911 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 7 06:04:49.860919 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 7 06:04:49.860928 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 7 06:04:49.860937 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 7 06:04:49.860947 systemd[1]: Finished systemd-fsck-usr.service. Jul 7 06:04:49.860956 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 7 06:04:49.860987 systemd-journald[219]: Collecting audit messages is disabled. Jul 7 06:04:49.861012 systemd-journald[219]: Journal started Jul 7 06:04:49.861031 systemd-journald[219]: Runtime Journal (/run/log/journal/0f5989e7392e464fb985574f8d53574a) is 6M, max 48.6M, 42.5M free. Jul 7 06:04:49.850874 systemd-modules-load[221]: Inserted module 'overlay' Jul 7 06:04:49.895679 systemd[1]: Started systemd-journald.service - Journal Service. Jul 7 06:04:49.895712 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 7 06:04:49.895740 kernel: Bridge firewalling registered Jul 7 06:04:49.885434 systemd-modules-load[221]: Inserted module 'br_netfilter' Jul 7 06:04:49.896140 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 7 06:04:49.899446 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 7 06:04:49.901782 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 7 06:04:49.906022 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 7 06:04:49.908847 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 7 06:04:49.920290 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 7 06:04:49.921050 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 7 06:04:49.932143 systemd-tmpfiles[243]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 7 06:04:49.936533 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 7 06:04:49.938124 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 7 06:04:49.938530 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 7 06:04:49.942036 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 7 06:04:49.947581 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 7 06:04:49.950618 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 7 06:04:49.981339 dracut-cmdline[262]: 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=2e0b2c30526b1d273b6d599d4c30389a93a14ce36aaa5af83a05b11c5ea5ae50 Jul 7 06:04:49.999104 systemd-resolved[263]: Positive Trust Anchors: Jul 7 06:04:49.999115 systemd-resolved[263]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 7 06:04:49.999147 systemd-resolved[263]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 7 06:04:50.001665 systemd-resolved[263]: Defaulting to hostname 'linux'. Jul 7 06:04:50.002910 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 7 06:04:50.049369 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 7 06:04:50.172530 kernel: SCSI subsystem initialized Jul 7 06:04:50.184534 kernel: Loading iSCSI transport class v2.0-870. Jul 7 06:04:50.198595 kernel: iscsi: registered transport (tcp) Jul 7 06:04:50.225797 kernel: iscsi: registered transport (qla4xxx) Jul 7 06:04:50.225901 kernel: QLogic iSCSI HBA Driver Jul 7 06:04:50.249987 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 7 06:04:50.294815 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 7 06:04:50.301271 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 7 06:04:50.370554 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 7 06:04:50.374324 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 7 06:04:50.435533 kernel: raid6: avx2x4 gen() 29972 MB/s Jul 7 06:04:50.452553 kernel: raid6: avx2x2 gen() 30205 MB/s Jul 7 06:04:50.469559 kernel: raid6: avx2x1 gen() 25628 MB/s Jul 7 06:04:50.469597 kernel: raid6: using algorithm avx2x2 gen() 30205 MB/s Jul 7 06:04:50.487697 kernel: raid6: .... xor() 19624 MB/s, rmw enabled Jul 7 06:04:50.487791 kernel: raid6: using avx2x2 recovery algorithm Jul 7 06:04:50.526526 kernel: xor: automatically using best checksumming function avx Jul 7 06:04:50.694541 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 7 06:04:50.703312 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 7 06:04:50.706194 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 7 06:04:50.743039 systemd-udevd[472]: Using default interface naming scheme 'v255'. Jul 7 06:04:50.749533 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 7 06:04:50.751834 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 7 06:04:50.785999 dracut-pre-trigger[479]: rd.md=0: removing MD RAID activation Jul 7 06:04:50.820455 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 7 06:04:50.827752 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 7 06:04:50.920914 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 7 06:04:50.925188 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 7 06:04:50.967514 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jul 7 06:04:50.972120 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 7 06:04:50.976058 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 7 06:04:50.978443 kernel: cryptd: max_cpu_qlen set to 1000 Jul 7 06:04:50.978497 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Jul 7 06:04:50.993540 kernel: libata version 3.00 loaded. Jul 7 06:04:50.994511 kernel: AES CTR mode by8 optimization enabled Jul 7 06:04:51.008502 kernel: ahci 0000:00:1f.2: version 3.0 Jul 7 06:04:51.010489 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 7 06:04:51.024567 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jul 7 06:04:51.024596 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Jul 7 06:04:51.025025 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Jul 7 06:04:51.025197 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jul 7 06:04:51.025386 kernel: scsi host0: ahci Jul 7 06:04:51.011299 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 7 06:04:51.029700 kernel: scsi host1: ahci Jul 7 06:04:51.032181 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 7 06:04:51.033501 kernel: scsi host2: ahci Jul 7 06:04:51.036245 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 7 06:04:51.037705 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 7 06:04:51.043493 kernel: scsi host3: ahci Jul 7 06:04:51.043678 kernel: scsi host4: ahci Jul 7 06:04:51.047099 kernel: scsi host5: ahci Jul 7 06:04:51.047560 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 lpm-pol 0 Jul 7 06:04:51.047573 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 lpm-pol 0 Jul 7 06:04:51.049063 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 lpm-pol 0 Jul 7 06:04:51.049085 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 lpm-pol 0 Jul 7 06:04:51.049096 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 lpm-pol 0 Jul 7 06:04:51.049106 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 lpm-pol 0 Jul 7 06:04:51.067052 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 7 06:04:51.105538 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 7 06:04:51.116468 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 7 06:04:51.153291 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 7 06:04:51.161681 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 7 06:04:51.161769 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 7 06:04:51.165429 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 7 06:04:51.357527 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jul 7 06:04:51.357617 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jul 7 06:04:51.358685 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jul 7 06:04:51.359501 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 7 06:04:51.360503 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jul 7 06:04:51.360523 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jul 7 06:04:51.361514 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jul 7 06:04:51.362669 kernel: ata3.00: applying bridge limits Jul 7 06:04:51.362684 kernel: ata3.00: configured for UDMA/100 Jul 7 06:04:51.363513 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jul 7 06:04:51.454840 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jul 7 06:04:51.455156 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 7 06:04:51.455181 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 7 06:04:51.481512 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 7 06:04:51.565514 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 7 06:04:51.898670 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 7 06:04:51.902297 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 7 06:04:51.905136 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 7 06:04:51.907656 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 7 06:04:51.910908 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 7 06:04:51.944600 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 7 06:04:52.572420 disk-uuid[636]: The operation has completed successfully. Jul 7 06:04:52.573825 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 7 06:04:52.607294 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 7 06:04:52.607430 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 7 06:04:52.645007 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 7 06:04:52.670330 sh[664]: Success Jul 7 06:04:52.689203 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 7 06:04:52.689248 kernel: device-mapper: uevent: version 1.0.3 Jul 7 06:04:52.689272 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 7 06:04:52.699518 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 7 06:04:52.735229 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 7 06:04:52.737738 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 7 06:04:52.752637 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 7 06:04:52.760263 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 7 06:04:52.760296 kernel: BTRFS: device fsid 9d124217-7448-4fc6-a329-8a233bb5a0ac devid 1 transid 38 /dev/mapper/usr (253:0) scanned by mount (676) Jul 7 06:04:52.762572 kernel: BTRFS info (device dm-0): first mount of filesystem 9d124217-7448-4fc6-a329-8a233bb5a0ac Jul 7 06:04:52.762597 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 7 06:04:52.762611 kernel: BTRFS info (device dm-0): using free-space-tree Jul 7 06:04:52.768165 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 7 06:04:52.770625 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 7 06:04:52.773081 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 7 06:04:52.776071 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 7 06:04:52.779081 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 7 06:04:52.807335 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (707) Jul 7 06:04:52.807385 kernel: BTRFS info (device vda6): first mount of filesystem 847f3129-822b-493d-8278-974df083638f Jul 7 06:04:52.807396 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 7 06:04:52.808220 kernel: BTRFS info (device vda6): using free-space-tree Jul 7 06:04:52.815500 kernel: BTRFS info (device vda6): last unmount of filesystem 847f3129-822b-493d-8278-974df083638f Jul 7 06:04:52.816765 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 7 06:04:52.820827 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 7 06:04:52.962720 ignition[750]: Ignition 2.21.0 Jul 7 06:04:52.962739 ignition[750]: Stage: fetch-offline Jul 7 06:04:52.962794 ignition[750]: no configs at "/usr/lib/ignition/base.d" Jul 7 06:04:52.962807 ignition[750]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 7 06:04:52.962967 ignition[750]: parsed url from cmdline: "" Jul 7 06:04:52.962972 ignition[750]: no config URL provided Jul 7 06:04:52.962980 ignition[750]: reading system config file "/usr/lib/ignition/user.ign" Jul 7 06:04:52.962992 ignition[750]: no config at "/usr/lib/ignition/user.ign" Jul 7 06:04:52.963022 ignition[750]: op(1): [started] loading QEMU firmware config module Jul 7 06:04:52.963029 ignition[750]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 7 06:04:52.972975 ignition[750]: op(1): [finished] loading QEMU firmware config module Jul 7 06:04:52.975704 ignition[750]: parsing config with SHA512: 5dbb432998f4026a023f4699f2fef7f41f94086ca445ecd00f8bfb658b0d48b477b988aff88e541be6d40c2cdb5f1e3325879f0b89a7e14b5ad34d8358d18418 Jul 7 06:04:52.985615 unknown[750]: fetched base config from "system" Jul 7 06:04:52.985800 unknown[750]: fetched user config from "qemu" Jul 7 06:04:52.985952 ignition[750]: fetch-offline: fetch-offline passed Jul 7 06:04:52.986048 ignition[750]: Ignition finished successfully Jul 7 06:04:52.988065 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 7 06:04:52.990368 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 7 06:04:52.995245 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 7 06:04:53.052508 systemd-networkd[856]: lo: Link UP Jul 7 06:04:53.052519 systemd-networkd[856]: lo: Gained carrier Jul 7 06:04:53.054254 systemd-networkd[856]: Enumeration completed Jul 7 06:04:53.054370 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 7 06:04:53.054748 systemd-networkd[856]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 7 06:04:53.054753 systemd-networkd[856]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 7 06:04:53.056273 systemd[1]: Reached target network.target - Network. Jul 7 06:04:53.057150 systemd-networkd[856]: eth0: Link UP Jul 7 06:04:53.057154 systemd-networkd[856]: eth0: Gained carrier Jul 7 06:04:53.057164 systemd-networkd[856]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 7 06:04:53.058301 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 7 06:04:53.059166 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 7 06:04:53.080627 systemd-networkd[856]: eth0: DHCPv4 address 10.0.0.66/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 7 06:04:53.133391 ignition[859]: Ignition 2.21.0 Jul 7 06:04:53.133408 ignition[859]: Stage: kargs Jul 7 06:04:53.133612 ignition[859]: no configs at "/usr/lib/ignition/base.d" Jul 7 06:04:53.133624 ignition[859]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 7 06:04:53.134738 ignition[859]: kargs: kargs passed Jul 7 06:04:53.134979 ignition[859]: Ignition finished successfully Jul 7 06:04:53.140810 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 7 06:04:53.143873 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 7 06:04:53.171950 ignition[868]: Ignition 2.21.0 Jul 7 06:04:53.171965 ignition[868]: Stage: disks Jul 7 06:04:53.172326 ignition[868]: no configs at "/usr/lib/ignition/base.d" Jul 7 06:04:53.172340 ignition[868]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 7 06:04:53.178882 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 7 06:04:53.175440 ignition[868]: disks: disks passed Jul 7 06:04:53.180225 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 7 06:04:53.175590 ignition[868]: Ignition finished successfully Jul 7 06:04:53.182367 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 7 06:04:53.182612 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 7 06:04:53.182959 systemd[1]: Reached target sysinit.target - System Initialization. Jul 7 06:04:53.183320 systemd[1]: Reached target basic.target - Basic System. Jul 7 06:04:53.184952 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 7 06:04:53.219970 systemd-fsck[878]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 7 06:04:53.517332 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 7 06:04:53.518888 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 7 06:04:53.654501 kernel: EXT4-fs (vda9): mounted filesystem df0fa228-af1b-4496-9a54-2d4ccccd27d9 r/w with ordered data mode. Quota mode: none. Jul 7 06:04:53.655081 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 7 06:04:53.655928 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 7 06:04:53.659498 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 7 06:04:53.661694 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 7 06:04:53.662128 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 7 06:04:53.662188 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 7 06:04:53.662217 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 7 06:04:53.682810 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 7 06:04:53.684669 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 7 06:04:53.687628 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (887) Jul 7 06:04:53.690503 kernel: BTRFS info (device vda6): first mount of filesystem 847f3129-822b-493d-8278-974df083638f Jul 7 06:04:53.690531 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 7 06:04:53.691689 kernel: BTRFS info (device vda6): using free-space-tree Jul 7 06:04:53.696832 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 7 06:04:53.734515 initrd-setup-root[912]: cut: /sysroot/etc/passwd: No such file or directory Jul 7 06:04:53.742890 initrd-setup-root[919]: cut: /sysroot/etc/group: No such file or directory Jul 7 06:04:53.747827 initrd-setup-root[926]: cut: /sysroot/etc/shadow: No such file or directory Jul 7 06:04:53.753071 initrd-setup-root[933]: cut: /sysroot/etc/gshadow: No such file or directory Jul 7 06:04:53.855518 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 7 06:04:53.858245 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 7 06:04:53.860045 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 7 06:04:53.886372 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 7 06:04:53.888017 kernel: BTRFS info (device vda6): last unmount of filesystem 847f3129-822b-493d-8278-974df083638f Jul 7 06:04:53.905796 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 7 06:04:53.927556 ignition[1002]: INFO : Ignition 2.21.0 Jul 7 06:04:53.927556 ignition[1002]: INFO : Stage: mount Jul 7 06:04:53.929603 ignition[1002]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 7 06:04:53.929603 ignition[1002]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 7 06:04:53.929603 ignition[1002]: INFO : mount: mount passed Jul 7 06:04:53.929603 ignition[1002]: INFO : Ignition finished successfully Jul 7 06:04:53.932529 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 7 06:04:53.935127 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 7 06:04:53.965255 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 7 06:04:53.994513 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1014) Jul 7 06:04:53.996959 kernel: BTRFS info (device vda6): first mount of filesystem 847f3129-822b-493d-8278-974df083638f Jul 7 06:04:53.996985 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 7 06:04:53.996997 kernel: BTRFS info (device vda6): using free-space-tree Jul 7 06:04:54.001737 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 7 06:04:54.038076 ignition[1031]: INFO : Ignition 2.21.0 Jul 7 06:04:54.038076 ignition[1031]: INFO : Stage: files Jul 7 06:04:54.040436 ignition[1031]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 7 06:04:54.040436 ignition[1031]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 7 06:04:54.040436 ignition[1031]: DEBUG : files: compiled without relabeling support, skipping Jul 7 06:04:54.040436 ignition[1031]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 7 06:04:54.040436 ignition[1031]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 7 06:04:54.047585 ignition[1031]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 7 06:04:54.047585 ignition[1031]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 7 06:04:54.047585 ignition[1031]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 7 06:04:54.044355 unknown[1031]: wrote ssh authorized keys file for user: core Jul 7 06:04:54.053685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 7 06:04:54.053685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 7 06:04:54.053685 ignition[1031]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jul 7 06:04:54.053685 ignition[1031]: 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" Jul 7 06:04:54.062644 ignition[1031]: 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" Jul 7 06:04:54.062644 ignition[1031]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jul 7 06:04:54.062644 ignition[1031]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jul 7 06:04:54.062644 ignition[1031]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 7 06:04:54.062644 ignition[1031]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 7 06:04:54.062644 ignition[1031]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jul 7 06:04:54.062644 ignition[1031]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Jul 7 06:04:54.083911 ignition[1031]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 7 06:04:54.091702 ignition[1031]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 7 06:04:54.093409 ignition[1031]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Jul 7 06:04:54.093409 ignition[1031]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Jul 7 06:04:54.093409 ignition[1031]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Jul 7 06:04:54.093409 ignition[1031]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 7 06:04:54.093409 ignition[1031]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 7 06:04:54.093409 ignition[1031]: INFO : files: files passed Jul 7 06:04:54.093409 ignition[1031]: INFO : Ignition finished successfully Jul 7 06:04:54.106198 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 7 06:04:54.108361 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 7 06:04:54.110447 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 7 06:04:54.140383 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 7 06:04:54.140540 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 7 06:04:54.144742 initrd-setup-root-after-ignition[1060]: grep: /sysroot/oem/oem-release: No such file or directory Jul 7 06:04:54.147795 initrd-setup-root-after-ignition[1063]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 7 06:04:54.147795 initrd-setup-root-after-ignition[1063]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 7 06:04:54.152803 initrd-setup-root-after-ignition[1067]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 7 06:04:54.150963 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 7 06:04:54.152949 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 7 06:04:54.156448 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 7 06:04:54.209433 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 7 06:04:54.209629 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 7 06:04:54.212202 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 7 06:04:54.214489 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 7 06:04:54.216448 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 7 06:04:54.217436 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 7 06:04:54.235460 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 7 06:04:54.238183 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 7 06:04:54.263747 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 7 06:04:54.265262 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 7 06:04:54.267486 systemd[1]: Stopped target timers.target - Timer Units. Jul 7 06:04:54.268592 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 7 06:04:54.268735 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 7 06:04:54.269366 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 7 06:04:54.269839 systemd[1]: Stopped target basic.target - Basic System. Jul 7 06:04:54.270152 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 7 06:04:54.270493 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 7 06:04:54.270951 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 7 06:04:54.271281 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 7 06:04:54.271765 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 7 06:04:54.272080 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 7 06:04:54.272412 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 7 06:04:54.289222 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 7 06:04:54.289528 systemd[1]: Stopped target swap.target - Swaps. Jul 7 06:04:54.289978 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 7 06:04:54.290112 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 7 06:04:54.295496 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 7 06:04:54.296510 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 7 06:04:54.296935 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 7 06:04:54.297092 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 7 06:04:54.301747 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 7 06:04:54.301856 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 7 06:04:54.302468 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 7 06:04:54.302594 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 7 06:04:54.303028 systemd[1]: Stopped target paths.target - Path Units. Jul 7 06:04:54.303350 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 7 06:04:54.303576 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 7 06:04:54.309635 systemd[1]: Stopped target slices.target - Slice Units. Jul 7 06:04:54.310019 systemd[1]: Stopped target sockets.target - Socket Units. Jul 7 06:04:54.310389 systemd[1]: iscsid.socket: Deactivated successfully. Jul 7 06:04:54.310523 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 7 06:04:54.315865 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 7 06:04:54.315955 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 7 06:04:54.317563 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 7 06:04:54.317692 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 7 06:04:54.318000 systemd[1]: ignition-files.service: Deactivated successfully. Jul 7 06:04:54.318114 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 7 06:04:54.322871 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 7 06:04:54.326269 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 7 06:04:54.327302 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 7 06:04:54.327507 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 7 06:04:54.329452 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 7 06:04:54.329625 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 7 06:04:54.336080 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 7 06:04:54.337599 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 7 06:04:54.356827 ignition[1087]: INFO : Ignition 2.21.0 Jul 7 06:04:54.358589 ignition[1087]: INFO : Stage: umount Jul 7 06:04:54.358589 ignition[1087]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 7 06:04:54.358589 ignition[1087]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 7 06:04:54.361906 ignition[1087]: INFO : umount: umount passed Jul 7 06:04:54.361906 ignition[1087]: INFO : Ignition finished successfully Jul 7 06:04:54.362704 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 7 06:04:54.362885 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 7 06:04:54.364982 systemd[1]: Stopped target network.target - Network. Jul 7 06:04:54.366060 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 7 06:04:54.366143 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 7 06:04:54.367111 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 7 06:04:54.367162 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 7 06:04:54.367787 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 7 06:04:54.367842 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 7 06:04:54.368116 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 7 06:04:54.368167 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 7 06:04:54.368633 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 7 06:04:54.369018 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 7 06:04:54.379338 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 7 06:04:54.379504 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 7 06:04:54.384336 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 7 06:04:54.384498 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 7 06:04:54.386689 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 7 06:04:54.386783 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 7 06:04:54.388198 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 7 06:04:54.388255 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 7 06:04:54.392622 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 7 06:04:54.392767 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 7 06:04:54.395401 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 7 06:04:54.396286 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 7 06:04:54.396333 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 7 06:04:54.401875 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 7 06:04:54.403891 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 7 06:04:54.403950 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 7 06:04:54.404229 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 7 06:04:54.404275 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 7 06:04:54.409465 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 7 06:04:54.409532 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 7 06:04:54.412757 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 7 06:04:54.441524 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 7 06:04:54.442726 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 7 06:04:54.444386 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 7 06:04:54.444438 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 7 06:04:54.445409 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 7 06:04:54.445448 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 7 06:04:54.445911 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 7 06:04:54.445966 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 7 06:04:54.446694 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 7 06:04:54.446741 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 7 06:04:54.447358 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 7 06:04:54.447405 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 7 06:04:54.449191 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 7 06:04:54.457731 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 7 06:04:54.457792 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 7 06:04:54.463963 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 7 06:04:54.464047 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 7 06:04:54.466691 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 7 06:04:54.466743 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 7 06:04:54.469767 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 7 06:04:54.469817 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 7 06:04:54.470815 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 7 06:04:54.470871 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 7 06:04:54.476091 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 7 06:04:54.476232 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 7 06:04:54.479547 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 7 06:04:54.479715 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 7 06:04:54.482194 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 7 06:04:54.485132 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 7 06:04:54.518671 systemd[1]: Switching root. Jul 7 06:04:54.563719 systemd-journald[219]: Journal stopped Jul 7 06:04:55.735414 systemd-journald[219]: Received SIGTERM from PID 1 (systemd). Jul 7 06:04:55.735566 kernel: SELinux: policy capability network_peer_controls=1 Jul 7 06:04:55.735599 kernel: SELinux: policy capability open_perms=1 Jul 7 06:04:55.735613 kernel: SELinux: policy capability extended_socket_class=1 Jul 7 06:04:55.735632 kernel: SELinux: policy capability always_check_network=0 Jul 7 06:04:55.735645 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 7 06:04:55.735659 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 7 06:04:55.735672 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 7 06:04:55.735692 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 7 06:04:55.735708 kernel: SELinux: policy capability userspace_initial_context=0 Jul 7 06:04:55.735722 kernel: audit: type=1403 audit(1751868294.664:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 7 06:04:55.735737 systemd[1]: Successfully loaded SELinux policy in 50.242ms. Jul 7 06:04:55.735768 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 13.074ms. Jul 7 06:04:55.735784 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) Jul 7 06:04:55.735799 systemd[1]: Detected virtualization kvm. Jul 7 06:04:55.735814 systemd[1]: Detected architecture x86-64. Jul 7 06:04:55.735828 systemd[1]: Detected first boot. Jul 7 06:04:55.735842 systemd[1]: Initializing machine ID from VM UUID. Jul 7 06:04:55.735859 zram_generator::config[1132]: No configuration found. Jul 7 06:04:55.735875 kernel: Guest personality initialized and is inactive Jul 7 06:04:55.735888 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Jul 7 06:04:55.735902 kernel: Initialized host personality Jul 7 06:04:55.735916 kernel: NET: Registered PF_VSOCK protocol family Jul 7 06:04:55.735930 systemd[1]: Populated /etc with preset unit settings. Jul 7 06:04:55.735945 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 7 06:04:55.735959 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 7 06:04:55.735976 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 7 06:04:55.735993 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 7 06:04:55.736017 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 7 06:04:55.736032 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 7 06:04:55.736046 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 7 06:04:55.736061 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 7 06:04:55.736078 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 7 06:04:55.736093 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 7 06:04:55.736113 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 7 06:04:55.736127 systemd[1]: Created slice user.slice - User and Session Slice. Jul 7 06:04:55.736142 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 7 06:04:55.736156 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 7 06:04:55.736173 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 7 06:04:55.736187 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 7 06:04:55.736205 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 7 06:04:55.736220 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 7 06:04:55.736235 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 7 06:04:55.736250 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 7 06:04:55.736265 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 7 06:04:55.736279 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 7 06:04:55.736294 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 7 06:04:55.736308 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 7 06:04:55.736325 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 7 06:04:55.736340 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 7 06:04:55.736354 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 7 06:04:55.736369 systemd[1]: Reached target slices.target - Slice Units. Jul 7 06:04:55.736389 systemd[1]: Reached target swap.target - Swaps. Jul 7 06:04:55.736407 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 7 06:04:55.736421 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 7 06:04:55.736436 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 7 06:04:55.736450 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 7 06:04:55.736467 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 7 06:04:55.736499 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 7 06:04:55.736513 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 7 06:04:55.736551 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 7 06:04:55.736567 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 7 06:04:55.736581 systemd[1]: Mounting media.mount - External Media Directory... Jul 7 06:04:55.736596 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:55.736610 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 7 06:04:55.736624 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 7 06:04:55.736643 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 7 06:04:55.736658 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). Jul 7 06:04:55.736673 systemd[1]: Reached target machines.target - Containers. Jul 7 06:04:55.736688 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 7 06:04:55.736703 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 7 06:04:55.736717 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 7 06:04:55.736732 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 7 06:04:55.736747 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 7 06:04:55.736762 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 7 06:04:55.736779 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 7 06:04:55.736794 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 7 06:04:55.736809 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 7 06:04:55.736824 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 7 06:04:55.736838 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 7 06:04:55.736853 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 7 06:04:55.736868 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 7 06:04:55.736883 systemd[1]: Stopped systemd-fsck-usr.service. Jul 7 06:04:55.736901 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). Jul 7 06:04:55.736916 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 7 06:04:55.736931 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 7 06:04:55.736945 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 7 06:04:55.736959 kernel: fuse: init (API version 7.41) Jul 7 06:04:55.736973 kernel: loop: module loaded Jul 7 06:04:55.736987 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 7 06:04:55.737015 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 7 06:04:55.737030 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 7 06:04:55.737049 systemd[1]: verity-setup.service: Deactivated successfully. Jul 7 06:04:55.737064 systemd[1]: Stopped verity-setup.service. Jul 7 06:04:55.737080 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:55.737094 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 7 06:04:55.737108 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 7 06:04:55.737125 systemd[1]: Mounted media.mount - External Media Directory. Jul 7 06:04:55.737140 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 7 06:04:55.737154 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 7 06:04:55.737168 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 7 06:04:55.737183 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 7 06:04:55.737197 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 7 06:04:55.737212 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 7 06:04:55.737229 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 7 06:04:55.737243 kernel: ACPI: bus type drm_connector registered Jul 7 06:04:55.737287 systemd-journald[1207]: Collecting audit messages is disabled. Jul 7 06:04:55.737318 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 7 06:04:55.737333 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 7 06:04:55.737351 systemd-journald[1207]: Journal started Jul 7 06:04:55.737380 systemd-journald[1207]: Runtime Journal (/run/log/journal/0f5989e7392e464fb985574f8d53574a) is 6M, max 48.6M, 42.5M free. Jul 7 06:04:55.329038 systemd[1]: Queued start job for default target multi-user.target. Jul 7 06:04:55.739949 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 7 06:04:55.740042 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 7 06:04:55.352955 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 7 06:04:55.353513 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 7 06:04:55.742596 systemd[1]: Started systemd-journald.service - Journal Service. Jul 7 06:04:55.744254 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 7 06:04:55.744682 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 7 06:04:55.746233 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 7 06:04:55.746509 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 7 06:04:55.747937 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 7 06:04:55.748225 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 7 06:04:55.749778 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 7 06:04:55.751244 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 7 06:04:55.752960 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 7 06:04:55.754814 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 7 06:04:55.777017 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 7 06:04:55.780548 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 7 06:04:55.785567 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 7 06:04:55.786920 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 7 06:04:55.786958 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 7 06:04:55.789600 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 7 06:04:55.794603 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 7 06:04:55.796217 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 7 06:04:55.798641 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 7 06:04:55.802884 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 7 06:04:55.804604 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 7 06:04:55.806976 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 7 06:04:55.808442 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 7 06:04:55.811019 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 7 06:04:55.819615 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 7 06:04:55.827302 systemd-journald[1207]: Time spent on flushing to /var/log/journal/0f5989e7392e464fb985574f8d53574a is 28.483ms for 943 entries. Jul 7 06:04:55.827302 systemd-journald[1207]: System Journal (/var/log/journal/0f5989e7392e464fb985574f8d53574a) is 8M, max 195.6M, 187.6M free. Jul 7 06:04:55.868948 systemd-journald[1207]: Received client request to flush runtime journal. Jul 7 06:04:55.823360 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 7 06:04:55.828698 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 7 06:04:55.830366 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 7 06:04:55.837414 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 7 06:04:55.840575 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 7 06:04:55.849077 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 7 06:04:55.852038 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 7 06:04:55.870863 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 7 06:04:55.892458 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 7 06:04:55.907529 kernel: loop0: detected capacity change from 0 to 146240 Jul 7 06:04:55.917509 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 7 06:04:55.923889 systemd-tmpfiles[1252]: ACLs are not supported, ignoring. Jul 7 06:04:55.923909 systemd-tmpfiles[1252]: ACLs are not supported, ignoring. Jul 7 06:04:55.931305 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 7 06:04:55.936557 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 7 06:04:55.939499 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 7 06:04:55.963840 kernel: loop1: detected capacity change from 0 to 113872 Jul 7 06:04:56.009770 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 7 06:04:56.012511 kernel: loop2: detected capacity change from 0 to 146240 Jul 7 06:04:56.013929 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 7 06:04:56.029601 kernel: loop3: detected capacity change from 0 to 113872 Jul 7 06:04:56.043314 systemd-tmpfiles[1273]: ACLs are not supported, ignoring. Jul 7 06:04:56.043336 systemd-tmpfiles[1273]: ACLs are not supported, ignoring. Jul 7 06:04:56.045793 (sd-merge)[1272]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jul 7 06:04:56.047833 (sd-merge)[1272]: Merged extensions into '/usr'. Jul 7 06:04:56.049987 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 7 06:04:56.053008 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 7 06:04:56.058152 systemd[1]: Starting ensure-sysext.service... Jul 7 06:04:56.061668 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 7 06:04:56.085374 systemd[1]: Reload requested from client PID 1277 ('systemctl') (unit ensure-sysext.service)... Jul 7 06:04:56.085577 systemd[1]: Reloading... Jul 7 06:04:56.135642 systemd-tmpfiles[1278]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 7 06:04:56.135688 systemd-tmpfiles[1278]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 7 06:04:56.136026 systemd-tmpfiles[1278]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 7 06:04:56.136286 systemd-tmpfiles[1278]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 7 06:04:56.137714 systemd-tmpfiles[1278]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 7 06:04:56.138101 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. Jul 7 06:04:56.138238 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. Jul 7 06:04:56.166623 systemd-tmpfiles[1278]: Detected autofs mount point /boot during canonicalization of boot. Jul 7 06:04:56.166642 systemd-tmpfiles[1278]: Skipping /boot Jul 7 06:04:56.191541 zram_generator::config[1304]: No configuration found. Jul 7 06:04:56.193513 systemd-tmpfiles[1278]: Detected autofs mount point /boot during canonicalization of boot. Jul 7 06:04:56.193538 systemd-tmpfiles[1278]: Skipping /boot Jul 7 06:04:56.348993 ldconfig[1246]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 7 06:04:56.363061 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 7 06:04:56.465096 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 7 06:04:56.465788 systemd[1]: Reloading finished in 379 ms. Jul 7 06:04:56.503718 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 7 06:04:56.532266 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 7 06:04:56.545142 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 7 06:04:56.549123 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 7 06:04:56.559202 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 7 06:04:56.563626 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 7 06:04:56.567648 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 7 06:04:56.573120 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:56.574721 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 7 06:04:56.577698 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 7 06:04:56.583363 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 7 06:04:56.590887 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 7 06:04:56.592174 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 7 06:04:56.592310 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). Jul 7 06:04:56.613145 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 7 06:04:56.614607 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:56.617618 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 7 06:04:56.625884 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:56.626757 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 7 06:04:56.627605 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 7 06:04:56.627762 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). Jul 7 06:04:56.627910 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:56.634101 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:56.635028 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 7 06:04:56.639346 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 7 06:04:56.641027 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 7 06:04:56.641181 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). Jul 7 06:04:56.641400 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 7 06:04:56.648466 systemd[1]: Finished ensure-sysext.service. Jul 7 06:04:56.653924 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 7 06:04:56.655702 augenrules[1376]: No rules Jul 7 06:04:56.658753 systemd[1]: audit-rules.service: Deactivated successfully. Jul 7 06:04:56.659216 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 7 06:04:56.663138 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 7 06:04:56.663634 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 7 06:04:56.665416 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 7 06:04:56.665749 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 7 06:04:56.667626 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 7 06:04:56.667886 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 7 06:04:56.669840 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 7 06:04:56.670174 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 7 06:04:56.676815 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 7 06:04:56.676926 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 7 06:04:56.684642 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 7 06:04:56.696753 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 7 06:04:56.698623 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). Jul 7 06:04:56.721737 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 7 06:04:56.726214 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 7 06:04:56.736243 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 7 06:04:56.740543 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 7 06:04:56.760127 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 7 06:04:56.808065 systemd-udevd[1396]: Using default interface naming scheme 'v255'. Jul 7 06:04:56.833569 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 7 06:04:56.839392 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 7 06:04:56.842094 systemd-resolved[1349]: Positive Trust Anchors: Jul 7 06:04:56.842118 systemd-resolved[1349]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 7 06:04:56.842156 systemd-resolved[1349]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 7 06:04:56.851873 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 7 06:04:56.853803 systemd[1]: Reached target time-set.target - System Time Set. Jul 7 06:04:56.855597 systemd-resolved[1349]: Defaulting to hostname 'linux'. Jul 7 06:04:56.858117 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 7 06:04:56.859525 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 7 06:04:56.860943 systemd[1]: Reached target sysinit.target - System Initialization. Jul 7 06:04:56.862922 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 7 06:04:56.864448 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 7 06:04:56.866548 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jul 7 06:04:56.868120 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 7 06:04:56.869586 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 7 06:04:56.871171 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 7 06:04:56.872978 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 7 06:04:56.873026 systemd[1]: Reached target paths.target - Path Units. Jul 7 06:04:56.875062 systemd[1]: Reached target timers.target - Timer Units. Jul 7 06:04:56.879174 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 7 06:04:56.885015 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 7 06:04:56.890858 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 7 06:04:56.892502 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 7 06:04:56.893758 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 7 06:04:56.902097 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 7 06:04:56.903825 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 7 06:04:56.911018 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 7 06:04:56.917120 systemd[1]: Reached target sockets.target - Socket Units. Jul 7 06:04:56.918622 systemd[1]: Reached target basic.target - Basic System. Jul 7 06:04:56.919858 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 7 06:04:56.919886 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 7 06:04:56.921316 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 7 06:04:56.925614 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 7 06:04:56.928707 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 7 06:04:56.941373 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 7 06:04:56.942735 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). Jul 7 06:04:56.948787 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jul 7 06:04:56.951058 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 7 06:04:56.957035 jq[1434]: false Jul 7 06:04:56.957386 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 7 06:04:56.964193 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 7 06:04:56.970796 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 7 06:04:56.973307 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 7 06:04:56.974118 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 7 06:04:56.975452 systemd[1]: Starting update-engine.service - Update Engine... Jul 7 06:04:56.981197 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 7 06:04:56.995609 oslogin_cache_refresh[1436]: Refreshing passwd entry cache Jul 7 06:04:57.016050 google_oslogin_nss_cache[1436]: oslogin_cache_refresh[1436]: Refreshing passwd entry cache Jul 7 06:04:56.983628 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 7 06:04:56.985723 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 7 06:04:56.985982 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 7 06:04:57.019514 google_oslogin_nss_cache[1436]: oslogin_cache_refresh[1436]: Failure getting users, quitting Jul 7 06:04:57.019514 google_oslogin_nss_cache[1436]: oslogin_cache_refresh[1436]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 7 06:04:57.019514 google_oslogin_nss_cache[1436]: oslogin_cache_refresh[1436]: Refreshing group entry cache Jul 7 06:04:57.019514 google_oslogin_nss_cache[1436]: oslogin_cache_refresh[1436]: Failure getting groups, quitting Jul 7 06:04:57.019514 google_oslogin_nss_cache[1436]: oslogin_cache_refresh[1436]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 7 06:04:57.016881 oslogin_cache_refresh[1436]: Failure getting users, quitting Jul 7 06:04:57.016902 oslogin_cache_refresh[1436]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 7 06:04:57.016960 oslogin_cache_refresh[1436]: Refreshing group entry cache Jul 7 06:04:57.017491 oslogin_cache_refresh[1436]: Failure getting groups, quitting Jul 7 06:04:57.017503 oslogin_cache_refresh[1436]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 7 06:04:57.020445 extend-filesystems[1435]: Found /dev/vda6 Jul 7 06:04:57.023154 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jul 7 06:04:57.026066 jq[1446]: true Jul 7 06:04:57.024605 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jul 7 06:04:57.026425 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 7 06:04:57.027787 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 7 06:04:57.046909 extend-filesystems[1435]: Found /dev/vda9 Jul 7 06:04:57.046909 extend-filesystems[1435]: Checking size of /dev/vda9 Jul 7 06:04:57.027839 systemd-networkd[1404]: lo: Link UP Jul 7 06:04:57.027846 systemd-networkd[1404]: lo: Gained carrier Jul 7 06:04:57.051209 jq[1453]: true Jul 7 06:04:57.031000 systemd-networkd[1404]: Enumeration completed Jul 7 06:04:57.032105 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 7 06:04:57.044273 systemd[1]: Reached target network.target - Network. Jul 7 06:04:57.047738 systemd[1]: Starting containerd.service - containerd container runtime... Jul 7 06:04:57.052775 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 7 06:04:57.067029 extend-filesystems[1435]: Old size kept for /dev/vda9 Jul 7 06:04:57.069765 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 7 06:04:57.074338 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 7 06:04:57.075562 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 7 06:04:57.077461 systemd[1]: motdgen.service: Deactivated successfully. Jul 7 06:04:57.078210 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 7 06:04:57.103930 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 7 06:04:57.103743 dbus-daemon[1432]: [system] SELinux support is enabled Jul 7 06:04:57.118208 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 7 06:04:57.118407 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). Jul 7 06:04:57.118427 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 7 06:04:57.119890 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). Jul 7 06:04:57.119917 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 7 06:04:57.121550 update_engine[1443]: I20250707 06:04:57.121400 1443 main.cc:92] Flatcar Update Engine starting Jul 7 06:04:57.132186 update_engine[1443]: I20250707 06:04:57.132025 1443 update_check_scheduler.cc:74] Next update check in 9m49s Jul 7 06:04:57.132709 systemd[1]: Started update-engine.service - Update Engine. Jul 7 06:04:57.137394 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 7 06:04:57.142540 (ntainerd)[1483]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 7 06:04:57.155505 systemd-networkd[1404]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 7 06:04:57.155520 systemd-networkd[1404]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 7 06:04:57.158074 systemd-networkd[1404]: eth0: Link UP Jul 7 06:04:57.158293 systemd-networkd[1404]: eth0: Gained carrier Jul 7 06:04:57.158316 systemd-networkd[1404]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 7 06:04:57.172611 systemd-networkd[1404]: eth0: DHCPv4 address 10.0.0.66/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 7 06:04:57.174020 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Jul 7 06:04:57.750030 systemd-timesyncd[1378]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 7 06:04:57.751189 systemd-resolved[1349]: Clock change detected. Flushing caches. Jul 7 06:04:57.752540 systemd-timesyncd[1378]: Initial clock synchronization to Mon 2025-07-07 06:04:57.749844 UTC. Jul 7 06:04:57.768204 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 7 06:04:57.795232 systemd-logind[1441]: New seat seat0. Jul 7 06:04:57.803941 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Jul 7 06:04:57.802256 systemd[1]: Started systemd-logind.service - User Login Management. Jul 7 06:04:57.823906 kernel: mousedev: PS/2 mouse device common for all mice Jul 7 06:04:57.829898 kernel: ACPI: button: Power Button [PWRF] Jul 7 06:04:57.831254 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 7 06:04:57.835420 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 7 06:04:57.932459 bash[1500]: Updated "/home/core/.ssh/authorized_keys" Jul 7 06:04:57.935454 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 7 06:04:57.939262 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 7 06:04:57.939988 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 7 06:04:57.952343 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jul 7 06:04:57.952838 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jul 7 06:04:57.969155 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 7 06:04:57.996626 systemd-logind[1441]: Watching system buttons on /dev/input/event2 (Power Button) Jul 7 06:04:57.998225 systemd-logind[1441]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jul 7 06:04:58.052034 locksmithd[1484]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 7 06:04:58.115029 sshd_keygen[1468]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 7 06:04:58.152102 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 7 06:04:58.152248 kernel: kvm_amd: TSC scaling supported Jul 7 06:04:58.152283 kernel: kvm_amd: Nested Virtualization enabled Jul 7 06:04:58.152302 kernel: kvm_amd: Nested Paging enabled Jul 7 06:04:58.152319 kernel: kvm_amd: LBR virtualization supported Jul 7 06:04:58.153109 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Jul 7 06:04:58.153211 kernel: kvm_amd: Virtual GIF supported Jul 7 06:04:58.161553 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 7 06:04:58.190656 systemd[1]: issuegen.service: Deactivated successfully. Jul 7 06:04:58.191073 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 7 06:04:58.196299 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 7 06:04:58.202922 kernel: EDAC MC: Ver: 3.0.0 Jul 7 06:04:58.224642 containerd[1483]: time="2025-07-07T06:04:58Z" 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 Jul 7 06:04:58.227595 containerd[1483]: time="2025-07-07T06:04:58.227533934Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241238034Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.973µs" Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241286805Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241310059Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241576018Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241593040Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241620872Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241693759Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.241704960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.242050308Z" 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 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.242064745Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.242075395Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242430 containerd[1483]: time="2025-07-07T06:04:58.242085153Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242861 containerd[1483]: time="2025-07-07T06:04:58.242201611Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242861 containerd[1483]: time="2025-07-07T06:04:58.242475335Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 7 06:04:58.242861 containerd[1483]: time="2025-07-07T06:04:58.242508708Z" 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 Jul 7 06:04:58.242861 containerd[1483]: time="2025-07-07T06:04:58.242521972Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 7 06:04:58.242861 containerd[1483]: time="2025-07-07T06:04:58.242568981Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 7 06:04:58.242861 containerd[1483]: time="2025-07-07T06:04:58.242799162Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 7 06:04:58.243278 containerd[1483]: time="2025-07-07T06:04:58.242925079Z" level=info msg="metadata content store policy set" policy=shared Jul 7 06:04:58.273565 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 7 06:04:58.294521 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 7 06:04:58.310716 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 7 06:04:58.358014 systemd[1]: Reached target getty.target - Login Prompts. Jul 7 06:04:58.375071 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 7 06:04:58.408867 containerd[1483]: time="2025-07-07T06:04:58.408745329Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 7 06:04:58.408867 containerd[1483]: time="2025-07-07T06:04:58.408836931Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 7 06:04:58.408867 containerd[1483]: time="2025-07-07T06:04:58.408857590Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.408901242Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.408952588Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.408967135Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.408983085Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.408994637Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.409005277Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.409015396Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.409024493Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 7 06:04:58.409055 containerd[1483]: time="2025-07-07T06:04:58.409037187Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 7 06:04:58.409252 containerd[1483]: time="2025-07-07T06:04:58.409188190Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 7 06:04:58.409252 containerd[1483]: time="2025-07-07T06:04:58.409206835Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 7 06:04:58.409252 containerd[1483]: time="2025-07-07T06:04:58.409220020Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 7 06:04:58.409252 containerd[1483]: time="2025-07-07T06:04:58.409229848Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 7 06:04:58.409252 containerd[1483]: time="2025-07-07T06:04:58.409240358Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 7 06:04:58.409252 containerd[1483]: time="2025-07-07T06:04:58.409249485Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 7 06:04:58.409370 containerd[1483]: time="2025-07-07T06:04:58.409261207Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 7 06:04:58.409370 containerd[1483]: time="2025-07-07T06:04:58.409271066Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 7 06:04:58.409370 containerd[1483]: time="2025-07-07T06:04:58.409281245Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 7 06:04:58.409370 containerd[1483]: time="2025-07-07T06:04:58.409290803Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 7 06:04:58.409370 containerd[1483]: time="2025-07-07T06:04:58.409301082Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 7 06:04:58.409471 containerd[1483]: time="2025-07-07T06:04:58.409387464Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 7 06:04:58.409471 containerd[1483]: time="2025-07-07T06:04:58.409401681Z" level=info msg="Start snapshots syncer" Jul 7 06:04:58.409471 containerd[1483]: time="2025-07-07T06:04:58.409429333Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 7 06:04:58.409750 containerd[1483]: time="2025-07-07T06:04:58.409703437Z" 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\"}" Jul 7 06:04:58.409919 containerd[1483]: time="2025-07-07T06:04:58.409760554Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 7 06:04:58.409919 containerd[1483]: time="2025-07-07T06:04:58.409841195Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 7 06:04:58.410011 containerd[1483]: time="2025-07-07T06:04:58.409982400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 7 06:04:58.410045 containerd[1483]: time="2025-07-07T06:04:58.410017326Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 7 06:04:58.410045 containerd[1483]: time="2025-07-07T06:04:58.410031061Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 7 06:04:58.410082 containerd[1483]: time="2025-07-07T06:04:58.410044096Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 7 06:04:58.410082 containerd[1483]: time="2025-07-07T06:04:58.410056249Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 7 06:04:58.410082 containerd[1483]: time="2025-07-07T06:04:58.410071628Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 7 06:04:58.410136 containerd[1483]: time="2025-07-07T06:04:58.410082678Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 7 06:04:58.410136 containerd[1483]: time="2025-07-07T06:04:58.410121130Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 7 06:04:58.410136 containerd[1483]: time="2025-07-07T06:04:58.410133854Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 7 06:04:58.410194 containerd[1483]: time="2025-07-07T06:04:58.410144194Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 7 06:04:58.410194 containerd[1483]: time="2025-07-07T06:04:58.410169621Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 7 06:04:58.410194 containerd[1483]: time="2025-07-07T06:04:58.410188206Z" 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 Jul 7 06:04:58.410250 containerd[1483]: time="2025-07-07T06:04:58.410200129Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 7 06:04:58.410250 containerd[1483]: time="2025-07-07T06:04:58.410213233Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 7 06:04:58.410250 containerd[1483]: time="2025-07-07T06:04:58.410221308Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 7 06:04:58.410250 containerd[1483]: time="2025-07-07T06:04:58.410230095Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 7 06:04:58.410250 containerd[1483]: time="2025-07-07T06:04:58.410239402Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 7 06:04:58.410350 containerd[1483]: time="2025-07-07T06:04:58.410262516Z" level=info msg="runtime interface created" Jul 7 06:04:58.410350 containerd[1483]: time="2025-07-07T06:04:58.410271493Z" level=info msg="created NRI interface" Jul 7 06:04:58.410350 containerd[1483]: time="2025-07-07T06:04:58.410283435Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 7 06:04:58.410350 containerd[1483]: time="2025-07-07T06:04:58.410296860Z" level=info msg="Connect containerd service" Jul 7 06:04:58.410350 containerd[1483]: time="2025-07-07T06:04:58.410345251Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 7 06:04:58.411405 containerd[1483]: time="2025-07-07T06:04:58.411346309Z" 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" Jul 7 06:04:58.579451 containerd[1483]: time="2025-07-07T06:04:58.579288661Z" level=info msg="Start subscribing containerd event" Jul 7 06:04:58.579589 containerd[1483]: time="2025-07-07T06:04:58.579418384Z" level=info msg="Start recovering state" Jul 7 06:04:58.579589 containerd[1483]: time="2025-07-07T06:04:58.579529863Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 7 06:04:58.579675 containerd[1483]: time="2025-07-07T06:04:58.579647123Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 7 06:04:58.579760 containerd[1483]: time="2025-07-07T06:04:58.579693951Z" level=info msg="Start event monitor" Jul 7 06:04:58.579760 containerd[1483]: time="2025-07-07T06:04:58.579721062Z" level=info msg="Start cni network conf syncer for default" Jul 7 06:04:58.579760 containerd[1483]: time="2025-07-07T06:04:58.579729859Z" level=info msg="Start streaming server" Jul 7 06:04:58.579760 containerd[1483]: time="2025-07-07T06:04:58.579754304Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 7 06:04:58.579760 containerd[1483]: time="2025-07-07T06:04:58.579765155Z" level=info msg="runtime interface starting up..." Jul 7 06:04:58.579967 containerd[1483]: time="2025-07-07T06:04:58.579777638Z" level=info msg="starting plugins..." Jul 7 06:04:58.579967 containerd[1483]: time="2025-07-07T06:04:58.579803417Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 7 06:04:58.580894 containerd[1483]: time="2025-07-07T06:04:58.580516454Z" level=info msg="containerd successfully booted in 0.356472s" Jul 7 06:04:58.581080 systemd[1]: Started containerd.service - containerd container runtime. Jul 7 06:04:59.093090 systemd-networkd[1404]: eth0: Gained IPv6LL Jul 7 06:04:59.099244 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 7 06:04:59.101642 systemd[1]: Reached target network-online.target - Network is Online. Jul 7 06:04:59.104753 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 7 06:04:59.107624 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 7 06:04:59.151337 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 7 06:04:59.174811 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 7 06:04:59.175131 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 7 06:04:59.178453 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jul 7 06:04:59.179746 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 7 06:04:59.200651 (-wrapper)[1587]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jul 7 06:04:59.430860 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 7 06:04:59.453349 (dockerd)[1599]: 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 Jul 7 06:04:59.996545 dockerd[1599]: time="2025-07-07T06:04:59.996433967Z" level=info msg="Starting up" Jul 7 06:04:59.997597 dockerd[1599]: time="2025-07-07T06:04:59.997521216Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 7 06:05:00.337953 dockerd[1599]: time="2025-07-07T06:05:00.337774516Z" level=info msg="Loading containers: start." Jul 7 06:05:00.514910 kernel: Initializing XFRM netlink socket Jul 7 06:05:01.312390 systemd-networkd[1404]: docker0: Link UP Jul 7 06:05:01.317773 dockerd[1599]: time="2025-07-07T06:05:01.317705206Z" level=info msg="Loading containers: done." Jul 7 06:05:01.341309 dockerd[1599]: time="2025-07-07T06:05:01.341227365Z" 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 Jul 7 06:05:01.341501 dockerd[1599]: time="2025-07-07T06:05:01.341357028Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 7 06:05:01.341575 dockerd[1599]: time="2025-07-07T06:05:01.341528740Z" level=info msg="Initializing buildkit" Jul 7 06:05:01.385917 dockerd[1599]: time="2025-07-07T06:05:01.385835864Z" level=info msg="Completed buildkit initialization" Jul 7 06:05:01.392601 dockerd[1599]: time="2025-07-07T06:05:01.392526035Z" level=info msg="Daemon has completed initialization" Jul 7 06:05:01.392718 dockerd[1599]: time="2025-07-07T06:05:01.392612708Z" level=info msg="API listen on /run/docker.sock" Jul 7 06:05:01.392953 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 7 06:05:01.396500 etcd-wrapper[1591]: Error response from daemon: No such container: etcd-member Jul 7 06:05:01.417008 etcd-wrapper[1790]: Error response from daemon: No such container: etcd-member Jul 7 06:05:01.458211 etcd-wrapper[1810]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Jul 7 06:05:03.055830 etcd-wrapper[1810]: v3.5.16: Pulling from coreos/etcd Jul 7 06:05:03.486384 etcd-wrapper[1810]: 804c8aba2cc6: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: 2ae710cd8bfe: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: d462aa345367: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: 0f8b424aa0b9: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: d557676654e5: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: c8022d07192e: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: d858cbc252ad: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: 1069fc2daed1: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: b40161cd83fc: Pulling fs layer Jul 7 06:05:03.486384 etcd-wrapper[1810]: d557676654e5: Waiting Jul 7 06:05:03.486384 etcd-wrapper[1810]: c8022d07192e: Waiting Jul 7 06:05:03.486384 etcd-wrapper[1810]: d858cbc252ad: Waiting Jul 7 06:05:03.486384 etcd-wrapper[1810]: 1069fc2daed1: Waiting Jul 7 06:05:03.490863 etcd-wrapper[1810]: 0f8b424aa0b9: Waiting Jul 7 06:05:03.491144 etcd-wrapper[1810]: 5318d93a3a65: Pulling fs layer Jul 7 06:05:03.491329 etcd-wrapper[1810]: 307c1adadb60: Pulling fs layer Jul 7 06:05:03.491479 etcd-wrapper[1810]: fbb01d9e9dc9: Pulling fs layer Jul 7 06:05:03.491684 etcd-wrapper[1810]: fbfea02ac3cf: Pulling fs layer Jul 7 06:05:03.491957 etcd-wrapper[1810]: 8c26e4bf18e2: Pulling fs layer Jul 7 06:05:03.492312 etcd-wrapper[1810]: 1e59a65f8816: Pulling fs layer Jul 7 06:05:03.492604 etcd-wrapper[1810]: ffbd4ca5f0bd: Pulling fs layer Jul 7 06:05:03.492604 etcd-wrapper[1810]: b40161cd83fc: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: 5318d93a3a65: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: 307c1adadb60: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: fbb01d9e9dc9: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: fbfea02ac3cf: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: 8c26e4bf18e2: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: 1e59a65f8816: Waiting Jul 7 06:05:03.492604 etcd-wrapper[1810]: ffbd4ca5f0bd: Waiting Jul 7 06:05:03.713524 etcd-wrapper[1810]: 2ae710cd8bfe: Verifying Checksum Jul 7 06:05:03.713524 etcd-wrapper[1810]: 2ae710cd8bfe: Download complete Jul 7 06:05:03.715824 etcd-wrapper[1810]: d462aa345367: Download complete Jul 7 06:05:03.817412 etcd-wrapper[1810]: 804c8aba2cc6: Verifying Checksum Jul 7 06:05:03.817412 etcd-wrapper[1810]: 804c8aba2cc6: Download complete Jul 7 06:05:03.855964 etcd-wrapper[1810]: 804c8aba2cc6: Pull complete Jul 7 06:05:03.877425 systemd[1]: var-lib-docker-overlay2-a4c5fd9eda0fc3af5ff187379e9068bbc37a1d7841c75dd3ecc83b354cfb7d63-merged.mount: Deactivated successfully. Jul 7 06:05:03.908405 etcd-wrapper[1810]: 2ae710cd8bfe: Pull complete Jul 7 06:05:03.929909 etcd-wrapper[1810]: 0f8b424aa0b9: Verifying Checksum Jul 7 06:05:03.929909 etcd-wrapper[1810]: 0f8b424aa0b9: Download complete Jul 7 06:05:03.934257 etcd-wrapper[1810]: d557676654e5: Verifying Checksum Jul 7 06:05:03.934257 etcd-wrapper[1810]: d557676654e5: Download complete Jul 7 06:05:04.082577 etcd-wrapper[1810]: c8022d07192e: Verifying Checksum Jul 7 06:05:04.082577 etcd-wrapper[1810]: c8022d07192e: Download complete Jul 7 06:05:04.142321 etcd-wrapper[1810]: d858cbc252ad: Verifying Checksum Jul 7 06:05:04.142321 etcd-wrapper[1810]: d858cbc252ad: Download complete Jul 7 06:05:04.149148 etcd-wrapper[1810]: 1069fc2daed1: Download complete Jul 7 06:05:04.348815 etcd-wrapper[1810]: b40161cd83fc: Verifying Checksum Jul 7 06:05:04.348815 etcd-wrapper[1810]: b40161cd83fc: Download complete Jul 7 06:05:04.364549 etcd-wrapper[1810]: 307c1adadb60: Verifying Checksum Jul 7 06:05:04.364549 etcd-wrapper[1810]: 307c1adadb60: Download complete Jul 7 06:05:04.404512 etcd-wrapper[1810]: 5318d93a3a65: Verifying Checksum Jul 7 06:05:04.404512 etcd-wrapper[1810]: 5318d93a3a65: Download complete Jul 7 06:05:04.522948 etcd-wrapper[1810]: d462aa345367: Pull complete Jul 7 06:05:04.554610 etcd-wrapper[1810]: 0f8b424aa0b9: Pull complete Jul 7 06:05:04.592334 etcd-wrapper[1810]: d557676654e5: Pull complete Jul 7 06:05:04.607964 etcd-wrapper[1810]: fbfea02ac3cf: Verifying Checksum Jul 7 06:05:04.607964 etcd-wrapper[1810]: fbfea02ac3cf: Download complete Jul 7 06:05:04.641224 etcd-wrapper[1810]: c8022d07192e: Pull complete Jul 7 06:05:04.653103 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 7 06:05:04.655100 systemd[1]: Started sshd@0-10.0.0.66:22-10.0.0.1:33244.service - OpenSSH per-connection server daemon (10.0.0.1:33244). Jul 7 06:05:04.676490 etcd-wrapper[1810]: d858cbc252ad: Pull complete Jul 7 06:05:04.777650 etcd-wrapper[1810]: fbb01d9e9dc9: Verifying Checksum Jul 7 06:05:04.777650 etcd-wrapper[1810]: fbb01d9e9dc9: Download complete Jul 7 06:05:04.822489 systemd[1]: var-lib-docker-overlay2-4b300ee6f01497aef67a2664354a120bd895733ffdb4b6f4cad7ecb2c3d776db-merged.mount: Deactivated successfully. Jul 7 06:05:04.895717 sshd[1862]: Accepted publickey for core from 10.0.0.1 port 33244 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:04.898618 sshd-session[1862]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:04.905043 etcd-wrapper[1810]: 1e59a65f8816: Verifying Checksum Jul 7 06:05:04.905182 etcd-wrapper[1810]: 1e59a65f8816: Download complete Jul 7 06:05:04.908910 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 7 06:05:04.910425 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 7 06:05:04.938834 systemd-logind[1441]: New session 1 of user core. Jul 7 06:05:04.949594 etcd-wrapper[1810]: 8c26e4bf18e2: Verifying Checksum Jul 7 06:05:04.949594 etcd-wrapper[1810]: 8c26e4bf18e2: Download complete Jul 7 06:05:04.981252 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 7 06:05:04.984961 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 7 06:05:05.002857 (systemd)[1873]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 7 06:05:05.005756 systemd-logind[1441]: New session c1 of user core. Jul 7 06:05:05.109839 etcd-wrapper[1810]: ffbd4ca5f0bd: Verifying Checksum Jul 7 06:05:05.109839 etcd-wrapper[1810]: ffbd4ca5f0bd: Download complete Jul 7 06:05:05.232365 systemd[1873]: Queued start job for default target default.target. Jul 7 06:05:05.233986 etcd-wrapper[1810]: 1069fc2daed1: Pull complete Jul 7 06:05:05.245185 systemd[1873]: Created slice app.slice - User Application Slice. Jul 7 06:05:05.245216 systemd[1873]: Reached target paths.target - Paths. Jul 7 06:05:05.245273 systemd[1873]: Reached target timers.target - Timers. Jul 7 06:05:05.246958 systemd[1873]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 7 06:05:05.260916 systemd[1873]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 7 06:05:05.261050 systemd[1873]: Reached target sockets.target - Sockets. Jul 7 06:05:05.261089 systemd[1873]: Reached target basic.target - Basic System. Jul 7 06:05:05.261152 systemd[1873]: Reached target default.target - Main User Target. Jul 7 06:05:05.261192 systemd[1873]: Startup finished in 246ms. Jul 7 06:05:05.262095 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 7 06:05:05.264096 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 7 06:05:05.326403 systemd[1]: Started sshd@1-10.0.0.66:22-10.0.0.1:33246.service - OpenSSH per-connection server daemon (10.0.0.1:33246). Jul 7 06:05:05.370776 sshd[1884]: Accepted publickey for core from 10.0.0.1 port 33246 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:05.372822 sshd-session[1884]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:05.378453 systemd-logind[1441]: New session 2 of user core. Jul 7 06:05:05.393100 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 7 06:05:05.450593 systemd[1]: var-lib-docker-overlay2-f4bdfa080566b641428fbfd33429cf6220654c5cdd20e271c375c05cfc41dba0-merged.mount: Deactivated successfully. Jul 7 06:05:05.486502 sshd[1890]: Connection closed by 10.0.0.1 port 33246 Jul 7 06:05:05.486339 sshd-session[1884]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:05.470923 systemd[1]: Started sshd@2-10.0.0.66:22-10.0.0.1:33254.service - OpenSSH per-connection server daemon (10.0.0.1:33254). Jul 7 06:05:05.492435 systemd[1]: sshd@1-10.0.0.66:22-10.0.0.1:33246.service: Deactivated successfully. Jul 7 06:05:05.494532 systemd[1]: session-2.scope: Deactivated successfully. Jul 7 06:05:05.495467 systemd-logind[1441]: Session 2 logged out. Waiting for processes to exit. Jul 7 06:05:05.497292 systemd-logind[1441]: Removed session 2. Jul 7 06:05:05.515985 sshd[1893]: Accepted publickey for core from 10.0.0.1 port 33254 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:05.517031 etcd-wrapper[1810]: b40161cd83fc: Pull complete Jul 7 06:05:05.518217 sshd-session[1893]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:05.524784 systemd-logind[1441]: New session 3 of user core. Jul 7 06:05:05.531200 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 7 06:05:05.553322 etcd-wrapper[1810]: 5318d93a3a65: Pull complete Jul 7 06:05:05.584155 etcd-wrapper[1810]: 307c1adadb60: Pull complete Jul 7 06:05:05.590865 sshd[1903]: Connection closed by 10.0.0.1 port 33254 Jul 7 06:05:05.591274 sshd-session[1893]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:05.596492 systemd[1]: sshd@2-10.0.0.66:22-10.0.0.1:33254.service: Deactivated successfully. Jul 7 06:05:05.599051 systemd[1]: session-3.scope: Deactivated successfully. Jul 7 06:05:05.601104 systemd-logind[1441]: Session 3 logged out. Waiting for processes to exit. Jul 7 06:05:05.603297 systemd-logind[1441]: Removed session 3. Jul 7 06:05:05.822455 systemd[1]: var-lib-docker-overlay2-3c9bda6ee71be3a18c6fb4083ed806945f9be30f9e2e7ac5213ca77389aa8ba3-merged.mount: Deactivated successfully. Jul 7 06:05:05.829630 etcd-wrapper[1810]: fbb01d9e9dc9: Pull complete Jul 7 06:05:05.930171 systemd[1]: var-lib-docker-overlay2-f97f20b913fc3ce10442246c486f68e7484ee5acfaeffe433d3a9cff3fbf9c6f-merged.mount: Deactivated successfully. Jul 7 06:05:06.012762 etcd-wrapper[1810]: fbfea02ac3cf: Pull complete Jul 7 06:05:06.112601 systemd[1]: var-lib-docker-overlay2-d9b549a7e143cda04d677b07f789621c886fa9b99e8e1c06f701f40e1ec969b3-merged.mount: Deactivated successfully. Jul 7 06:05:06.186645 etcd-wrapper[1810]: 8c26e4bf18e2: Pull complete Jul 7 06:05:06.215510 etcd-wrapper[1810]: 1e59a65f8816: Pull complete Jul 7 06:05:06.243003 etcd-wrapper[1810]: ffbd4ca5f0bd: Pull complete Jul 7 06:05:06.253089 etcd-wrapper[1810]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Jul 7 06:05:06.257548 etcd-wrapper[1810]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Jul 7 06:05:06.326991 containerd[1483]: time="2025-07-07T06:05:06.326926663Z" level=info msg="connecting to shim 2ab57e757f85374214ec9b39e4a689d81786657d14baa1dec139ef0d0a70384e" address="unix:///run/containerd/s/bccc68e63430ef5c40ca411e2ee4a20563a6d51131b963654c7d502c355eff01" namespace=moby protocol=ttrpc version=3 Jul 7 06:05:06.378051 systemd[1]: Started docker-2ab57e757f85374214ec9b39e4a689d81786657d14baa1dec139ef0d0a70384e.scope - libcontainer container 2ab57e757f85374214ec9b39e4a689d81786657d14baa1dec139ef0d0a70384e. Jul 7 06:05:06.398665 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.777425Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.777591Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"0f5989e7392e464fb985574f8d53574a"} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.777614Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.777629Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.777634Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.777638Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.777664Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 7 06:05:06.777977 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.777695Z","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.66:2379"]} Jul 7 06:05:06.778401 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.777773Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 7 06:05:06.778401 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.777785Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Jul 7 06:05:06.778650 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.778464Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jul 7 06:05:06.778847 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.778626Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"amd64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"0f5989e7392e464fb985574f8d53574a","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.66:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"0f5989e7392e464fb985574f8d53574a=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"} Jul 7 06:05:06.781625 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.781419Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.426202ms"} Jul 7 06:05:06.786491 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.786210Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Jul 7 06:05:06.786491 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.786290Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Jul 7 06:05:06.786491 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.786331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Jul 7 06:05:06.786491 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.786344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jul 7 06:05:06.786491 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.786363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Jul 7 06:05:06.786491 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.786393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 7 06:05:06.792781 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:05:06.790862Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Jul 7 06:05:06.792937 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.792009Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Jul 7 06:05:06.794236 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.793001Z","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"} Jul 7 06:05:06.795814 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.795436Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Jul 7 06:05:06.796057 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.795590Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Jul 7 06:05:06.796057 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.795708Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 7 06:05:06.796057 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.795801Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Jul 7 06:05:06.796057 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.795926Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Jul 7 06:05:06.796336 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.795939Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Jul 7 06:05:06.796513 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.796364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 7 06:05:06.797366 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.796777Z","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"]} Jul 7 06:05:06.798966 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.798752Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Jul 7 06:05:06.798966 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.798788Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Jul 7 06:05:06.799084 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:06.798887Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.66:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286650Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286710Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Jul 7 06:05:07.287036 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.286747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Jul 7 06:05:07.287814 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.287605Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Jul 7 06:05:07.288844 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.288139Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:0f5989e7392e464fb985574f8d53574a ClientURLs:[http://10.0.0.66:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Jul 7 06:05:07.288844 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.288178Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Jul 7 06:05:07.288844 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.288416Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Jul 7 06:05:07.288844 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.288442Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Jul 7 06:05:07.288844 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.288614Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Jul 7 06:05:07.288844 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.288689Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 7 06:05:07.289122 systemd[1]: Started etcd-member.service - etcd (System Application Container). Jul 7 06:05:07.289474 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.289016Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jul 7 06:05:07.289474 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.289047Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Jul 7 06:05:07.289519 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 7 06:05:07.289752 systemd[1]: Startup finished in 3.153s (kernel) + 5.039s (initrd) + 12.098s (userspace) = 20.290s. Jul 7 06:05:07.290003 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:05:07.289626Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Jul 7 06:05:15.603765 systemd[1]: Started sshd@3-10.0.0.66:22-10.0.0.1:37406.service - OpenSSH per-connection server daemon (10.0.0.1:37406). Jul 7 06:05:15.649926 sshd[1993]: Accepted publickey for core from 10.0.0.1 port 37406 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:15.651635 sshd-session[1993]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:15.656936 systemd-logind[1441]: New session 4 of user core. Jul 7 06:05:15.664036 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 7 06:05:15.718335 sshd[1995]: Connection closed by 10.0.0.1 port 37406 Jul 7 06:05:15.718795 sshd-session[1993]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:15.741630 systemd[1]: sshd@3-10.0.0.66:22-10.0.0.1:37406.service: Deactivated successfully. Jul 7 06:05:15.743937 systemd[1]: session-4.scope: Deactivated successfully. Jul 7 06:05:15.744929 systemd-logind[1441]: Session 4 logged out. Waiting for processes to exit. Jul 7 06:05:15.748683 systemd[1]: Started sshd@4-10.0.0.66:22-10.0.0.1:37412.service - OpenSSH per-connection server daemon (10.0.0.1:37412). Jul 7 06:05:15.749626 systemd-logind[1441]: Removed session 4. Jul 7 06:05:15.807214 sshd[2001]: Accepted publickey for core from 10.0.0.1 port 37412 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:15.809119 sshd-session[2001]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:15.814749 systemd-logind[1441]: New session 5 of user core. Jul 7 06:05:15.826122 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 7 06:05:15.879826 sshd[2003]: Connection closed by 10.0.0.1 port 37412 Jul 7 06:05:15.880720 sshd-session[2001]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:15.891567 systemd[1]: sshd@4-10.0.0.66:22-10.0.0.1:37412.service: Deactivated successfully. Jul 7 06:05:15.894035 systemd[1]: session-5.scope: Deactivated successfully. Jul 7 06:05:15.894866 systemd-logind[1441]: Session 5 logged out. Waiting for processes to exit. Jul 7 06:05:15.898684 systemd[1]: Started sshd@5-10.0.0.66:22-10.0.0.1:37414.service - OpenSSH per-connection server daemon (10.0.0.1:37414). Jul 7 06:05:15.899386 systemd-logind[1441]: Removed session 5. Jul 7 06:05:15.955128 sshd[2009]: Accepted publickey for core from 10.0.0.1 port 37414 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:15.956697 sshd-session[2009]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:15.962283 systemd-logind[1441]: New session 6 of user core. Jul 7 06:05:15.977022 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 7 06:05:16.033614 sshd[2011]: Connection closed by 10.0.0.1 port 37414 Jul 7 06:05:16.034051 sshd-session[2009]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:16.045004 systemd[1]: sshd@5-10.0.0.66:22-10.0.0.1:37414.service: Deactivated successfully. Jul 7 06:05:16.047669 systemd[1]: session-6.scope: Deactivated successfully. Jul 7 06:05:16.048575 systemd-logind[1441]: Session 6 logged out. Waiting for processes to exit. Jul 7 06:05:16.052001 systemd[1]: Started sshd@6-10.0.0.66:22-10.0.0.1:38386.service - OpenSSH per-connection server daemon (10.0.0.1:38386). Jul 7 06:05:16.052988 systemd-logind[1441]: Removed session 6. Jul 7 06:05:16.101534 sshd[2017]: Accepted publickey for core from 10.0.0.1 port 38386 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:16.103257 sshd-session[2017]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:16.108785 systemd-logind[1441]: New session 7 of user core. Jul 7 06:05:16.122199 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 7 06:05:16.174485 sshd[2019]: Connection closed by 10.0.0.1 port 38386 Jul 7 06:05:16.174821 sshd-session[2017]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:16.187745 systemd[1]: sshd@6-10.0.0.66:22-10.0.0.1:38386.service: Deactivated successfully. Jul 7 06:05:16.189682 systemd[1]: session-7.scope: Deactivated successfully. Jul 7 06:05:16.190576 systemd-logind[1441]: Session 7 logged out. Waiting for processes to exit. Jul 7 06:05:16.194030 systemd[1]: Started sshd@7-10.0.0.66:22-10.0.0.1:38398.service - OpenSSH per-connection server daemon (10.0.0.1:38398). Jul 7 06:05:16.194783 systemd-logind[1441]: Removed session 7. Jul 7 06:05:16.245493 sshd[2027]: Accepted publickey for core from 10.0.0.1 port 38398 ssh2: RSA SHA256:lM1+QfY1+TxW9jK1A/TPIM6/Ft6LQX1Zpr4Dn3u4l9M Jul 7 06:05:16.247361 sshd-session[2027]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 7 06:05:16.252866 systemd-logind[1441]: New session 8 of user core. Jul 7 06:05:16.262154 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 7 06:05:16.574646 sshd[2029]: Connection closed by 10.0.0.1 port 38398 Jul 7 06:05:16.575196 sshd-session[2027]: pam_unix(sshd:session): session closed for user core Jul 7 06:05:16.579990 systemd[1]: sshd@7-10.0.0.66:22-10.0.0.1:38398.service: Deactivated successfully. Jul 7 06:05:16.582134 systemd[1]: session-8.scope: Deactivated successfully. Jul 7 06:05:16.582860 systemd-logind[1441]: Session 8 logged out. Waiting for processes to exit. Jul 7 06:05:16.584097 systemd-logind[1441]: Removed session 8. Jul 7 06:05:43.025597 update_engine[1443]: I20250707 06:05:43.025431 1443 update_attempter.cc:509] Updating boot flags... Jul 7 06:06:08.355787 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.355277Z","caller":"traceutil/trace.go:171","msg":"trace[1332779809] transaction","detail":"{read_only:false; response_revision:115; number_of_response:1; }","duration":"161.260607ms","start":"2025-07-07T06:06:08.194005Z","end":"2025-07-07T06:06:08.355266Z","steps":["trace[1332779809] 'process raft request' (duration: 161.121816ms)"],"step_count":1} Jul 7 06:06:08.355787 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.355242Z","caller":"traceutil/trace.go:171","msg":"trace[1132064393] linearizableReadLoop","detail":"{readStateIndex:121; appliedIndex:120; }","duration":"160.721723ms","start":"2025-07-07T06:06:08.194495Z","end":"2025-07-07T06:06:08.355216Z","steps":["trace[1132064393] 'read index received' (duration: 160.577923ms)","trace[1132064393] 'applied index is now lower than readState.Index' (duration: 143.289µs)"],"step_count":2} Jul 7 06:06:08.355787 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:08.355381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.84178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} Jul 7 06:06:08.355787 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.355467Z","caller":"traceutil/trace.go:171","msg":"trace[374593271] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:115; }","duration":"160.967195ms","start":"2025-07-07T06:06:08.194483Z","end":"2025-07-07T06:06:08.355450Z","steps":["trace[374593271] 'agreement among raft nodes before linearized reading' (duration: 160.828945ms)"],"step_count":1} Jul 7 06:06:08.499905 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.499506Z","caller":"traceutil/trace.go:171","msg":"trace[1158644443] linearizableReadLoop","detail":"{readStateIndex:122; appliedIndex:121; }","duration":"139.772396ms","start":"2025-07-07T06:06:08.359717Z","end":"2025-07-07T06:06:08.499489Z","steps":["trace[1158644443] 'read index received' (duration: 79.490591ms)","trace[1158644443] 'applied index is now lower than readState.Index' (duration: 60.281254ms)"],"step_count":2} Jul 7 06:06:08.499905 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.499538Z","caller":"traceutil/trace.go:171","msg":"trace[756721113] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"140.700422ms","start":"2025-07-07T06:06:08.358826Z","end":"2025-07-07T06:06:08.499526Z","steps":["trace[756721113] 'process raft request' (duration: 80.408597ms)","trace[756721113] 'compare' (duration: 60.180585ms)"],"step_count":2} Jul 7 06:06:08.499905 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:08.499596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.863207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} Jul 7 06:06:08.500176 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.499613Z","caller":"traceutil/trace.go:171","msg":"trace[1292115891] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:116; }","duration":"139.903222ms","start":"2025-07-07T06:06:08.359705Z","end":"2025-07-07T06:06:08.499608Z","steps":["trace[1292115891] 'agreement among raft nodes before linearized reading' (duration: 139.856795ms)"],"step_count":1} Jul 7 06:06:08.500176 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:08.499616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.909475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} Jul 7 06:06:08.500176 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:08.499635Z","caller":"traceutil/trace.go:171","msg":"trace[872599736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:116; }","duration":"107.939351ms","start":"2025-07-07T06:06:08.391689Z","end":"2025-07-07T06:06:08.499628Z","steps":["trace[872599736] 'agreement among raft nodes before linearized reading' (duration: 107.913403ms)"],"step_count":1} Jul 7 06:06:09.338970 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:09.338380Z","caller":"traceutil/trace.go:171","msg":"trace[395014223] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"121.166461ms","start":"2025-07-07T06:06:09.217191Z","end":"2025-07-07T06:06:09.338357Z","steps":["trace[395014223] 'process raft request' (duration: 53.668674ms)","trace[395014223] 'compare' (duration: 67.258958ms)"],"step_count":2} Jul 7 06:06:09.647621 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:09.647238Z","caller":"traceutil/trace.go:171","msg":"trace[1881592132] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"128.733008ms","start":"2025-07-07T06:06:09.518484Z","end":"2025-07-07T06:06:09.647217Z","steps":["trace[1881592132] 'process raft request' (duration: 51.041374ms)","trace[1881592132] 'compare' (duration: 77.591256ms)"],"step_count":2} Jul 7 06:06:16.096435 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:16.096057Z","caller":"traceutil/trace.go:171","msg":"trace[1581176872] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"133.081836ms","start":"2025-07-07T06:06:15.962947Z","end":"2025-07-07T06:06:16.096029Z","steps":["trace[1581176872] 'process raft request' (duration: 132.915725ms)"],"step_count":1} Jul 7 06:06:16.205577 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:16.205112Z","caller":"traceutil/trace.go:171","msg":"trace[1656258895] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"104.453055ms","start":"2025-07-07T06:06:16.100638Z","end":"2025-07-07T06:06:16.205091Z","steps":["trace[1656258895] 'process raft request' (duration: 104.340863ms)"],"step_count":1} Jul 7 06:06:16.205577 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:16.205175Z","caller":"traceutil/trace.go:171","msg":"trace[1795724028] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"104.490315ms","start":"2025-07-07T06:06:16.100656Z","end":"2025-07-07T06:06:16.205146Z","steps":["trace[1795724028] 'process raft request' (duration: 104.386459ms)"],"step_count":1} Jul 7 06:06:36.751980 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:36.751121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.032018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} Jul 7 06:06:36.751980 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:36.751255Z","caller":"traceutil/trace.go:171","msg":"trace[1478280355] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"149.018724ms","start":"2025-07-07T06:06:36.602220Z","end":"2025-07-07T06:06:36.751239Z","steps":["trace[1478280355] 'read index received' (duration: 14.397079ms)","trace[1478280355] 'applied index is now lower than readState.Index' (duration: 134.621124ms)"],"step_count":2} Jul 7 06:06:36.751980 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:36.751315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.089772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/10.0.0.76\" ","response":"range_response_count:0 size:5"} Jul 7 06:06:36.751980 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:36.751330Z","caller":"traceutil/trace.go:171","msg":"trace[1653830381] range","detail":"{range_begin:/registry/csinodes/10.0.0.76; range_end:; response_count:0; response_revision:494; }","duration":"149.13456ms","start":"2025-07-07T06:06:36.602191Z","end":"2025-07-07T06:06:36.751325Z","steps":["trace[1653830381] 'agreement among raft nodes before linearized reading' (duration: 149.090384ms)"],"step_count":1} Jul 7 06:06:36.752905 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:36.751300Z","caller":"traceutil/trace.go:171","msg":"trace[362954144] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"152.184625ms","start":"2025-07-07T06:06:36.599084Z","end":"2025-07-07T06:06:36.751268Z","steps":["trace[362954144] 'process raft request' (duration: 17.605643ms)","trace[362954144] 'compare' (duration: 133.923286ms)"],"step_count":2} Jul 7 06:06:37.084151 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.083562Z","caller":"traceutil/trace.go:171","msg":"trace[110233341] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"276.9933ms","start":"2025-07-07T06:06:36.806551Z","end":"2025-07-07T06:06:37.083545Z","steps":["trace[110233341] 'read index received' (duration: 218.93869ms)","trace[110233341] 'applied index is now lower than readState.Index' (duration: 58.054109ms)"],"step_count":2} Jul 7 06:06:37.084151 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.083604Z","caller":"traceutil/trace.go:171","msg":"trace[656383498] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"297.997157ms","start":"2025-07-07T06:06:36.785578Z","end":"2025-07-07T06:06:37.083575Z","steps":["trace[656383498] 'process raft request' (duration: 239.951483ms)","trace[656383498] 'compare' (duration: 57.94579ms)"],"step_count":2} Jul 7 06:06:37.084151 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.083707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.138242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/10.0.0.76\" ","response":"range_response_count:0 size:5"} Jul 7 06:06:37.084151 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.083708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.777165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/10.0.0.76\" ","response":"range_response_count:0 size:5"} Jul 7 06:06:37.084151 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.083742Z","caller":"traceutil/trace.go:171","msg":"trace[487360361] range","detail":"{range_begin:/registry/csinodes/10.0.0.76; range_end:; response_count:0; response_revision:496; }","duration":"277.204891ms","start":"2025-07-07T06:06:36.806528Z","end":"2025-07-07T06:06:37.083733Z","steps":["trace[487360361] 'agreement among raft nodes before linearized reading' (duration: 277.103904ms)"],"step_count":1} Jul 7 06:06:37.084377 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.083751Z","caller":"traceutil/trace.go:171","msg":"trace[782456578] range","detail":"{range_begin:/registry/minions/10.0.0.76; range_end:; response_count:0; response_revision:496; }","duration":"246.840929ms","start":"2025-07-07T06:06:36.836903Z","end":"2025-07-07T06:06:37.083744Z","steps":["trace[782456578] 'agreement among raft nodes before linearized reading' (duration: 246.77434ms)"],"step_count":1} Jul 7 06:06:37.899771 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.899311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.089002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jul 7 06:06:37.899771 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.899421Z","caller":"traceutil/trace.go:171","msg":"trace[1241092952] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"414.976594ms","start":"2025-07-07T06:06:37.484432Z","end":"2025-07-07T06:06:37.899409Z","steps":["trace[1241092952] 'read index received' (duration: 215.663896ms)","trace[1241092952] 'applied index is now lower than readState.Index' (duration: 199.312147ms)"],"step_count":2} Jul 7 06:06:37.899771 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.899454Z","caller":"traceutil/trace.go:171","msg":"trace[1879574563] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"456.23033ms","start":"2025-07-07T06:06:37.443203Z","end":"2025-07-07T06:06:37.899434Z","steps":["trace[1879574563] 'process raft request' (duration: 256.818358ms)","trace[1879574563] 'compare' (duration: 198.979641ms)"],"step_count":2} Jul 7 06:06:37.900521 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.899578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.443194Z","time spent":"456.304474ms","remote":"10.0.0.72:39414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5302,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:37.992037 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.990999Z","caller":"traceutil/trace.go:171","msg":"trace[1297971891] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"501.964226ms","start":"2025-07-07T06:06:37.489003Z","end":"2025-07-07T06:06:37.990967Z","steps":["trace[1297971891] 'process raft request' (duration: 501.759679ms)"],"step_count":1} Jul 7 06:06:37.992037 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.991062Z","caller":"traceutil/trace.go:171","msg":"trace[406681374] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"501.367225ms","start":"2025-07-07T06:06:37.489672Z","end":"2025-07-07T06:06:37.991039Z","steps":["trace[406681374] 'process raft request' (duration: 501.265609ms)"],"step_count":1} Jul 7 06:06:37.992037 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.991103Z","caller":"traceutil/trace.go:171","msg":"trace[1998606063] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"447.38904ms","start":"2025-07-07T06:06:37.543693Z","end":"2025-07-07T06:06:37.991082Z","steps":["trace[1998606063] 'process raft request' (duration: 447.359573ms)"],"step_count":1} Jul 7 06:06:37.992037 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.488992Z","time spent":"502.087786ms","remote":"10.0.0.72:39414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3403,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:37.992332 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.991174Z","caller":"traceutil/trace.go:171","msg":"trace[91461750] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"501.506906ms","start":"2025-07-07T06:06:37.489660Z","end":"2025-07-07T06:06:37.991167Z","steps":["trace[91461750] 'process raft request' (duration: 501.302409ms)"],"step_count":1} Jul 7 06:06:37.992332 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.543683Z","time spent":"447.477212ms","remote":"10.0.0.72:39496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:37.992332 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.489653Z","time spent":"501.545632ms","remote":"10.0.0.72:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":692,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} Jul 7 06:06:37.992332 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.991298Z","caller":"traceutil/trace.go:171","msg":"trace[436002803] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"500.899065ms","start":"2025-07-07T06:06:37.490392Z","end":"2025-07-07T06:06:37.991291Z","steps":["trace[436002803] 'process raft request' (duration: 500.629791ms)"],"step_count":1} Jul 7 06:06:37.992463 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.490382Z","time spent":"500.926198ms","remote":"10.0.0.72:39700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7104,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:37.992463 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.991332Z","caller":"traceutil/trace.go:171","msg":"trace[182329416] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"502.306412ms","start":"2025-07-07T06:06:37.489017Z","end":"2025-07-07T06:06:37.991324Z","steps":["trace[182329416] 'process raft request' (duration: 501.883399ms)"],"step_count":1} Jul 7 06:06:37.992463 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:37.991106Z","caller":"traceutil/trace.go:171","msg":"trace[1362314669] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"500.900719ms","start":"2025-07-07T06:06:37.490188Z","end":"2025-07-07T06:06:37.991089Z","steps":["trace[1362314669] 'process raft request' (duration: 500.799612ms)"],"step_count":1} Jul 7 06:06:37.992463 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.488997Z","time spent":"502.367832ms","remote":"10.0.0.72:39412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2246,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:37.992584 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.490181Z","time spent":"501.200312ms","remote":"10.0.0.72:39700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2906,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:37.992584 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:37.991174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.489663Z","time spent":"501.449766ms","remote":"10.0.0.72:39414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5273,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:38.280661 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.278548Z","caller":"traceutil/trace.go:171","msg":"trace[1239311248] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"282.301365ms","start":"2025-07-07T06:06:37.996226Z","end":"2025-07-07T06:06:38.278527Z","steps":["trace[1239311248] 'process raft request' (duration: 282.251187ms)"],"step_count":1} Jul 7 06:06:38.280661 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.278641Z","caller":"traceutil/trace.go:171","msg":"trace[112349529] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"280.160591ms","start":"2025-07-07T06:06:37.998455Z","end":"2025-07-07T06:06:38.278616Z","steps":["trace[112349529] 'process raft request' (duration: 280.050358ms)"],"step_count":1} Jul 7 06:06:38.280661 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.278704Z","caller":"traceutil/trace.go:171","msg":"trace[31791391] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"493.903996ms","start":"2025-07-07T06:06:37.784792Z","end":"2025-07-07T06:06:38.278696Z","steps":["trace[31791391] 'process raft request' (duration: 490.444857ms)"],"step_count":1} Jul 7 06:06:38.280661 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.278791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.784775Z","time spent":"493.946077ms","remote":"10.0.0.72:39496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:38.281001 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.278938Z","caller":"traceutil/trace.go:171","msg":"trace[1547043755] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"376.366616ms","start":"2025-07-07T06:06:37.902533Z","end":"2025-07-07T06:06:38.278899Z","steps":["trace[1547043755] 'process raft request' (duration: 375.866515ms)"],"step_count":1} Jul 7 06:06:38.281001 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.278965Z","caller":"traceutil/trace.go:171","msg":"trace[2063003779] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:519; }","duration":"379.523163ms","start":"2025-07-07T06:06:37.899436Z","end":"2025-07-07T06:06:38.278959Z","steps":["trace[2063003779] 'read index received' (duration: 91.32721ms)","trace[2063003779] 'applied index is now lower than readState.Index' (duration: 288.195302ms)"],"step_count":2} Jul 7 06:06:38.281001 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.992219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/10.0.0.76\" ","response":"range_response_count:1 size:2261"} Jul 7 06:06:38.281001 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279059Z","caller":"traceutil/trace.go:171","msg":"trace[785969493] range","detail":"{range_begin:/registry/minions/10.0.0.76; range_end:; response_count:1; response_revision:517; }","duration":"459.017246ms","start":"2025-07-07T06:06:37.820034Z","end":"2025-07-07T06:06:38.279051Z","steps":["trace[785969493] 'agreement among raft nodes before linearized reading' (duration: 458.978351ms)"],"step_count":1} Jul 7 06:06:38.281001 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.820012Z","time spent":"459.060902ms","remote":"10.0.0.72:39412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":2285,"request content":"key:\"/registry/minions/10.0.0.76\" "} Jul 7 06:06:38.281194 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279069Z","caller":"traceutil/trace.go:171","msg":"trace[2107216803] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"376.561296ms","start":"2025-07-07T06:06:37.902493Z","end":"2025-07-07T06:06:38.279055Z","steps":["trace[2107216803] 'process raft request' (duration: 375.857198ms)"],"step_count":1} Jul 7 06:06:38.281194 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.902482Z","time spent":"376.627252ms","remote":"10.0.0.72:39400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:38.281194 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.932503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} Jul 7 06:06:38.281194 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279174Z","caller":"traceutil/trace.go:171","msg":"trace[1669396091] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"572.976959ms","start":"2025-07-07T06:06:37.706192Z","end":"2025-07-07T06:06:38.279169Z","steps":["trace[1669396091] 'agreement among raft nodes before linearized reading' (duration: 572.956119ms)"],"step_count":1} Jul 7 06:06:38.281327 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.706170Z","time spent":"573.014242ms","remote":"10.0.0.72:39198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} Jul 7 06:06:38.281327 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279270Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.54629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/10.0.0.76\" ","response":"range_response_count:1 size:2261"} Jul 7 06:06:38.281327 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279287Z","caller":"traceutil/trace.go:171","msg":"trace[1290956784] range","detail":"{range_begin:/registry/minions/10.0.0.76; range_end:; response_count:1; response_revision:517; }","duration":"282.593952ms","start":"2025-07-07T06:06:37.996689Z","end":"2025-07-07T06:06:38.279283Z","steps":["trace[1290956784] 'agreement among raft nodes before linearized reading' (duration: 282.564725ms)"],"step_count":1} Jul 7 06:06:38.281327 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.348261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} Jul 7 06:06:38.281327 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279390Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.257948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2921"} Jul 7 06:06:38.281476 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279402Z","caller":"traceutil/trace.go:171","msg":"trace[1680441360] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:517; }","duration":"113.466249ms","start":"2025-07-07T06:06:38.165928Z","end":"2025-07-07T06:06:38.279394Z","steps":["trace[1680441360] 'agreement among raft nodes before linearized reading' (duration: 113.354262ms)"],"step_count":1} Jul 7 06:06:38.281476 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279411Z","caller":"traceutil/trace.go:171","msg":"trace[2059110714] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:517; }","duration":"282.29509ms","start":"2025-07-07T06:06:37.997110Z","end":"2025-07-07T06:06:38.279405Z","steps":["trace[2059110714] 'agreement among raft nodes before linearized reading' (duration: 282.263709ms)"],"step_count":1} Jul 7 06:06:38.281476 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.902525Z","time spent":"376.441221ms","remote":"10.0.0.72:39504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1219,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:38.281476 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279340Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.628335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-r6l49\" ","response":"range_response_count:1 size:3418"} Jul 7 06:06:38.281750 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279491Z","caller":"traceutil/trace.go:171","msg":"trace[1562670257] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-r6l49; range_end:; response_count:1; response_revision:517; }","duration":"279.787896ms","start":"2025-07-07T06:06:37.999698Z","end":"2025-07-07T06:06:38.279486Z","steps":["trace[1562670257] 'agreement among raft nodes before linearized reading' (duration: 279.627274ms)"],"step_count":1} Jul 7 06:06:38.281750 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.289646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-flannel/kube-flannel-ds\" ","response":"range_response_count:1 size:7119"} Jul 7 06:06:38.281750 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279517Z","caller":"traceutil/trace.go:171","msg":"trace[1425565164] range","detail":"{range_begin:/registry/daemonsets/kube-flannel/kube-flannel-ds; range_end:; response_count:1; response_revision:517; }","duration":"281.467531ms","start":"2025-07-07T06:06:37.998045Z","end":"2025-07-07T06:06:38.279513Z","steps":["trace[1425565164] 'agreement among raft nodes before linearized reading' (duration: 281.304333ms)"],"step_count":1} Jul 7 06:06:38.281750 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.290869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-flannel/flannel\" ","response":"range_response_count:1 size:612"} Jul 7 06:06:38.281750 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.279545Z","caller":"traceutil/trace.go:171","msg":"trace[292080877] range","detail":"{range_begin:/registry/serviceaccounts/kube-flannel/flannel; range_end:; response_count:1; response_revision:517; }","duration":"113.379923ms","start":"2025-07-07T06:06:38.166158Z","end":"2025-07-07T06:06:38.279538Z","steps":["trace[292080877] 'agreement among raft nodes before linearized reading' (duration: 113.307262ms)"],"step_count":1} Jul 7 06:06:38.282068 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.278945Z","caller":"traceutil/trace.go:171","msg":"trace[317491160] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"320.574536ms","start":"2025-07-07T06:06:37.958362Z","end":"2025-07-07T06:06:38.278936Z","steps":["trace[317491160] 'process raft request' (duration: 320.077671ms)"],"step_count":1} Jul 7 06:06:38.282068 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:38.279621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:37.958340Z","time spent":"321.258625ms","remote":"10.0.0.72:39496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":674,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:38.433330 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:38.432931Z","caller":"traceutil/trace.go:171","msg":"trace[1229364249] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"106.326433ms","start":"2025-07-07T06:06:38.326539Z","end":"2025-07-07T06:06:38.432866Z","steps":["trace[1229364249] 'process raft request' (duration: 54.429291ms)","trace[1229364249] 'compare' (duration: 51.779012ms)"],"step_count":2} Jul 7 06:06:42.191759 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.191361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.006475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-proxy-r6l49.184fe306c2b161ec\" ","response":"range_response_count:1 size:800"} Jul 7 06:06:42.191759 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.191390Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.095067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-r6l49\" ","response":"range_response_count:1 size:4811"} Jul 7 06:06:42.191759 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.191429Z","caller":"traceutil/trace.go:171","msg":"trace[645275134] range","detail":"{range_begin:/registry/events/kube-system/kube-proxy-r6l49.184fe306c2b161ec; range_end:; response_count:1; response_revision:541; }","duration":"110.112911ms","start":"2025-07-07T06:06:42.081298Z","end":"2025-07-07T06:06:42.191411Z","steps":["trace[645275134] 'range keys from in-memory index tree' (duration: 109.935719ms)"],"step_count":1} Jul 7 06:06:42.191759 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.191452Z","caller":"traceutil/trace.go:171","msg":"trace[87975748] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-r6l49; range_end:; response_count:1; response_revision:541; }","duration":"110.181694ms","start":"2025-07-07T06:06:42.081254Z","end":"2025-07-07T06:06:42.191436Z","steps":["trace[87975748] 'range keys from in-memory index tree' (duration: 110.046273ms)"],"step_count":1} Jul 7 06:06:42.487611 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.487074Z","caller":"traceutil/trace.go:171","msg":"trace[658646466] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"304.032781ms","start":"2025-07-07T06:06:42.183019Z","end":"2025-07-07T06:06:42.487052Z","steps":["trace[658646466] 'process raft request' (duration: 303.924802ms)"],"step_count":1} Jul 7 06:06:42.487611 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.487200Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:42.182994Z","time spent":"304.143465ms","remote":"10.0.0.72:39412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4980,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:42.742823 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.742435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.75534ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jul 7 06:06:42.743248 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.742566Z","caller":"traceutil/trace.go:171","msg":"trace[1574092242] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"549.959635ms","start":"2025-07-07T06:06:42.192588Z","end":"2025-07-07T06:06:42.742548Z","steps":["trace[1574092242] 'process raft request' (duration: 349.031381ms)","trace[1574092242] 'compare' (duration: 200.668151ms)"],"step_count":2} Jul 7 06:06:42.743248 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.742642Z","caller":"traceutil/trace.go:171","msg":"trace[1877937238] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"492.803888ms","start":"2025-07-07T06:06:42.249831Z","end":"2025-07-07T06:06:42.742635Z","steps":["trace[1877937238] 'process raft request' (duration: 492.709575ms)"],"step_count":1} Jul 7 06:06:42.743248 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.742676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:42.249796Z","time spent":"492.861058ms","remote":"10.0.0.72:39496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:42.743356 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.742688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:42.192574Z","time spent":"550.079578ms","remote":"10.0.0.72:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:42.743356 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.742719Z","caller":"traceutil/trace.go:171","msg":"trace[330616923] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"454.16202ms","start":"2025-07-07T06:06:42.288542Z","end":"2025-07-07T06:06:42.742704Z","steps":["trace[330616923] 'process raft request' (duration: 454.018181ms)"],"step_count":1} Jul 7 06:06:42.743356 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.742748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:42.288519Z","time spent":"454.210263ms","remote":"10.0.0.72:39496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:42.743459 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:42.742791Z","caller":"traceutil/trace.go:171","msg":"trace[1124509223] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"545.979192ms","start":"2025-07-07T06:06:42.196804Z","end":"2025-07-07T06:06:42.742784Z","steps":["trace[1124509223] 'process raft request' (duration: 545.702247ms)"],"step_count":1} Jul 7 06:06:42.743459 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:42.742846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2025-07-07T06:06:42.196786Z","time spent":"546.04011ms","remote":"10.0.0.72:39414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4788,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} Jul 7 06:06:43.010814 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:43.010170Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.414024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jul 7 06:06:43.010814 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:43.010273Z","caller":"traceutil/trace.go:171","msg":"trace[1269942063] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"262.675896ms","start":"2025-07-07T06:06:42.747582Z","end":"2025-07-07T06:06:43.010258Z","steps":["trace[1269942063] 'process raft request' (duration: 131.108496ms)","trace[1269942063] 'compare' (duration: 131.31892ms)"],"step_count":2} Jul 7 06:06:43.313783 etcd-wrapper[1810]: {"level":"warn","ts":"2025-07-07T06:06:43.313262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.821859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} Jul 7 06:06:43.313783 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:43.313361Z","caller":"traceutil/trace.go:171","msg":"trace[1072073826] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"236.320411ms","start":"2025-07-07T06:06:43.077025Z","end":"2025-07-07T06:06:43.313345Z","steps":["trace[1072073826] 'process raft request' (duration: 42.338372ms)","trace[1072073826] 'compare' (duration: 193.716035ms)"],"step_count":2} Jul 7 06:06:44.010656 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:44.010326Z","caller":"traceutil/trace.go:171","msg":"trace[685511460] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"125.364621ms","start":"2025-07-07T06:06:43.884938Z","end":"2025-07-07T06:06:44.010303Z","steps":["trace[685511460] 'process raft request' (duration: 125.211505ms)"],"step_count":1} Jul 7 06:06:44.159422 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:44.159179Z","caller":"traceutil/trace.go:171","msg":"trace[927376496] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"142.333371ms","start":"2025-07-07T06:06:44.016837Z","end":"2025-07-07T06:06:44.159170Z","steps":["trace[927376496] 'process raft request' (duration: 142.306369ms)"],"step_count":1} Jul 7 06:06:44.159422 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:44.159228Z","caller":"traceutil/trace.go:171","msg":"trace[1945011296] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"144.400696ms","start":"2025-07-07T06:06:44.014816Z","end":"2025-07-07T06:06:44.159217Z","steps":["trace[1945011296] 'process raft request' (duration: 121.332583ms)","trace[1945011296] 'compare' (duration: 22.949975ms)"],"step_count":2} Jul 7 06:06:44.192398 etcd-wrapper[1810]: {"level":"info","ts":"2025-07-07T06:06:44.192008Z","caller":"traceutil/trace.go:171","msg":"trace[328423790] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"135.346139ms","start":"2025-07-07T06:06:44.056640Z","end":"2025-07-07T06:06:44.191986Z","steps":["trace[328423790] 'process raft request' (duration: 135.218413ms)"],"step_count":1}