May 14 19:28:37.977611 kernel: Linux version 6.12.20-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 Wed May 14 16:37:27 -00 2025
May 14 19:28:37.977641 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0
May 14 19:28:37.977652 kernel: BIOS-provided physical RAM map:
May 14 19:28:37.977663 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
May 14 19:28:37.977670 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
May 14 19:28:37.977678 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
May 14 19:28:37.977688 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable
May 14 19:28:37.977696 kernel: BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved
May 14 19:28:37.977704 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
May 14 19:28:37.977712 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
May 14 19:28:37.977721 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable
May 14 19:28:37.977729 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
May 14 19:28:37.977739 kernel: NX (Execute Disable) protection: active
May 14 19:28:37.977747 kernel: APIC: Static calls initialized
May 14 19:28:37.977757 kernel: SMBIOS 3.0.0 present.
May 14 19:28:37.977766 kernel: DMI: OpenStack Foundation OpenStack Nova, BIOS 1.16.3-debian-1.16.3-2 04/01/2014
May 14 19:28:37.977774 kernel: DMI: Memory slots populated: 1/1
May 14 19:28:37.977785 kernel: Hypervisor detected: KVM
May 14 19:28:37.977793 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00
May 14 19:28:37.977802 kernel: kvm-clock: using sched offset of 4945836838 cycles
May 14 19:28:37.977811 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
May 14 19:28:37.977820 kernel: tsc: Detected 1996.249 MHz processor
May 14 19:28:37.977829 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 14 19:28:37.977839 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 14 19:28:37.977848 kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000
May 14 19:28:37.977857 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
May 14 19:28:37.977867 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
May 14 19:28:37.977876 kernel: last_pfn = 0xbffdd max_arch_pfn = 0x400000000
May 14 19:28:37.977885 kernel: ACPI: Early table checksum verification disabled
May 14 19:28:37.977894 kernel: ACPI: RSDP 0x00000000000F51E0 000014 (v00 BOCHS )
May 14 19:28:37.977902 kernel: ACPI: RSDT 0x00000000BFFE1B65 000030 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 19:28:37.977911 kernel: ACPI: FACP 0x00000000BFFE1A49 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 19:28:37.977920 kernel: ACPI: DSDT 0x00000000BFFE0040 001A09 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 19:28:37.977929 kernel: ACPI: FACS 0x00000000BFFE0000 000040
May 14 19:28:37.977938 kernel: ACPI: APIC 0x00000000BFFE1ABD 000080 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 19:28:37.977949 kernel: ACPI: WAET 0x00000000BFFE1B3D 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 19:28:37.977957 kernel: ACPI: Reserving FACP table memory at [mem 0xbffe1a49-0xbffe1abc]
May 14 19:28:37.977966 kernel: ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a48]
May 14 19:28:37.977975 kernel: ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
May 14 19:28:37.977984 kernel: ACPI: Reserving APIC table memory at [mem 0xbffe1abd-0xbffe1b3c]
May 14 19:28:37.977996 kernel: ACPI: Reserving WAET table memory at [mem 0xbffe1b3d-0xbffe1b64]
May 14 19:28:37.978005 kernel: No NUMA configuration found
May 14 19:28:37.978043 kernel: Faking a node at [mem 0x0000000000000000-0x000000013fffffff]
May 14 19:28:37.978053 kernel: NODE_DATA(0) allocated [mem 0x13fff5dc0-0x13fffcfff]
May 14 19:28:37.978063 kernel: Zone ranges:
May 14 19:28:37.978072 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 14 19:28:37.978081 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
May 14 19:28:37.978090 kernel:   Normal   [mem 0x0000000100000000-0x000000013fffffff]
May 14 19:28:37.978099 kernel:   Device   empty
May 14 19:28:37.978108 kernel: Movable zone start for each node
May 14 19:28:37.978119 kernel: Early memory node ranges
May 14 19:28:37.978128 kernel:   node   0: [mem 0x0000000000001000-0x000000000009efff]
May 14 19:28:37.978176 kernel:   node   0: [mem 0x0000000000100000-0x00000000bffdcfff]
May 14 19:28:37.978187 kernel:   node   0: [mem 0x0000000100000000-0x000000013fffffff]
May 14 19:28:37.978196 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff]
May 14 19:28:37.978205 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 14 19:28:37.978214 kernel: On node 0, zone DMA: 97 pages in unavailable ranges
May 14 19:28:37.978223 kernel: On node 0, zone Normal: 35 pages in unavailable ranges
May 14 19:28:37.978232 kernel: ACPI: PM-Timer IO Port: 0x608
May 14 19:28:37.978245 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
May 14 19:28:37.978254 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
May 14 19:28:37.978263 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
May 14 19:28:37.978273 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
May 14 19:28:37.978282 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 14 19:28:37.978291 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
May 14 19:28:37.978300 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
May 14 19:28:37.978309 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 14 19:28:37.978318 kernel: CPU topo: Max. logical packages:   2
May 14 19:28:37.978329 kernel: CPU topo: Max. logical dies:       2
May 14 19:28:37.978338 kernel: CPU topo: Max. dies per package:   1
May 14 19:28:37.978347 kernel: CPU topo: Max. threads per core:   1
May 14 19:28:37.978356 kernel: CPU topo: Num. cores per package:     1
May 14 19:28:37.978365 kernel: CPU topo: Num. threads per package:   1
May 14 19:28:37.978374 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs
May 14 19:28:37.978383 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
May 14 19:28:37.978392 kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices
May 14 19:28:37.978402 kernel: Booting paravirtualized kernel on KVM
May 14 19:28:37.978413 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
May 14 19:28:37.978422 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
May 14 19:28:37.978431 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u1048576
May 14 19:28:37.978440 kernel: pcpu-alloc: s207832 r8192 d29736 u1048576 alloc=1*2097152
May 14 19:28:37.978449 kernel: pcpu-alloc: [0] 0 1 
May 14 19:28:37.978458 kernel: kvm-guest: PV spinlocks disabled, no host support
May 14 19:28:37.978469 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0
May 14 19:28:37.978479 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 14 19:28:37.978490 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 14 19:28:37.978499 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 14 19:28:37.978508 kernel: Fallback order for Node 0: 0 
May 14 19:28:37.978517 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 1048443
May 14 19:28:37.978527 kernel: Policy zone: Normal
May 14 19:28:37.978536 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 14 19:28:37.978545 kernel: software IO TLB: area num 2.
May 14 19:28:37.978557 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
May 14 19:28:37.978570 kernel: ftrace: allocating 40065 entries in 157 pages
May 14 19:28:37.978586 kernel: ftrace: allocated 157 pages with 5 groups
May 14 19:28:37.978600 kernel: Dynamic Preempt: voluntary
May 14 19:28:37.978613 kernel: rcu: Preemptible hierarchical RCU implementation.
May 14 19:28:37.978628 kernel: rcu:         RCU event tracing is enabled.
May 14 19:28:37.978643 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
May 14 19:28:37.978657 kernel:         Trampoline variant of Tasks RCU enabled.
May 14 19:28:37.978671 kernel:         Rude variant of Tasks RCU enabled.
May 14 19:28:37.978685 kernel:         Tracing variant of Tasks RCU enabled.
May 14 19:28:37.978699 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 14 19:28:37.978716 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
May 14 19:28:37.978730 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 14 19:28:37.978745 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 14 19:28:37.978759 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 14 19:28:37.978773 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16
May 14 19:28:37.978786 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 14 19:28:37.978800 kernel: Console: colour VGA+ 80x25
May 14 19:28:37.978814 kernel: printk: legacy console [tty0] enabled
May 14 19:28:37.978828 kernel: printk: legacy console [ttyS0] enabled
May 14 19:28:37.978845 kernel: ACPI: Core revision 20240827
May 14 19:28:37.978859 kernel: APIC: Switch to symmetric I/O mode setup
May 14 19:28:37.978873 kernel: x2apic enabled
May 14 19:28:37.978886 kernel: APIC: Switched APIC routing to: physical x2apic
May 14 19:28:37.978900 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
May 14 19:28:37.978915 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized
May 14 19:28:37.978938 kernel: Calibrating delay loop (skipped) preset value.. 3992.49 BogoMIPS (lpj=1996249)
May 14 19:28:37.978956 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
May 14 19:28:37.978971 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
May 14 19:28:37.978986 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 14 19:28:37.979001 kernel: Spectre V2 : Mitigation: Retpolines
May 14 19:28:37.979015 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
May 14 19:28:37.979033 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT
May 14 19:28:37.979048 kernel: Speculative Store Bypass: Vulnerable
May 14 19:28:37.979063 kernel: x86/fpu: x87 FPU will use FXSAVE
May 14 19:28:37.979078 kernel: Freeing SMP alternatives memory: 32K
May 14 19:28:37.979092 kernel: pid_max: default: 32768 minimum: 301
May 14 19:28:37.979111 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima
May 14 19:28:37.979125 kernel: landlock: Up and running.
May 14 19:28:37.979159 kernel: SELinux:  Initializing.
May 14 19:28:37.979175 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 14 19:28:37.979189 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 14 19:28:37.979204 kernel: smpboot: CPU0: AMD Intel Core i7 9xx (Nehalem Class Core i7) (family: 0x6, model: 0x1a, stepping: 0x3)
May 14 19:28:37.979219 kernel: Performance Events: AMD PMU driver.
May 14 19:28:37.979234 kernel: ... version:                0
May 14 19:28:37.979248 kernel: ... bit width:              48
May 14 19:28:37.979267 kernel: ... generic registers:      4
May 14 19:28:37.979281 kernel: ... value mask:             0000ffffffffffff
May 14 19:28:37.979855 kernel: ... max period:             00007fffffffffff
May 14 19:28:37.979882 kernel: ... fixed-purpose events:   0
May 14 19:28:37.979892 kernel: ... event mask:             000000000000000f
May 14 19:28:37.979902 kernel: signal: max sigframe size: 1440
May 14 19:28:37.979912 kernel: rcu: Hierarchical SRCU implementation.
May 14 19:28:37.979922 kernel: rcu:         Max phase no-delay instances is 400.
May 14 19:28:37.979932 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
May 14 19:28:37.979946 kernel: smp: Bringing up secondary CPUs ...
May 14 19:28:37.979956 kernel: smpboot: x86: Booting SMP configuration:
May 14 19:28:37.979966 kernel: .... node  #0, CPUs:      #1
May 14 19:28:37.979975 kernel: smp: Brought up 1 node, 2 CPUs
May 14 19:28:37.979985 kernel: smpboot: Total of 2 processors activated (7984.99 BogoMIPS)
May 14 19:28:37.979995 kernel: Memory: 3961272K/4193772K available (14336K kernel code, 2438K rwdata, 9944K rodata, 54424K init, 2536K bss, 227296K reserved, 0K cma-reserved)
May 14 19:28:37.980005 kernel: devtmpfs: initialized
May 14 19:28:37.980014 kernel: x86/mm: Memory block size: 128MB
May 14 19:28:37.980024 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 14 19:28:37.980036 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
May 14 19:28:37.980046 kernel: pinctrl core: initialized pinctrl subsystem
May 14 19:28:37.980056 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 14 19:28:37.980065 kernel: audit: initializing netlink subsys (disabled)
May 14 19:28:37.980075 kernel: audit: type=2000 audit(1747250914.549:1): state=initialized audit_enabled=0 res=1
May 14 19:28:37.980085 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 14 19:28:37.980095 kernel: thermal_sys: Registered thermal governor 'user_space'
May 14 19:28:37.980104 kernel: cpuidle: using governor menu
May 14 19:28:37.980114 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 14 19:28:37.980126 kernel: dca service started, version 1.12.1
May 14 19:28:37.980156 kernel: PCI: Using configuration type 1 for base access
May 14 19:28:37.980167 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 14 19:28:37.980177 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 14 19:28:37.980186 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 14 19:28:37.980196 kernel: ACPI: Added _OSI(Module Device)
May 14 19:28:37.980206 kernel: ACPI: Added _OSI(Processor Device)
May 14 19:28:37.980216 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 14 19:28:37.980225 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 14 19:28:37.980237 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 14 19:28:37.980247 kernel: ACPI: Interpreter enabled
May 14 19:28:37.980256 kernel: ACPI: PM: (supports S0 S3 S5)
May 14 19:28:37.980266 kernel: ACPI: Using IOAPIC for interrupt routing
May 14 19:28:37.980276 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 14 19:28:37.980286 kernel: PCI: Using E820 reservations for host bridge windows
May 14 19:28:37.980295 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F
May 14 19:28:37.980305 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
May 14 19:28:37.980451 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
May 14 19:28:37.980553 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
May 14 19:28:37.980646 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge
May 14 19:28:37.980660 kernel: acpiphp: Slot [3] registered
May 14 19:28:37.980670 kernel: acpiphp: Slot [4] registered
May 14 19:28:37.980680 kernel: acpiphp: Slot [5] registered
May 14 19:28:37.980690 kernel: acpiphp: Slot [6] registered
May 14 19:28:37.980700 kernel: acpiphp: Slot [7] registered
May 14 19:28:37.980714 kernel: acpiphp: Slot [8] registered
May 14 19:28:37.980749 kernel: acpiphp: Slot [9] registered
May 14 19:28:37.980766 kernel: acpiphp: Slot [10] registered
May 14 19:28:37.980787 kernel: acpiphp: Slot [11] registered
May 14 19:28:37.980797 kernel: acpiphp: Slot [12] registered
May 14 19:28:37.980807 kernel: acpiphp: Slot [13] registered
May 14 19:28:37.980817 kernel: acpiphp: Slot [14] registered
May 14 19:28:37.980827 kernel: acpiphp: Slot [15] registered
May 14 19:28:37.980836 kernel: acpiphp: Slot [16] registered
May 14 19:28:37.980846 kernel: acpiphp: Slot [17] registered
May 14 19:28:37.980859 kernel: acpiphp: Slot [18] registered
May 14 19:28:37.980869 kernel: acpiphp: Slot [19] registered
May 14 19:28:37.980878 kernel: acpiphp: Slot [20] registered
May 14 19:28:37.980888 kernel: acpiphp: Slot [21] registered
May 14 19:28:37.980897 kernel: acpiphp: Slot [22] registered
May 14 19:28:37.980907 kernel: acpiphp: Slot [23] registered
May 14 19:28:37.980917 kernel: acpiphp: Slot [24] registered
May 14 19:28:37.980927 kernel: acpiphp: Slot [25] registered
May 14 19:28:37.980936 kernel: acpiphp: Slot [26] registered
May 14 19:28:37.980948 kernel: acpiphp: Slot [27] registered
May 14 19:28:37.980957 kernel: acpiphp: Slot [28] registered
May 14 19:28:37.980967 kernel: acpiphp: Slot [29] registered
May 14 19:28:37.980977 kernel: acpiphp: Slot [30] registered
May 14 19:28:37.980986 kernel: acpiphp: Slot [31] registered
May 14 19:28:37.980995 kernel: PCI host bridge to bus 0000:00
May 14 19:28:37.981098 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
May 14 19:28:37.981209 kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
May 14 19:28:37.981300 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
May 14 19:28:37.981382 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
May 14 19:28:37.981463 kernel: pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window]
May 14 19:28:37.981543 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
May 14 19:28:37.981656 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint
May 14 19:28:37.981764 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint
May 14 19:28:37.981866 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint
May 14 19:28:37.981966 kernel: pci 0000:00:01.1: BAR 4 [io  0xc120-0xc12f]
May 14 19:28:37.982060 kernel: pci 0000:00:01.1: BAR 0 [io  0x01f0-0x01f7]: legacy IDE quirk
May 14 19:28:37.984941 kernel: pci 0000:00:01.1: BAR 1 [io  0x03f6]: legacy IDE quirk
May 14 19:28:37.985111 kernel: pci 0000:00:01.1: BAR 2 [io  0x0170-0x0177]: legacy IDE quirk
May 14 19:28:37.985351 kernel: pci 0000:00:01.1: BAR 3 [io  0x0376]: legacy IDE quirk
May 14 19:28:37.985533 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint
May 14 19:28:37.985694 kernel: pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
May 14 19:28:37.985841 kernel: pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
May 14 19:28:37.985977 kernel: pci 0000:00:02.0: [1af4:1050] type 00 class 0x030000 conventional PCI endpoint
May 14 19:28:37.986109 kernel: pci 0000:00:02.0: BAR 0 [mem 0xfe000000-0xfe7fffff pref]
May 14 19:28:37.988940 kernel: pci 0000:00:02.0: BAR 2 [mem 0xc000000000-0xc000003fff 64bit pref]
May 14 19:28:37.989074 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfeb90000-0xfeb90fff]
May 14 19:28:37.989199 kernel: pci 0000:00:02.0: ROM [mem 0xfeb80000-0xfeb8ffff pref]
May 14 19:28:37.989303 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
May 14 19:28:37.989407 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
May 14 19:28:37.989505 kernel: pci 0000:00:03.0: BAR 0 [io  0xc080-0xc0bf]
May 14 19:28:37.989641 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfeb91000-0xfeb91fff]
May 14 19:28:37.989738 kernel: pci 0000:00:03.0: BAR 4 [mem 0xc000004000-0xc000007fff 64bit pref]
May 14 19:28:37.989830 kernel: pci 0000:00:03.0: ROM [mem 0xfeb00000-0xfeb7ffff pref]
May 14 19:28:37.989934 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
May 14 19:28:37.990034 kernel: pci 0000:00:04.0: BAR 0 [io  0xc000-0xc07f]
May 14 19:28:37.990128 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfeb92000-0xfeb92fff]
May 14 19:28:37.990248 kernel: pci 0000:00:04.0: BAR 4 [mem 0xc000008000-0xc00000bfff 64bit pref]
May 14 19:28:37.990354 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint
May 14 19:28:37.990449 kernel: pci 0000:00:05.0: BAR 0 [io  0xc0c0-0xc0ff]
May 14 19:28:37.990543 kernel: pci 0000:00:05.0: BAR 4 [mem 0xc00000c000-0xc00000ffff 64bit pref]
May 14 19:28:37.990642 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
May 14 19:28:37.990742 kernel: pci 0000:00:06.0: BAR 0 [io  0xc100-0xc11f]
May 14 19:28:37.990850 kernel: pci 0000:00:06.0: BAR 1 [mem 0xfeb93000-0xfeb93fff]
May 14 19:28:37.990997 kernel: pci 0000:00:06.0: BAR 4 [mem 0xc000010000-0xc000013fff 64bit pref]
May 14 19:28:37.991020 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10
May 14 19:28:37.991036 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10
May 14 19:28:37.991050 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11
May 14 19:28:37.991066 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11
May 14 19:28:37.991082 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9
May 14 19:28:37.991102 kernel: iommu: Default domain type: Translated
May 14 19:28:37.991118 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 14 19:28:37.991133 kernel: PCI: Using ACPI for IRQ routing
May 14 19:28:37.993213 kernel: PCI: pci_cache_line_size set to 64 bytes
May 14 19:28:37.993231 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
May 14 19:28:37.993246 kernel: e820: reserve RAM buffer [mem 0xbffdd000-0xbfffffff]
May 14 19:28:37.993423 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device
May 14 19:28:37.993590 kernel: pci 0000:00:02.0: vgaarb: bridge control possible
May 14 19:28:37.993744 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
May 14 19:28:37.993766 kernel: vgaarb: loaded
May 14 19:28:37.993781 kernel: clocksource: Switched to clocksource kvm-clock
May 14 19:28:37.993799 kernel: VFS: Disk quotas dquot_6.6.0
May 14 19:28:37.993814 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 14 19:28:37.993830 kernel: pnp: PnP ACPI init
May 14 19:28:37.993975 kernel: pnp 00:03: [dma 2]
May 14 19:28:37.994001 kernel: pnp: PnP ACPI: found 5 devices
May 14 19:28:37.994018 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 14 19:28:37.994039 kernel: NET: Registered PF_INET protocol family
May 14 19:28:37.994056 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
May 14 19:28:37.994072 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
May 14 19:28:37.994090 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 14 19:28:37.994106 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 14 19:28:37.994118 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
May 14 19:28:37.994131 kernel: TCP: Hash tables configured (established 32768 bind 32768)
May 14 19:28:37.995186 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 14 19:28:37.995211 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 14 19:28:37.995225 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 14 19:28:37.995241 kernel: NET: Registered PF_XDP protocol family
May 14 19:28:37.995389 kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
May 14 19:28:37.995518 kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
May 14 19:28:37.995646 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
May 14 19:28:37.995773 kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
May 14 19:28:37.995902 kernel: pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window]
May 14 19:28:37.996059 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release
May 14 19:28:37.998321 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers
May 14 19:28:37.998362 kernel: PCI: CLS 0 bytes, default 64
May 14 19:28:37.998380 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 14 19:28:37.998397 kernel: software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB)
May 14 19:28:37.998413 kernel: Initialise system trusted keyrings
May 14 19:28:37.998430 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
May 14 19:28:37.998446 kernel: Key type asymmetric registered
May 14 19:28:37.998462 kernel: Asymmetric key parser 'x509' registered
May 14 19:28:37.998485 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
May 14 19:28:37.998501 kernel: io scheduler mq-deadline registered
May 14 19:28:37.998516 kernel: io scheduler kyber registered
May 14 19:28:37.998531 kernel: io scheduler bfq registered
May 14 19:28:37.998546 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
May 14 19:28:37.998561 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10
May 14 19:28:37.998577 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11
May 14 19:28:37.998592 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11
May 14 19:28:37.998609 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10
May 14 19:28:37.998628 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 14 19:28:37.998643 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 14 19:28:37.998658 kernel: random: crng init done
May 14 19:28:37.998673 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
May 14 19:28:37.998722 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
May 14 19:28:37.998739 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
May 14 19:28:37.998754 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
May 14 19:28:37.998923 kernel: rtc_cmos 00:04: RTC can wake from S4
May 14 19:28:37.999064 kernel: rtc_cmos 00:04: registered as rtc0
May 14 19:28:38.000326 kernel: rtc_cmos 00:04: setting system clock to 2025-05-14T19:28:37 UTC (1747250917)
May 14 19:28:38.000466 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram
May 14 19:28:38.000491 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
May 14 19:28:38.000507 kernel: NET: Registered PF_INET6 protocol family
May 14 19:28:38.000523 kernel: Segment Routing with IPv6
May 14 19:28:38.000538 kernel: In-situ OAM (IOAM) with IPv6
May 14 19:28:38.000553 kernel: NET: Registered PF_PACKET protocol family
May 14 19:28:38.000568 kernel: Key type dns_resolver registered
May 14 19:28:38.000590 kernel: IPI shorthand broadcast: enabled
May 14 19:28:38.000607 kernel: sched_clock: Marking stable (3671016258, 182198452)->(3861699667, -8484957)
May 14 19:28:38.000623 kernel: registered taskstats version 1
May 14 19:28:38.000639 kernel: Loading compiled-in X.509 certificates
May 14 19:28:38.000655 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.20-flatcar: 41e2a150aa08ec2528be2394819b3db677e5f4ef'
May 14 19:28:38.000670 kernel: Demotion targets for Node 0: null
May 14 19:28:38.000685 kernel: Key type .fscrypt registered
May 14 19:28:38.000699 kernel: Key type fscrypt-provisioning registered
May 14 19:28:38.000714 kernel: ima: No TPM chip found, activating TPM-bypass!
May 14 19:28:38.000755 kernel: ima: Allocated hash algorithm: sha1
May 14 19:28:38.000771 kernel: ima: No architecture policies found
May 14 19:28:38.000787 kernel: clk: Disabling unused clocks
May 14 19:28:38.000803 kernel: Warning: unable to open an initial console.
May 14 19:28:38.000821 kernel: Freeing unused kernel image (initmem) memory: 54424K
May 14 19:28:38.000836 kernel: Write protecting the kernel read-only data: 24576k
May 14 19:28:38.000851 kernel: Freeing unused kernel image (rodata/data gap) memory: 296K
May 14 19:28:38.000866 kernel: Run /init as init process
May 14 19:28:38.000881 kernel:   with arguments:
May 14 19:28:38.000900 kernel:     /init
May 14 19:28:38.000915 kernel:   with environment:
May 14 19:28:38.000930 kernel:     HOME=/
May 14 19:28:38.000945 kernel:     TERM=linux
May 14 19:28:38.000959 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 14 19:28:38.000979 systemd[1]: Successfully made /usr/ read-only.
May 14 19:28:38.001001 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)
May 14 19:28:38.001035 systemd[1]: Detected virtualization kvm.
May 14 19:28:38.001052 systemd[1]: Detected architecture x86-64.
May 14 19:28:38.001068 systemd[1]: Running in initrd.
May 14 19:28:38.001079 systemd[1]: No hostname configured, using default hostname.
May 14 19:28:38.001090 systemd[1]: Hostname set to <localhost>.
May 14 19:28:38.001100 systemd[1]: Initializing machine ID from VM UUID.
May 14 19:28:38.001114 systemd[1]: Queued start job for default target initrd.target.
May 14 19:28:38.001124 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 14 19:28:38.001357 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 14 19:28:38.001379 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 14 19:28:38.001391 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 14 19:28:38.001402 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 14 19:28:38.001413 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 14 19:28:38.001428 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
May 14 19:28:38.001439 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 14 19:28:38.001450 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 14 19:28:38.001461 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 14 19:28:38.001472 systemd[1]: Reached target paths.target - Path Units.
May 14 19:28:38.001483 systemd[1]: Reached target slices.target - Slice Units.
May 14 19:28:38.001493 systemd[1]: Reached target swap.target - Swaps.
May 14 19:28:38.001508 systemd[1]: Reached target timers.target - Timer Units.
May 14 19:28:38.001528 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 14 19:28:38.001545 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 14 19:28:38.001561 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 14 19:28:38.001578 systemd[1]: Listening on systemd-journald.socket - Journal Sockets.
May 14 19:28:38.001595 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 14 19:28:38.001612 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 14 19:28:38.001630 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 14 19:28:38.001647 systemd[1]: Reached target sockets.target - Socket Units.
May 14 19:28:38.001664 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 14 19:28:38.001685 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 14 19:28:38.001703 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 14 19:28:38.001724 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).
May 14 19:28:38.001742 systemd[1]: Starting systemd-fsck-usr.service...
May 14 19:28:38.001759 systemd[1]: Starting systemd-journald.service - Journal Service...
May 14 19:28:38.001782 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 14 19:28:38.001799 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 19:28:38.001817 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 14 19:28:38.001835 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
May 14 19:28:38.001893 systemd-journald[212]: Collecting audit messages is disabled.
May 14 19:28:38.001936 kernel: Bridge firewalling registered
May 14 19:28:38.001959 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 14 19:28:38.001980 systemd[1]: Finished systemd-fsck-usr.service.
May 14 19:28:38.001998 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 14 19:28:38.002016 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 14 19:28:38.002036 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 14 19:28:38.002054 systemd-journald[212]: Journal started
May 14 19:28:38.002091 systemd-journald[212]: Runtime Journal (/run/log/journal/9aa8709c5ffd4362897a8ae24c102794) is 8M, max 78.5M, 70.5M free.
May 14 19:28:37.939890 systemd-modules-load[214]: Inserted module 'overlay'
May 14 19:28:37.980814 systemd-modules-load[214]: Inserted module 'br_netfilter'
May 14 19:28:38.052179 systemd[1]: Started systemd-journald.service - Journal Service.
May 14 19:28:38.054457 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 14 19:28:38.058632 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 14 19:28:38.061247 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 14 19:28:38.075514 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 14 19:28:38.076287 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 14 19:28:38.080299 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 14 19:28:38.084206 systemd-tmpfiles[233]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring.
May 14 19:28:38.088564 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 14 19:28:38.092254 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 14 19:28:38.097760 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 14 19:28:38.103244 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 14 19:28:38.105770 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 14 19:28:38.133181 dracut-cmdline[254]: 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0
May 14 19:28:38.138962 systemd-resolved[248]: Positive Trust Anchors:
May 14 19:28:38.138974 systemd-resolved[248]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 14 19:28:38.139018 systemd-resolved[248]: 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
May 14 19:28:38.142668 systemd-resolved[248]: Defaulting to hostname 'linux'.
May 14 19:28:38.143649 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 14 19:28:38.151242 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 14 19:28:38.217245 kernel: SCSI subsystem initialized
May 14 19:28:38.228163 kernel: Loading iSCSI transport class v2.0-870.
May 14 19:28:38.241199 kernel: iscsi: registered transport (tcp)
May 14 19:28:38.292498 kernel: iscsi: registered transport (qla4xxx)
May 14 19:28:38.292597 kernel: QLogic iSCSI HBA Driver
May 14 19:28:38.329592 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 14 19:28:38.352970 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 14 19:28:38.359303 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 14 19:28:38.451352 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 14 19:28:38.456772 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 14 19:28:38.544248 kernel: raid6: sse2x4   gen()  5194 MB/s
May 14 19:28:38.562878 kernel: raid6: sse2x2   gen() 14269 MB/s
May 14 19:28:38.580599 kernel: raid6: sse2x1   gen()  9903 MB/s
May 14 19:28:38.580661 kernel: raid6: using algorithm sse2x2 gen() 14269 MB/s
May 14 19:28:38.599621 kernel: raid6: .... xor() 9130 MB/s, rmw enabled
May 14 19:28:38.599679 kernel: raid6: using ssse3x2 recovery algorithm
May 14 19:28:38.623199 kernel: xor: measuring software checksum speed
May 14 19:28:38.623286 kernel:    prefetch64-sse  : 16985 MB/sec
May 14 19:28:38.625657 kernel:    generic_sse     : 16841 MB/sec
May 14 19:28:38.625705 kernel: xor: using function: prefetch64-sse (16985 MB/sec)
May 14 19:28:38.826202 kernel: Btrfs loaded, zoned=no, fsverity=no
May 14 19:28:38.832535 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 14 19:28:38.837338 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 14 19:28:38.864968 systemd-udevd[462]: Using default interface naming scheme 'v255'.
May 14 19:28:38.870740 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 14 19:28:38.877259 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 14 19:28:38.905209 dracut-pre-trigger[473]: rd.md=0: removing MD RAID activation
May 14 19:28:38.932774 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 14 19:28:38.937255 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 14 19:28:38.987869 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 14 19:28:38.993070 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 14 19:28:39.073164 kernel: virtio_blk virtio2: 2/0/0 default/read/poll queues
May 14 19:28:39.134289 kernel: virtio_blk virtio2: [vda] 20971520 512-byte logical blocks (10.7 GB/10.0 GiB)
May 14 19:28:39.134421 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
May 14 19:28:39.134438 kernel: GPT:17805311 != 20971519
May 14 19:28:39.134453 kernel: GPT:Alternate GPT header not at the end of the disk.
May 14 19:28:39.134466 kernel: GPT:17805311 != 20971519
May 14 19:28:39.134479 kernel: GPT: Use GNU Parted to correct GPT errors.
May 14 19:28:39.134493 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 19:28:39.134506 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2
May 14 19:28:39.134523 kernel: libata version 3.00 loaded.
May 14 19:28:39.133197 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 19:28:39.133354 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 19:28:39.136033 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 14 19:28:39.140265 kernel: ata_piix 0000:00:01.1: version 2.13
May 14 19:28:39.148907 kernel: scsi host0: ata_piix
May 14 19:28:39.149051 kernel: scsi host1: ata_piix
May 14 19:28:39.149204 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 lpm-pol 0
May 14 19:28:39.149221 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 lpm-pol 0
May 14 19:28:39.139377 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 19:28:39.142373 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 14 19:28:39.195587 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
May 14 19:28:39.226993 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 14 19:28:39.261402 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
May 14 19:28:39.272762 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 14 19:28:39.281823 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
May 14 19:28:39.282447 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
May 14 19:28:39.286110 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 14 19:28:39.307475 disk-uuid[557]: Primary Header is updated.
May 14 19:28:39.307475 disk-uuid[557]: Secondary Entries is updated.
May 14 19:28:39.307475 disk-uuid[557]: Secondary Header is updated.
May 14 19:28:39.322175 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 19:28:39.336176 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 19:28:39.741588 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 14 19:28:39.743748 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 14 19:28:39.747381 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 14 19:28:39.749270 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 14 19:28:39.755377 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 14 19:28:39.792813 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 14 19:28:40.338229 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 19:28:40.339255 disk-uuid[558]: The operation has completed successfully.
May 14 19:28:40.409235 systemd[1]: disk-uuid.service: Deactivated successfully.
May 14 19:28:40.409343 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 14 19:28:40.441183 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 14 19:28:40.470033 sh[587]: Success
May 14 19:28:40.510501 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 14 19:28:40.510587 kernel: device-mapper: uevent: version 1.0.3
May 14 19:28:40.512558 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
May 14 19:28:40.530163 kernel: device-mapper: verity: sha256 using shash "sha256-ssse3"
May 14 19:28:40.594472 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 14 19:28:40.597369 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 14 19:28:40.615522 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 14 19:28:40.628165 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay'
May 14 19:28:40.632171 kernel: BTRFS: device fsid dedcf745-d4ff-44ac-b61c-5ec1bad114c7 devid 1 transid 39 /dev/mapper/usr (253:0) scanned by mount (599)
May 14 19:28:40.636990 kernel: BTRFS info (device dm-0): first mount of filesystem dedcf745-d4ff-44ac-b61c-5ec1bad114c7
May 14 19:28:40.637055 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
May 14 19:28:40.637083 kernel: BTRFS info (device dm-0): using free-space-tree
May 14 19:28:40.651757 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 14 19:28:40.652478 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System.
May 14 19:28:40.654057 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 14 19:28:40.654769 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 14 19:28:40.663878 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 14 19:28:40.692186 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (622)
May 14 19:28:40.698170 kernel: BTRFS info (device vda6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 19:28:40.703623 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 14 19:28:40.703651 kernel: BTRFS info (device vda6): using free-space-tree
May 14 19:28:40.717171 kernel: BTRFS info (device vda6): last unmount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 19:28:40.719125 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 14 19:28:40.721968 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 14 19:28:40.775747 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 14 19:28:40.779847 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 14 19:28:40.818373 systemd-networkd[772]: lo: Link UP
May 14 19:28:40.818383 systemd-networkd[772]: lo: Gained carrier
May 14 19:28:40.819450 systemd-networkd[772]: Enumeration completed
May 14 19:28:40.819526 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 14 19:28:40.819836 systemd-networkd[772]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 19:28:40.819840 systemd-networkd[772]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 14 19:28:40.820645 systemd-networkd[772]: eth0: Link UP
May 14 19:28:40.820648 systemd-networkd[772]: eth0: Gained carrier
May 14 19:28:40.820657 systemd-networkd[772]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 19:28:40.824437 systemd[1]: Reached target network.target - Network.
May 14 19:28:40.837217 systemd-networkd[772]: eth0: DHCPv4 address 172.24.4.14/24, gateway 172.24.4.1 acquired from 172.24.4.1
May 14 19:28:40.942615 ignition[687]: Ignition 2.21.0
May 14 19:28:40.942629 ignition[687]: Stage: fetch-offline
May 14 19:28:40.944106 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 14 19:28:40.942660 ignition[687]: no configs at "/usr/lib/ignition/base.d"
May 14 19:28:40.946958 systemd-resolved[248]: Detected conflict on linux IN A 172.24.4.14
May 14 19:28:40.942669 ignition[687]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:40.946972 systemd-resolved[248]: Hostname conflict, changing published hostname from 'linux' to 'linux2'.
May 14 19:28:40.942749 ignition[687]: parsed url from cmdline: ""
May 14 19:28:40.947248 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
May 14 19:28:40.942752 ignition[687]: no config URL provided
May 14 19:28:40.942757 ignition[687]: reading system config file "/usr/lib/ignition/user.ign"
May 14 19:28:40.942764 ignition[687]: no config at "/usr/lib/ignition/user.ign"
May 14 19:28:40.942769 ignition[687]: failed to fetch config: resource requires networking
May 14 19:28:40.942915 ignition[687]: Ignition finished successfully
May 14 19:28:40.968551 ignition[781]: Ignition 2.21.0
May 14 19:28:40.968564 ignition[781]: Stage: fetch
May 14 19:28:40.968710 ignition[781]: no configs at "/usr/lib/ignition/base.d"
May 14 19:28:40.968738 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:40.968816 ignition[781]: parsed url from cmdline: ""
May 14 19:28:40.968820 ignition[781]: no config URL provided
May 14 19:28:40.968826 ignition[781]: reading system config file "/usr/lib/ignition/user.ign"
May 14 19:28:40.968833 ignition[781]: no config at "/usr/lib/ignition/user.ign"
May 14 19:28:40.968963 ignition[781]: config drive ("/dev/disk/by-label/config-2") not found. Waiting...
May 14 19:28:40.968991 ignition[781]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting...
May 14 19:28:40.969034 ignition[781]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1
May 14 19:28:41.253611 ignition[781]: GET result: OK
May 14 19:28:41.253757 ignition[781]: parsing config with SHA512: e16d2e5e210ec091289d0d30fe98700cd863d184638cf57822a6259bc7e6751537846632d6b0d1914e54276eb8431b5676198b47fb3848cf1040bcd45795b5cd
May 14 19:28:41.268489 unknown[781]: fetched base config from "system"
May 14 19:28:41.268529 unknown[781]: fetched base config from "system"
May 14 19:28:41.269309 ignition[781]: fetch: fetch complete
May 14 19:28:41.268550 unknown[781]: fetched user config from "openstack"
May 14 19:28:41.269340 ignition[781]: fetch: fetch passed
May 14 19:28:41.276983 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
May 14 19:28:41.269454 ignition[781]: Ignition finished successfully
May 14 19:28:41.281469 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 14 19:28:41.337222 ignition[788]: Ignition 2.21.0
May 14 19:28:41.337255 ignition[788]: Stage: kargs
May 14 19:28:41.337658 ignition[788]: no configs at "/usr/lib/ignition/base.d"
May 14 19:28:41.337690 ignition[788]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:41.343375 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 14 19:28:41.339801 ignition[788]: kargs: kargs passed
May 14 19:28:41.339922 ignition[788]: Ignition finished successfully
May 14 19:28:41.350483 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 14 19:28:41.395959 ignition[795]: Ignition 2.21.0
May 14 19:28:41.395977 ignition[795]: Stage: disks
May 14 19:28:41.396220 ignition[795]: no configs at "/usr/lib/ignition/base.d"
May 14 19:28:41.396234 ignition[795]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:41.400879 ignition[795]: disks: disks passed
May 14 19:28:41.400963 ignition[795]: Ignition finished successfully
May 14 19:28:41.402324 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 14 19:28:41.403356 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 14 19:28:41.404273 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 14 19:28:41.405675 systemd[1]: Reached target local-fs.target - Local File Systems.
May 14 19:28:41.406965 systemd[1]: Reached target sysinit.target - System Initialization.
May 14 19:28:41.408057 systemd[1]: Reached target basic.target - Basic System.
May 14 19:28:41.410334 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 14 19:28:41.449219 systemd-fsck[803]: ROOT: clean, 15/1628000 files, 120826/1617920 blocks
May 14 19:28:41.475308 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 14 19:28:41.479467 systemd[1]: Mounting sysroot.mount - /sysroot...
May 14 19:28:41.683213 kernel: EXT4-fs (vda9): mounted filesystem d6072e19-4548-4806-a012-87bb17c59f4c r/w with ordered data mode. Quota mode: none.
May 14 19:28:41.685565 systemd[1]: Mounted sysroot.mount - /sysroot.
May 14 19:28:41.698374 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 14 19:28:41.703085 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 14 19:28:41.710351 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 14 19:28:41.716904 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
May 14 19:28:41.723473 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent...
May 14 19:28:41.727672 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 14 19:28:41.727774 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 14 19:28:41.745466 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 14 19:28:41.748975 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (811)
May 14 19:28:41.756203 kernel: BTRFS info (device vda6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 19:28:41.757537 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 14 19:28:41.769431 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 14 19:28:41.769473 kernel: BTRFS info (device vda6): using free-space-tree
May 14 19:28:41.794967 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 14 19:28:41.891172 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev
May 14 19:28:41.897874 initrd-setup-root[840]: cut: /sysroot/etc/passwd: No such file or directory
May 14 19:28:41.907015 initrd-setup-root[847]: cut: /sysroot/etc/group: No such file or directory
May 14 19:28:41.913297 initrd-setup-root[854]: cut: /sysroot/etc/shadow: No such file or directory
May 14 19:28:41.920003 initrd-setup-root[861]: cut: /sysroot/etc/gshadow: No such file or directory
May 14 19:28:42.061351 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 14 19:28:42.065433 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 14 19:28:42.070316 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 14 19:28:42.085622 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 14 19:28:42.093173 kernel: BTRFS info (device vda6): last unmount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 19:28:42.115529 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 14 19:28:42.130176 ignition[929]: INFO     : Ignition 2.21.0
May 14 19:28:42.130176 ignition[929]: INFO     : Stage: mount
May 14 19:28:42.131780 ignition[929]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 14 19:28:42.131780 ignition[929]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:42.131780 ignition[929]: INFO     : mount: mount passed
May 14 19:28:42.131780 ignition[929]: INFO     : Ignition finished successfully
May 14 19:28:42.133250 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 14 19:28:42.664458 systemd-networkd[772]: eth0: Gained IPv6LL
May 14 19:28:42.933281 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev
May 14 19:28:44.946202 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev
May 14 19:28:48.957212 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev
May 14 19:28:48.963063 coreos-metadata[813]: May 14 19:28:48.963 WARN failed to locate config-drive, using the metadata service API instead
May 14 19:28:48.992521 coreos-metadata[813]: May 14 19:28:48.992 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1
May 14 19:28:49.005669 coreos-metadata[813]: May 14 19:28:49.005 INFO Fetch successful
May 14 19:28:49.007307 coreos-metadata[813]: May 14 19:28:49.007 INFO wrote hostname ci-4334-0-0-a-e9a669369a.novalocal to /sysroot/etc/hostname
May 14 19:28:49.009537 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully.
May 14 19:28:49.009729 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent.
May 14 19:28:49.017892 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 14 19:28:49.045352 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 14 19:28:49.077230 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (946)
May 14 19:28:49.088962 kernel: BTRFS info (device vda6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 19:28:49.089067 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 14 19:28:49.089098 kernel: BTRFS info (device vda6): using free-space-tree
May 14 19:28:49.103918 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 14 19:28:49.163537 ignition[964]: INFO     : Ignition 2.21.0
May 14 19:28:49.163537 ignition[964]: INFO     : Stage: files
May 14 19:28:49.167792 ignition[964]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 14 19:28:49.167792 ignition[964]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:49.167792 ignition[964]: DEBUG    : files: compiled without relabeling support, skipping
May 14 19:28:49.173869 ignition[964]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 14 19:28:49.176237 ignition[964]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 14 19:28:49.200802 ignition[964]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 14 19:28:49.202654 ignition[964]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 14 19:28:49.202654 ignition[964]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 14 19:28:49.201611 unknown[964]: wrote ssh authorized keys file for user: core
May 14 19:28:49.211076 ignition[964]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 14 19:28:49.213404 ignition[964]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 14 19:28:49.213404 ignition[964]: INFO     : files: op(4): [started]  processing unit "coreos-metadata.service"
May 14 19:28:49.229216 ignition[964]: INFO     : files: op(4): op(5): [started]  writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/20-clct-provider-override.conf"
May 14 19:28:49.237116 ignition[964]: INFO     : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/20-clct-provider-override.conf"
May 14 19:28:49.237116 ignition[964]: INFO     : files: op(4): [finished] processing unit "coreos-metadata.service"
May 14 19:28:49.237116 ignition[964]: INFO     : files: op(6): [started]  processing unit "coreos-metadata-sshkeys@.service"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(6): op(7): [started]  writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata-sshkeys@.service.d/20-clct-provider-override.conf"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(6): op(7): [finished] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata-sshkeys@.service.d/20-clct-provider-override.conf"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(6): [finished] processing unit "coreos-metadata-sshkeys@.service"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(8): [started]  processing unit "etcd-member.service"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(8): op(9): [started]  writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(8): op(9): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(8): [finished] processing unit "etcd-member.service"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(a): [started]  setting preset to enabled for "coreos-metadata-sshkeys@.service "
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(a): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service "
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(b): [started]  setting preset to enabled for "etcd-member.service"
May 14 19:28:49.246006 ignition[964]: INFO     : files: op(b): [finished] setting preset to enabled for "etcd-member.service"
May 14 19:28:49.246006 ignition[964]: INFO     : files: createResultFile: createFiles: op(c): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 14 19:28:49.246006 ignition[964]: INFO     : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 14 19:28:49.246006 ignition[964]: INFO     : files: files passed
May 14 19:28:49.246006 ignition[964]: INFO     : Ignition finished successfully
May 14 19:28:49.247016 systemd[1]: Finished ignition-files.service - Ignition (files).
May 14 19:28:49.257404 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 14 19:28:49.262414 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 14 19:28:49.288101 systemd[1]: ignition-quench.service: Deactivated successfully.
May 14 19:28:49.288543 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 14 19:28:49.309176 initrd-setup-root-after-ignition[994]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 14 19:28:49.309176 initrd-setup-root-after-ignition[994]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 14 19:28:49.312913 initrd-setup-root-after-ignition[998]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 14 19:28:49.313707 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 14 19:28:49.314607 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 14 19:28:49.320974 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 14 19:28:49.370989 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 14 19:28:49.371129 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 14 19:28:49.372509 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 14 19:28:49.373589 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 14 19:28:49.374813 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 14 19:28:49.375760 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 14 19:28:49.415635 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 14 19:28:49.422226 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 14 19:28:49.479931 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 14 19:28:49.483601 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 14 19:28:49.485408 systemd[1]: Stopped target timers.target - Timer Units.
May 14 19:28:49.488428 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 14 19:28:49.488793 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 14 19:28:49.492009 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 14 19:28:49.493993 systemd[1]: Stopped target basic.target - Basic System.
May 14 19:28:49.496772 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 14 19:28:49.499407 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 14 19:28:49.502207 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 14 19:28:49.505664 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System.
May 14 19:28:49.509068 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 14 19:28:49.512472 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 14 19:28:49.515749 systemd[1]: Stopped target sysinit.target - System Initialization.
May 14 19:28:49.519058 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 14 19:28:49.521912 systemd[1]: Stopped target swap.target - Swaps.
May 14 19:28:49.524497 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 14 19:28:49.524879 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 14 19:28:49.528092 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 14 19:28:49.530123 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 14 19:28:49.532597 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 14 19:28:49.533366 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 14 19:28:49.535852 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 14 19:28:49.536370 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 14 19:28:49.539889 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 14 19:28:49.540372 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 14 19:28:49.543386 systemd[1]: ignition-files.service: Deactivated successfully.
May 14 19:28:49.543767 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 14 19:28:49.549333 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 14 19:28:49.557425 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 14 19:28:49.561876 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 14 19:28:49.562923 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 14 19:28:49.564128 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 14 19:28:49.564653 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 14 19:28:49.575393 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 14 19:28:49.575492 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 14 19:28:49.592629 ignition[1018]: INFO     : Ignition 2.21.0
May 14 19:28:49.592629 ignition[1018]: INFO     : Stage: umount
May 14 19:28:49.595813 ignition[1018]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 14 19:28:49.595813 ignition[1018]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 14 19:28:49.595813 ignition[1018]: INFO     : umount: umount passed
May 14 19:28:49.595813 ignition[1018]: INFO     : Ignition finished successfully
May 14 19:28:49.595657 systemd[1]: ignition-mount.service: Deactivated successfully.
May 14 19:28:49.595802 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 14 19:28:49.597738 systemd[1]: ignition-disks.service: Deactivated successfully.
May 14 19:28:49.597793 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 14 19:28:49.599773 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 14 19:28:49.599815 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 14 19:28:49.600337 systemd[1]: ignition-fetch.service: Deactivated successfully.
May 14 19:28:49.600378 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
May 14 19:28:49.600876 systemd[1]: Stopped target network.target - Network.
May 14 19:28:49.603919 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 14 19:28:49.603967 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 14 19:28:49.605040 systemd[1]: Stopped target paths.target - Path Units.
May 14 19:28:49.605573 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 14 19:28:49.609367 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 14 19:28:49.611037 systemd[1]: Stopped target slices.target - Slice Units.
May 14 19:28:49.612317 systemd[1]: Stopped target sockets.target - Socket Units.
May 14 19:28:49.612938 systemd[1]: iscsid.socket: Deactivated successfully.
May 14 19:28:49.612980 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 14 19:28:49.613697 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 14 19:28:49.613732 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 14 19:28:49.617879 systemd[1]: ignition-setup.service: Deactivated successfully.
May 14 19:28:49.617934 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 14 19:28:49.618543 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 14 19:28:49.618588 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 14 19:28:49.619662 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 14 19:28:49.620822 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 14 19:28:49.623286 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 14 19:28:49.623896 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 14 19:28:49.623990 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 14 19:28:49.625070 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 14 19:28:49.626713 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 14 19:28:49.627912 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 14 19:28:49.628006 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 14 19:28:49.632040 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
May 14 19:28:49.632313 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 14 19:28:49.632417 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 14 19:28:49.634372 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
May 14 19:28:49.634974 systemd[1]: Stopped target network-pre.target - Preparation for Network.
May 14 19:28:49.641134 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 14 19:28:49.641222 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 14 19:28:49.643431 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 14 19:28:49.645493 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 14 19:28:49.645573 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 14 19:28:49.647583 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 14 19:28:49.647651 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 14 19:28:49.649275 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 14 19:28:49.649322 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 14 19:28:49.649877 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 14 19:28:49.649920 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 14 19:28:49.651115 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 14 19:28:49.653757 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
May 14 19:28:49.653844 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully.
May 14 19:28:49.663114 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 14 19:28:49.663516 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 14 19:28:49.665995 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 14 19:28:49.666042 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 14 19:28:49.667750 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 14 19:28:49.667785 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 14 19:28:49.668404 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 14 19:28:49.668471 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 14 19:28:49.669803 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 14 19:28:49.669853 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 14 19:28:49.671475 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 14 19:28:49.671526 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 14 19:28:49.673788 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 14 19:28:49.675939 systemd[1]: systemd-network-generator.service: Deactivated successfully.
May 14 19:28:49.676024 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line.
May 14 19:28:49.679324 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 14 19:28:49.679408 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 14 19:28:49.681160 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
May 14 19:28:49.681234 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 14 19:28:49.682731 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 14 19:28:49.682798 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 14 19:28:49.684985 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 19:28:49.685099 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 19:28:49.687402 systemd[1]: network-cleanup.service: Deactivated successfully.
May 14 19:28:49.691276 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 14 19:28:49.698460 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 14 19:28:49.698606 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 14 19:28:49.699944 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 14 19:28:49.702383 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 14 19:28:49.725364 systemd[1]: Switching root.
May 14 19:28:49.770832 systemd-journald[212]: Journal stopped
May 14 19:28:51.338891 systemd-journald[212]: Received SIGTERM from PID 1 (systemd).
May 14 19:28:51.338971 kernel: SELinux:  policy capability network_peer_controls=1
May 14 19:28:51.338988 kernel: SELinux:  policy capability open_perms=1
May 14 19:28:51.339005 kernel: SELinux:  policy capability extended_socket_class=1
May 14 19:28:51.339018 kernel: SELinux:  policy capability always_check_network=0
May 14 19:28:51.339030 kernel: SELinux:  policy capability cgroup_seclabel=1
May 14 19:28:51.339047 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 14 19:28:51.339059 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 14 19:28:51.339072 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 14 19:28:51.339090 kernel: SELinux:  policy capability userspace_initial_context=0
May 14 19:28:51.339104 systemd[1]: Successfully loaded SELinux policy in 57.979ms.
May 14 19:28:51.339131 kernel: audit: type=1403 audit(1747250929.949:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 14 19:28:51.341744 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 24.812ms.
May 14 19:28:51.341772 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)
May 14 19:28:51.341786 systemd[1]: Detected virtualization kvm.
May 14 19:28:51.341798 systemd[1]: Detected architecture x86-64.
May 14 19:28:51.341810 systemd[1]: Detected first boot.
May 14 19:28:51.341823 systemd[1]: Hostname set to <ci-4334-0-0-a-e9a669369a.novalocal>.
May 14 19:28:51.341836 systemd[1]: Initializing machine ID from VM UUID.
May 14 19:28:51.341848 zram_generator::config[1061]: No configuration found.
May 14 19:28:51.341864 kernel: Guest personality initialized and is inactive
May 14 19:28:51.341876 kernel: VMCI host device registered (name=vmci, major=10, minor=125)
May 14 19:28:51.341888 kernel: Initialized host personality
May 14 19:28:51.341899 kernel: NET: Registered PF_VSOCK protocol family
May 14 19:28:51.341910 systemd[1]: Populated /etc with preset unit settings.
May 14 19:28:51.341923 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully.
May 14 19:28:51.341935 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 14 19:28:51.341948 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 14 19:28:51.341960 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 14 19:28:51.341975 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 14 19:28:51.341988 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 14 19:28:51.342000 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys.
May 14 19:28:51.342014 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 14 19:28:51.342026 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 14 19:28:51.342042 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 14 19:28:51.342055 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 14 19:28:51.342067 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 14 19:28:51.342082 systemd[1]: Created slice user.slice - User and Session Slice.
May 14 19:28:51.342100 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 14 19:28:51.342113 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 14 19:28:51.342126 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 14 19:28:51.342157 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 14 19:28:51.342171 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 14 19:28:51.342186 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 14 19:28:51.342198 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
May 14 19:28:51.342211 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 14 19:28:51.342223 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 14 19:28:51.342235 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 14 19:28:51.342247 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 14 19:28:51.342259 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 14 19:28:51.342272 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 14 19:28:51.342284 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 14 19:28:51.342298 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 14 19:28:51.342310 systemd[1]: Reached target slices.target - Slice Units.
May 14 19:28:51.342322 systemd[1]: Reached target swap.target - Swaps.
May 14 19:28:51.342334 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 14 19:28:51.342346 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 14 19:28:51.342359 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption.
May 14 19:28:51.342371 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 14 19:28:51.342383 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 14 19:28:51.342395 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 14 19:28:51.342407 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 14 19:28:51.342421 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 14 19:28:51.342433 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 14 19:28:51.342445 systemd[1]: Mounting media.mount - External Media Directory...
May 14 19:28:51.342458 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:51.342470 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 14 19:28:51.342483 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 14 19:28:51.342495 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 14 19:28:51.342507 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).
May 14 19:28:51.342521 systemd[1]: Reached target machines.target - Containers.
May 14 19:28:51.342534 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 14 19:28:51.342547 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 19:28:51.342561 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 14 19:28:51.342573 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 14 19:28:51.342585 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 14 19:28:51.342597 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 14 19:28:51.342609 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 14 19:28:51.342623 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 14 19:28:51.342635 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 14 19:28:51.342649 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 14 19:28:51.342661 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 14 19:28:51.342674 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 14 19:28:51.342686 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 14 19:28:51.342698 systemd[1]: Stopped systemd-fsck-usr.service.
May 14 19:28:51.342711 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).
May 14 19:28:51.342723 kernel: loop: module loaded
May 14 19:28:51.342736 systemd[1]: Starting systemd-journald.service - Journal Service...
May 14 19:28:51.342749 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 14 19:28:51.342761 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 14 19:28:51.342774 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 14 19:28:51.342786 kernel: fuse: init (API version 7.41)
May 14 19:28:51.342800 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials...
May 14 19:28:51.342812 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 14 19:28:51.342827 systemd[1]: verity-setup.service: Deactivated successfully.
May 14 19:28:51.342839 systemd[1]: Stopped verity-setup.service.
May 14 19:28:51.342851 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:51.342866 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 14 19:28:51.342878 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 14 19:28:51.342891 systemd[1]: Mounted media.mount - External Media Directory.
May 14 19:28:51.342903 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 14 19:28:51.342915 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 14 19:28:51.342927 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 14 19:28:51.342941 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 14 19:28:51.342953 kernel: ACPI: bus type drm_connector registered
May 14 19:28:51.342964 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 14 19:28:51.342978 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 14 19:28:51.342991 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 14 19:28:51.343003 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 14 19:28:51.343015 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 14 19:28:51.343027 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 14 19:28:51.343039 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 14 19:28:51.343051 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 14 19:28:51.343063 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 14 19:28:51.343076 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 14 19:28:51.343090 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 14 19:28:51.343102 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 14 19:28:51.343114 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 14 19:28:51.343126 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 14 19:28:51.345869 systemd-journald[1144]: Collecting audit messages is disabled.
May 14 19:28:51.345915 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 14 19:28:51.345938 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 14 19:28:51.345961 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials.
May 14 19:28:51.345990 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 14 19:28:51.346012 systemd-journald[1144]: Journal started
May 14 19:28:51.346048 systemd-journald[1144]: Runtime Journal (/run/log/journal/9aa8709c5ffd4362897a8ae24c102794) is 8M, max 78.5M, 70.5M free.
May 14 19:28:50.911586 systemd[1]: Queued start job for default target multi-user.target.
May 14 19:28:50.931476 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
May 14 19:28:50.931905 systemd[1]: systemd-journald.service: Deactivated successfully.
May 14 19:28:51.353754 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 14 19:28:51.359164 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 14 19:28:51.367184 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 14 19:28:51.369517 systemd[1]: Reached target local-fs.target - Local File Systems.
May 14 19:28:51.373160 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management.
May 14 19:28:51.379183 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 14 19:28:51.385205 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 19:28:51.399185 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 14 19:28:51.399255 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 14 19:28:51.409176 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 14 19:28:51.413183 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 14 19:28:51.418046 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 14 19:28:51.421174 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 14 19:28:51.434193 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 14 19:28:51.441183 systemd[1]: Started systemd-journald.service - Journal Service.
May 14 19:28:51.443846 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 14 19:28:51.445399 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 14 19:28:51.446226 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 14 19:28:51.456555 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 14 19:28:51.470905 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 14 19:28:51.475290 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 14 19:28:51.476942 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk...
May 14 19:28:51.492299 kernel: loop0: detected capacity change from 0 to 113872
May 14 19:28:51.494602 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 14 19:28:51.512585 systemd-journald[1144]: Time spent on flushing to /var/log/journal/9aa8709c5ffd4362897a8ae24c102794 is 30.043ms for 974 entries.
May 14 19:28:51.512585 systemd-journald[1144]: System Journal (/var/log/journal/9aa8709c5ffd4362897a8ae24c102794) is 8M, max 584.8M, 576.8M free.
May 14 19:28:51.566609 systemd-journald[1144]: Received client request to flush runtime journal.
May 14 19:28:51.537648 systemd-tmpfiles[1181]: ACLs are not supported, ignoring.
May 14 19:28:51.537662 systemd-tmpfiles[1181]: ACLs are not supported, ignoring.
May 14 19:28:51.550919 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 14 19:28:51.554036 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 14 19:28:51.573573 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 14 19:28:51.571381 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk.
May 14 19:28:51.574236 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 14 19:28:51.601194 kernel: loop1: detected capacity change from 0 to 8
May 14 19:28:51.622187 kernel: loop2: detected capacity change from 0 to 146240
May 14 19:28:51.645800 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 14 19:28:51.651795 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 14 19:28:51.685377 kernel: loop3: detected capacity change from 0 to 113872
May 14 19:28:51.699627 systemd-tmpfiles[1220]: ACLs are not supported, ignoring.
May 14 19:28:51.700042 systemd-tmpfiles[1220]: ACLs are not supported, ignoring.
May 14 19:28:51.714216 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 14 19:28:51.718198 kernel: loop4: detected capacity change from 0 to 8
May 14 19:28:51.721207 kernel: loop5: detected capacity change from 0 to 146240
May 14 19:28:51.757868 (sd-merge)[1223]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-openstack'.
May 14 19:28:51.758303 (sd-merge)[1223]: Merged extensions into '/usr'.
May 14 19:28:51.764708 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 14 19:28:51.769576 systemd[1]: Starting ensure-sysext.service...
May 14 19:28:51.773295 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 14 19:28:51.807959 systemd[1]: Reload requested from client PID 1226 ('systemctl') (unit ensure-sysext.service)...
May 14 19:28:51.807976 systemd[1]: Reloading...
May 14 19:28:51.838766 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring.
May 14 19:28:51.840258 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring.
May 14 19:28:51.840550 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 14 19:28:51.840837 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 14 19:28:51.841733 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 14 19:28:51.842058 systemd-tmpfiles[1227]: ACLs are not supported, ignoring.
May 14 19:28:51.842127 systemd-tmpfiles[1227]: ACLs are not supported, ignoring.
May 14 19:28:51.849224 systemd-tmpfiles[1227]: Detected autofs mount point /boot during canonicalization of boot.
May 14 19:28:51.849236 systemd-tmpfiles[1227]: Skipping /boot
May 14 19:28:51.895463 systemd-tmpfiles[1227]: Detected autofs mount point /boot during canonicalization of boot.
May 14 19:28:51.895479 systemd-tmpfiles[1227]: Skipping /boot
May 14 19:28:51.911174 zram_generator::config[1251]: No configuration found.
May 14 19:28:52.229312 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.
May 14 19:28:52.345015 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 14 19:28:52.345316 systemd[1]: Reloading finished in 536 ms.
May 14 19:28:52.367333 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 14 19:28:52.374387 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 14 19:28:52.378415 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 14 19:28:52.381888 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 14 19:28:52.388519 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 14 19:28:52.395617 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 14 19:28:52.445896 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 14 19:28:52.456196 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 14 19:28:52.471168 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:52.471411 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 19:28:52.473654 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 14 19:28:52.483863 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 14 19:28:52.488359 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 14 19:28:52.489899 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 19:28:52.490054 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).
May 14 19:28:52.490229 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:52.495772 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:52.495981 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 19:28:52.497202 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 19:28:52.497353 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).
May 14 19:28:52.497501 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:52.506417 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 14 19:28:52.506705 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 14 19:28:52.517607 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:52.517929 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 19:28:52.522627 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 14 19:28:52.523422 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 19:28:52.523559 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).
May 14 19:28:52.523757 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 19:28:52.524629 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 14 19:28:52.525251 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 14 19:28:52.528476 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 14 19:28:52.531893 systemd[1]: Finished ensure-sysext.service.
May 14 19:28:52.536877 ldconfig[1176]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 14 19:28:52.543197 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
May 14 19:28:52.545064 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 14 19:28:52.554070 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 14 19:28:52.569721 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 14 19:28:52.571696 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 14 19:28:52.573563 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 14 19:28:52.580089 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 14 19:28:52.580615 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 14 19:28:52.584484 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 14 19:28:52.593775 augenrules[1354]: No rules
May 14 19:28:52.601350 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 14 19:28:52.602508 systemd[1]: audit-rules.service: Deactivated successfully.
May 14 19:28:52.602708 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 14 19:28:52.609229 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 14 19:28:52.613454 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 14 19:28:52.642073 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 14 19:28:52.642965 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).
May 14 19:28:52.654834 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 14 19:28:52.686939 systemd-udevd[1362]: Using default interface naming scheme 'v255'.
May 14 19:28:52.699093 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
May 14 19:28:52.701463 systemd[1]: Reached target time-set.target - System Time Set.
May 14 19:28:52.702800 systemd-resolved[1313]: Positive Trust Anchors:
May 14 19:28:52.702830 systemd-resolved[1313]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 14 19:28:52.702880 systemd-resolved[1313]: 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
May 14 19:28:52.713208 systemd-resolved[1313]: Using system hostname 'ci-4334-0-0-a-e9a669369a.novalocal'.
May 14 19:28:52.714687 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 14 19:28:52.715427 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 14 19:28:52.731462 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 14 19:28:52.732641 systemd[1]: Reached target sysinit.target - System Initialization.
May 14 19:28:52.733979 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 14 19:28:52.734637 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
May 14 19:28:52.735289 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer.
May 14 19:28:52.736404 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 14 19:28:52.737371 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 14 19:28:52.738559 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 14 19:28:52.739184 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 14 19:28:52.739227 systemd[1]: Reached target paths.target - Path Units.
May 14 19:28:52.739731 systemd[1]: Reached target timers.target - Timer Units.
May 14 19:28:52.742017 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 14 19:28:52.747087 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 14 19:28:52.754013 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
May 14 19:28:52.756369 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
May 14 19:28:52.757177 systemd[1]: Reached target ssh-access.target - SSH Access Available.
May 14 19:28:52.767233 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 14 19:28:52.769512 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket.
May 14 19:28:52.773348 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 14 19:28:52.776847 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 14 19:28:52.781362 systemd[1]: Reached target sockets.target - Socket Units.
May 14 19:28:52.784212 systemd[1]: Reached target basic.target - Basic System.
May 14 19:28:52.784828 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 14 19:28:52.784867 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 14 19:28:52.789205 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)...
May 14 19:28:52.796338 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent...
May 14 19:28:52.801848 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 14 19:28:52.806841 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 14 19:28:52.811311 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 14 19:28:52.820978 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 14 19:28:52.821739 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).
May 14 19:28:52.823018 jq[1404]: false
May 14 19:28:52.824589 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh...
May 14 19:28:52.832498 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 14 19:28:52.836204 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 14 19:28:52.841129 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 14 19:28:52.847555 google_oslogin_nss_cache[1406]: oslogin_cache_refresh[1406]: Refreshing passwd entry cache
May 14 19:28:52.846592 oslogin_cache_refresh[1406]: Refreshing passwd entry cache
May 14 19:28:52.851187 google_oslogin_nss_cache[1406]: oslogin_cache_refresh[1406]: Failure getting users, quitting
May 14 19:28:52.851187 google_oslogin_nss_cache[1406]: oslogin_cache_refresh[1406]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 14 19:28:52.851187 google_oslogin_nss_cache[1406]: oslogin_cache_refresh[1406]: Refreshing group entry cache
May 14 19:28:52.850982 oslogin_cache_refresh[1406]: Failure getting users, quitting
May 14 19:28:52.850995 oslogin_cache_refresh[1406]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 14 19:28:52.851032 oslogin_cache_refresh[1406]: Refreshing group entry cache
May 14 19:28:52.852386 systemd[1]: Starting systemd-logind.service - User Login Management...
May 14 19:28:52.852407 oslogin_cache_refresh[1406]: Failure getting groups, quitting
May 14 19:28:52.853298 google_oslogin_nss_cache[1406]: oslogin_cache_refresh[1406]: Failure getting groups, quitting
May 14 19:28:52.853298 google_oslogin_nss_cache[1406]: oslogin_cache_refresh[1406]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 14 19:28:52.852414 oslogin_cache_refresh[1406]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 14 19:28:52.853994 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 14 19:28:52.855622 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 14 19:28:52.864738 systemd[1]: Starting update-engine.service - Update Engine...
May 14 19:28:52.879315 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 14 19:28:52.882210 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 14 19:28:52.883332 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 14 19:28:52.883549 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 14 19:28:52.883830 systemd[1]: google-oslogin-cache.service: Deactivated successfully.
May 14 19:28:52.884044 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh.
May 14 19:28:52.885993 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 14 19:28:52.888340 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 14 19:28:52.894324 jq[1416]: true
May 14 19:28:52.917205 jq[1420]: true
May 14 19:28:52.946788 coreos-metadata[1398]: May 14 19:28:52.945 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1
May 14 19:28:52.946788 coreos-metadata[1398]: May 14 19:28:52.945 INFO Failed to fetch: error sending request for url (http://169.254.169.254/latest/meta-data/public-keys)
May 14 19:28:52.948582 update_engine[1415]: I20250514 19:28:52.947644  1415 main.cc:92] Flatcar Update Engine starting
May 14 19:28:52.967870 systemd[1]: motdgen.service: Deactivated successfully.
May 14 19:28:52.968160 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 14 19:28:52.984627 dbus-daemon[1402]: [system] SELinux support is enabled
May 14 19:28:52.984831 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 14 19:28:52.989785 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).
May 14 19:28:52.989827 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 14 19:28:52.991490 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).
May 14 19:28:52.991514 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 14 19:28:52.997774 systemd[1]: Started update-engine.service - Update Engine.
May 14 19:28:52.998204 update_engine[1415]: I20250514 19:28:52.997896  1415 update_check_scheduler.cc:74] Next update check in 2m42s
May 14 19:28:53.000887 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 14 19:28:53.001051 coreos-metadata[1401]: May 14 19:28:53.000 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1
May 14 19:28:53.001051 coreos-metadata[1401]: May 14 19:28:53.001 INFO Failed to fetch: error sending request for url (http://169.254.169.254/openstack/2012-08-10/meta_data.json)
May 14 19:28:53.033148 extend-filesystems[1405]: Found loop3
May 14 19:28:53.035048 extend-filesystems[1405]: Found loop4
May 14 19:28:53.035048 extend-filesystems[1405]: Found loop5
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda1
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda2
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda3
May 14 19:28:53.035048 extend-filesystems[1405]: Found usr
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda4
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda6
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda7
May 14 19:28:53.035048 extend-filesystems[1405]: Found vda9
May 14 19:28:53.061179 bash[1450]: Updated "/home/core/.ssh/authorized_keys"
May 14 19:28:53.035323 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 14 19:28:53.035533 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 14 19:28:53.050802 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 14 19:28:53.057913 systemd[1]: Starting sshkeys.service...
May 14 19:28:53.095832 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
May 14 19:28:53.205667 locksmithd[1451]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 14 19:28:53.208168 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
May 14 19:28:53.220168 kernel: ACPI: button: Power Button [PWRF]
May 14 19:28:53.246162 kernel: mousedev: PS/2 mouse device common for all mice
May 14 19:28:53.268183 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
May 14 19:28:53.281077 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
May 14 19:28:53.285158 kernel: [drm] pci: virtio-vga detected at 0000:00:02.0
May 14 19:28:53.287166 kernel: virtio-pci 0000:00:02.0: vgaarb: deactivate vga console
May 14 19:28:53.299404 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 14 19:28:53.304358 kernel: Console: switching to colour dummy device 80x25
May 14 19:28:53.308159 kernel: [drm] features: -virgl +edid -resource_blob -host_visible
May 14 19:28:53.308193 kernel: [drm] features: -context_init
May 14 19:28:53.308208 kernel: [drm] number of scanouts: 1
May 14 19:28:53.308221 kernel: [drm] number of cap sets: 0
May 14 19:28:53.308913 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 14 19:28:53.332179 kernel: [drm] Initialized virtio_gpu 0.1.0 for 0000:00:02.0 on minor 0
May 14 19:28:53.357204 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 14 19:28:53.423740 systemd-logind[1414]: New seat seat0.
May 14 19:28:53.424470 systemd[1]: Started systemd-logind.service - User Login Management.
May 14 19:28:53.435291 systemd-networkd[1396]: lo: Link UP
May 14 19:28:53.435300 systemd-networkd[1396]: lo: Gained carrier
May 14 19:28:53.436868 systemd-networkd[1396]: Enumeration completed
May 14 19:28:53.436987 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 14 19:28:53.437703 systemd[1]: Reached target network.target - Network.
May 14 19:28:53.438810 systemd-networkd[1396]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 19:28:53.438820 systemd-networkd[1396]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 14 19:28:53.439770 systemd-networkd[1396]: eth0: Link UP
May 14 19:28:53.439947 systemd-networkd[1396]: eth0: Gained carrier
May 14 19:28:53.439963 systemd-networkd[1396]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 19:28:53.441222 systemd[1]: Starting containerd.service - containerd container runtime...
May 14 19:28:53.446508 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd...
May 14 19:28:53.448502 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 14 19:28:53.454217 systemd-networkd[1396]: eth0: DHCPv4 address 172.24.4.14/24, gateway 172.24.4.1 acquired from 172.24.4.1
May 14 19:28:53.454987 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection.
May 14 19:28:53.489334 (ntainerd)[1488]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 14 19:28:53.522163 systemd-logind[1414]: Watching system buttons on /dev/input/event2 (Power Button)
May 14 19:28:53.525701 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd.
May 14 19:28:53.540446 systemd-logind[1414]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
May 14 19:28:53.625691 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 19:28:53.638739 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 19:28:53.638955 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 19:28:53.644285 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 19:28:53.777660 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 14 19:28:53.850809 containerd[1488]: time="2025-05-14T19:28:53Z" 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
May 14 19:28:53.852886 containerd[1488]: time="2025-05-14T19:28:53.852856879Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4
May 14 19:28:53.865465 containerd[1488]: time="2025-05-14T19:28:53.865421113Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.908µs"
May 14 19:28:53.865505 containerd[1488]: time="2025-05-14T19:28:53.865462821Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
May 14 19:28:53.865505 containerd[1488]: time="2025-05-14T19:28:53.865485093Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
May 14 19:28:53.865687 containerd[1488]: time="2025-05-14T19:28:53.865664820Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
May 14 19:28:53.865715 containerd[1488]: time="2025-05-14T19:28:53.865687663Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
May 14 19:28:53.865746 containerd[1488]: time="2025-05-14T19:28:53.865713462Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 19:28:53.865818 containerd[1488]: time="2025-05-14T19:28:53.865793632Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 19:28:53.865818 containerd[1488]: time="2025-05-14T19:28:53.865813078Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1
May 14 19:28:53.866067 containerd[1488]: time="2025-05-14T19:28:53.866041908Z" 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
May 14 19:28:53.866067 containerd[1488]: time="2025-05-14T19:28:53.866064370Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 19:28:53.866113 containerd[1488]: time="2025-05-14T19:28:53.866079258Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 19:28:53.866113 containerd[1488]: time="2025-05-14T19:28:53.866090068Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.866426799Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.866638547Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.866667811Z" 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
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.866679343Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.866717414Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.867007799Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
May 14 19:28:53.867193 containerd[1488]: time="2025-05-14T19:28:53.867079954Z" level=info msg="metadata content store policy set" policy=shared
May 14 19:28:53.875856 containerd[1488]: time="2025-05-14T19:28:53.875828783Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
May 14 19:28:53.875893 containerd[1488]: time="2025-05-14T19:28:53.875869489Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1
May 14 19:28:53.875893 containerd[1488]: time="2025-05-14T19:28:53.875886441Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
May 14 19:28:53.875945 containerd[1488]: time="2025-05-14T19:28:53.875901489Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
May 14 19:28:53.875945 containerd[1488]: time="2025-05-14T19:28:53.875915255Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
May 14 19:28:53.875945 containerd[1488]: time="2025-05-14T19:28:53.875927378Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
May 14 19:28:53.875945 containerd[1488]: time="2025-05-14T19:28:53.875941825Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
May 14 19:28:53.876030 containerd[1488]: time="2025-05-14T19:28:53.875955340Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
May 14 19:28:53.876030 containerd[1488]: time="2025-05-14T19:28:53.875966451Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
May 14 19:28:53.876030 containerd[1488]: time="2025-05-14T19:28:53.875977412Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
May 14 19:28:53.876030 containerd[1488]: time="2025-05-14T19:28:53.875987981Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
May 14 19:28:53.876030 containerd[1488]: time="2025-05-14T19:28:53.876002108Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
May 14 19:28:53.876129 containerd[1488]: time="2025-05-14T19:28:53.876096535Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
May 14 19:28:53.876129 containerd[1488]: time="2025-05-14T19:28:53.876118486Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
May 14 19:28:53.876198 containerd[1488]: time="2025-05-14T19:28:53.876134847Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
May 14 19:28:53.876198 containerd[1488]: time="2025-05-14T19:28:53.876170924Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
May 14 19:28:53.876198 containerd[1488]: time="2025-05-14T19:28:53.876187856Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
May 14 19:28:53.876257 containerd[1488]: time="2025-05-14T19:28:53.876199418Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
May 14 19:28:53.876257 containerd[1488]: time="2025-05-14T19:28:53.876211891Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
May 14 19:28:53.876257 containerd[1488]: time="2025-05-14T19:28:53.876222882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
May 14 19:28:53.876257 containerd[1488]: time="2025-05-14T19:28:53.876236447Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
May 14 19:28:53.876257 containerd[1488]: time="2025-05-14T19:28:53.876248350Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
May 14 19:28:53.876366 containerd[1488]: time="2025-05-14T19:28:53.876261084Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
May 14 19:28:53.876366 containerd[1488]: time="2025-05-14T19:28:53.876324703Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""
May 14 19:28:53.876366 containerd[1488]: time="2025-05-14T19:28:53.876341605Z" level=info msg="Start snapshots syncer"
May 14 19:28:53.876366 containerd[1488]: time="2025-05-14T19:28:53.876360610Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
May 14 19:28:53.876641 containerd[1488]: time="2025-05-14T19:28:53.876594940Z" 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\"}"
May 14 19:28:53.876766 containerd[1488]: time="2025-05-14T19:28:53.876659411Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
May 14 19:28:53.876856 containerd[1488]: time="2025-05-14T19:28:53.876812428Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
May 14 19:28:53.876974 containerd[1488]: time="2025-05-14T19:28:53.876952080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
May 14 19:28:53.877019 containerd[1488]: time="2025-05-14T19:28:53.877000340Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
May 14 19:28:53.877046 containerd[1488]: time="2025-05-14T19:28:53.877024525Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
May 14 19:28:53.877046 containerd[1488]: time="2025-05-14T19:28:53.877038361Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
May 14 19:28:53.877086 containerd[1488]: time="2025-05-14T19:28:53.877050544Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
May 14 19:28:53.877086 containerd[1488]: time="2025-05-14T19:28:53.877079008Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
May 14 19:28:53.877132 containerd[1488]: time="2025-05-14T19:28:53.877092353Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
May 14 19:28:53.877132 containerd[1488]: time="2025-05-14T19:28:53.877122349Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
May 14 19:28:53.877189 containerd[1488]: time="2025-05-14T19:28:53.877156443Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
May 14 19:28:53.877189 containerd[1488]: time="2025-05-14T19:28:53.877172513Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
May 14 19:28:53.878636 containerd[1488]: time="2025-05-14T19:28:53.878612564Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
May 14 19:28:53.878714 containerd[1488]: time="2025-05-14T19:28:53.878642871Z" 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
May 14 19:28:53.878714 containerd[1488]: time="2025-05-14T19:28:53.878706390Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 19:28:53.878760 containerd[1488]: time="2025-05-14T19:28:53.878722630Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 19:28:53.878760 containerd[1488]: time="2025-05-14T19:28:53.878732409Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
May 14 19:28:53.878801 containerd[1488]: time="2025-05-14T19:28:53.878760401Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
May 14 19:28:53.878801 containerd[1488]: time="2025-05-14T19:28:53.878779567Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
May 14 19:28:53.878801 containerd[1488]: time="2025-05-14T19:28:53.878797851Z" level=info msg="runtime interface created"
May 14 19:28:53.878866 containerd[1488]: time="2025-05-14T19:28:53.878805205Z" level=info msg="created NRI interface"
May 14 19:28:53.878866 containerd[1488]: time="2025-05-14T19:28:53.878814563Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1
May 14 19:28:53.878866 containerd[1488]: time="2025-05-14T19:28:53.878845380Z" level=info msg="Connect containerd service"
May 14 19:28:53.878926 containerd[1488]: time="2025-05-14T19:28:53.878875427Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 14 19:28:53.879898 containerd[1488]: time="2025-05-14T19:28:53.879872276Z" 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"
May 14 19:28:53.939778 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 14 19:28:53.946300 coreos-metadata[1398]: May 14 19:28:53.946 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #2
May 14 19:28:53.947129 sshd_keygen[1441]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 14 19:28:53.970162 coreos-metadata[1398]: May 14 19:28:53.969 INFO Fetch successful
May 14 19:28:53.970162 coreos-metadata[1398]: May 14 19:28:53.970 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1
May 14 19:28:53.972780 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 14 19:28:53.976790 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 14 19:28:53.979460 systemd[1]: Started sshd@0-172.24.4.14:22-172.24.4.1:47436.service - OpenSSH per-connection server daemon (172.24.4.1:47436).
May 14 19:28:53.981605 coreos-metadata[1398]: May 14 19:28:53.981 INFO Fetch successful
May 14 19:28:53.996004 unknown[1398]: wrote ssh authorized keys file for user: core
May 14 19:28:53.998049 systemd[1]: issuegen.service: Deactivated successfully.
May 14 19:28:53.998281 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 14 19:28:53.998628 coreos-metadata[1401]: May 14 19:28:53.998 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #2
May 14 19:28:54.009284 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 14 19:28:54.014330 coreos-metadata[1401]: May 14 19:28:54.012 INFO Fetch successful
May 14 19:28:54.014330 coreos-metadata[1401]: May 14 19:28:54.012 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1
May 14 19:28:54.032311 coreos-metadata[1401]: May 14 19:28:54.029 INFO Fetch successful
May 14 19:28:54.032311 coreos-metadata[1401]: May 14 19:28:54.029 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1
May 14 19:28:54.037555 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 14 19:28:54.051554 coreos-metadata[1401]: May 14 19:28:54.047 INFO Fetch successful
May 14 19:28:54.051554 coreos-metadata[1401]: May 14 19:28:54.047 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1
May 14 19:28:54.055590 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 14 19:28:54.059435 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
May 14 19:28:54.061288 update-ssh-keys[1529]: Updated "/home/core/.ssh/authorized_keys"
May 14 19:28:54.059809 systemd[1]: Reached target getty.target - Login Prompts.
May 14 19:28:54.060755 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys).
May 14 19:28:54.064308 systemd[1]: Finished sshkeys.service.
May 14 19:28:54.067528 coreos-metadata[1401]: May 14 19:28:54.067 INFO Fetch successful
May 14 19:28:54.067528 coreos-metadata[1401]: May 14 19:28:54.067 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1
May 14 19:28:54.085456 coreos-metadata[1401]: May 14 19:28:54.085 INFO Fetch successful
May 14 19:28:54.085456 coreos-metadata[1401]: May 14 19:28:54.085 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1
May 14 19:28:54.094490 coreos-metadata[1401]: May 14 19:28:54.094 INFO Fetch successful
May 14 19:28:54.121382 containerd[1488]: time="2025-05-14T19:28:54.121313469Z" level=info msg="Start subscribing containerd event"
May 14 19:28:54.121525 containerd[1488]: time="2025-05-14T19:28:54.121402857Z" level=info msg="Start recovering state"
May 14 19:28:54.121577 containerd[1488]: time="2025-05-14T19:28:54.121544663Z" level=info msg="Start event monitor"
May 14 19:28:54.121612 containerd[1488]: time="2025-05-14T19:28:54.121579819Z" level=info msg="Start cni network conf syncer for default"
May 14 19:28:54.121612 containerd[1488]: time="2025-05-14T19:28:54.121592963Z" level=info msg="Start streaming server"
May 14 19:28:54.121662 containerd[1488]: time="2025-05-14T19:28:54.121611869Z" level=info msg="Registered namespace \"k8s.io\" with NRI"
May 14 19:28:54.121662 containerd[1488]: time="2025-05-14T19:28:54.121621247Z" level=info msg="runtime interface starting up..."
May 14 19:28:54.121662 containerd[1488]: time="2025-05-14T19:28:54.121629111Z" level=info msg="starting plugins..."
May 14 19:28:54.121662 containerd[1488]: time="2025-05-14T19:28:54.121644350Z" level=info msg="Synchronizing NRI (plugin) with current runtime state"
May 14 19:28:54.122292 containerd[1488]: time="2025-05-14T19:28:54.122237242Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 14 19:28:54.122447 containerd[1488]: time="2025-05-14T19:28:54.122415616Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 14 19:28:54.122766 systemd[1]: Started containerd.service - containerd container runtime.
May 14 19:28:54.123286 containerd[1488]: time="2025-05-14T19:28:54.123269869Z" level=info msg="containerd successfully booted in 0.272835s"
May 14 19:28:54.129996 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent.
May 14 19:28:54.130852 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 14 19:28:55.336444 systemd-networkd[1396]: eth0: Gained IPv6LL
May 14 19:28:55.338547 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection.
May 14 19:28:55.341790 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 14 19:28:55.343034 systemd[1]: Reached target network-online.target - Network is Online.
May 14 19:28:55.345564 systemd[1]: Starting etcd-member.service - etcd (System Application Container)...
May 14 19:28:55.349599 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 14 19:28:55.354836 (-wrapper)[1547]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS
May 14 19:28:55.384111 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 14 19:28:55.598326 systemd[1]: Starting docker.service - Docker Application Container Engine...
May 14 19:28:55.618425 (dockerd)[1567]: 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
May 14 19:28:55.944595 sshd[1522]: Accepted publickey for core from 172.24.4.1 port 47436 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:28:55.948657 sshd-session[1522]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:28:55.964961 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 14 19:28:55.969372 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 14 19:28:56.008982 systemd-logind[1414]: New session 1 of user core.
May 14 19:28:56.022780 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 14 19:28:56.026323 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 14 19:28:56.040902 (systemd)[1575]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 14 19:28:56.043794 systemd-logind[1414]: New session c1 of user core.
May 14 19:28:56.048759 dockerd[1567]: time="2025-05-14T19:28:56.048696726Z" level=info msg="Starting up"
May 14 19:28:56.054237 dockerd[1567]: time="2025-05-14T19:28:56.054181132Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"
May 14 19:28:56.151993 systemd[1]: var-lib-docker-metacopy\x2dcheck3381829403-merged.mount: Deactivated successfully.
May 14 19:28:56.198449 dockerd[1567]: time="2025-05-14T19:28:56.198185041Z" level=info msg="Loading containers: start."
May 14 19:28:56.216352 kernel: Initializing XFRM netlink socket
May 14 19:28:56.224331 systemd[1575]: Queued start job for default target default.target.
May 14 19:28:56.235217 systemd[1575]: Created slice app.slice - User Application Slice.
May 14 19:28:56.235246 systemd[1575]: Reached target paths.target - Paths.
May 14 19:28:56.235287 systemd[1575]: Reached target timers.target - Timers.
May 14 19:28:56.236378 systemd[1575]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 14 19:28:56.247067 systemd[1575]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 14 19:28:56.247920 systemd[1575]: Reached target sockets.target - Sockets.
May 14 19:28:56.247963 systemd[1575]: Reached target basic.target - Basic System.
May 14 19:28:56.247997 systemd[1575]: Reached target default.target - Main User Target.
May 14 19:28:56.248021 systemd[1575]: Startup finished in 194ms.
May 14 19:28:56.248303 systemd[1]: Started user@500.service - User Manager for UID 500.
May 14 19:28:56.255341 systemd[1]: Started session-1.scope - Session 1 of User core.
May 14 19:28:56.471015 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection.
May 14 19:28:56.473776 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection.
May 14 19:28:56.486400 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection.
May 14 19:28:56.547076 systemd-networkd[1396]: docker0: Link UP
May 14 19:28:56.547762 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection.
May 14 19:28:56.559613 dockerd[1567]: time="2025-05-14T19:28:56.559550773Z" level=info msg="Loading containers: done."
May 14 19:28:56.584841 dockerd[1567]: time="2025-05-14T19:28:56.584554728Z" 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
May 14 19:28:56.584841 dockerd[1567]: time="2025-05-14T19:28:56.584657490Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1
May 14 19:28:56.584841 dockerd[1567]: time="2025-05-14T19:28:56.584767437Z" level=info msg="Initializing buildkit"
May 14 19:28:56.631162 dockerd[1567]: time="2025-05-14T19:28:56.631107808Z" level=info msg="Completed buildkit initialization"
May 14 19:28:56.643225 dockerd[1567]: time="2025-05-14T19:28:56.642470879Z" level=info msg="Daemon has completed initialization"
May 14 19:28:56.643225 dockerd[1567]: time="2025-05-14T19:28:56.642641890Z" level=info msg="API listen on /run/docker.sock"
May 14 19:28:56.643574 systemd[1]: Started docker.service - Docker Application Container Engine.
May 14 19:28:56.646154 etcd-wrapper[1553]: Error response from daemon: No such container: etcd-member
May 14 19:28:56.664602 systemd[1]: Started sshd@1-172.24.4.14:22-172.24.4.1:56532.service - OpenSSH per-connection server daemon (172.24.4.1:56532).
May 14 19:28:56.674604 etcd-wrapper[1767]: Error response from daemon: No such container: etcd-member
May 14 19:28:56.728465 etcd-wrapper[1787]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally
May 14 19:28:58.097359 sshd[1773]: Accepted publickey for core from 172.24.4.1 port 56532 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:28:58.100003 sshd-session[1773]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:28:58.104712 etcd-wrapper[1787]: v3.5.16: Pulling from coreos/etcd
May 14 19:28:58.114918 systemd-logind[1414]: New session 2 of user core.
May 14 19:28:58.131501 systemd[1]: Started session-2.scope - Session 2 of User core.
May 14 19:28:58.561430 etcd-wrapper[1787]: 804c8aba2cc6: Pulling fs layer
May 14 19:28:58.561695 etcd-wrapper[1787]: 2ae710cd8bfe: Pulling fs layer
May 14 19:28:58.562542 etcd-wrapper[1787]: d462aa345367: Pulling fs layer
May 14 19:28:58.562542 etcd-wrapper[1787]: 0f8b424aa0b9: Pulling fs layer
May 14 19:28:58.562542 etcd-wrapper[1787]: d557676654e5: Pulling fs layer
May 14 19:28:58.562542 etcd-wrapper[1787]: c8022d07192e: Pulling fs layer
May 14 19:28:58.562542 etcd-wrapper[1787]: d858cbc252ad: Pulling fs layer
May 14 19:28:58.562542 etcd-wrapper[1787]: 1069fc2daed1: Pulling fs layer
May 14 19:28:58.564454 etcd-wrapper[1787]: b40161cd83fc: Pulling fs layer
May 14 19:28:58.564454 etcd-wrapper[1787]: 5318d93a3a65: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: 307c1adadb60: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: fbb01d9e9dc9: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: fbfea02ac3cf: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: 8c26e4bf18e2: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: 1e59a65f8816: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: ffbd4ca5f0bd: Pulling fs layer
May 14 19:28:58.565040 etcd-wrapper[1787]: b40161cd83fc: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: 5318d93a3a65: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: 307c1adadb60: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: fbb01d9e9dc9: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: 0f8b424aa0b9: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: d557676654e5: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: c8022d07192e: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: d858cbc252ad: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: 1069fc2daed1: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: 8c26e4bf18e2: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: 1e59a65f8816: Waiting
May 14 19:28:58.565040 etcd-wrapper[1787]: ffbd4ca5f0bd: Waiting
May 14 19:28:58.566704 etcd-wrapper[1787]: fbfea02ac3cf: Waiting
May 14 19:28:58.867454 sshd[1795]: Connection closed by 172.24.4.1 port 56532
May 14 19:28:58.867228 sshd-session[1773]: pam_unix(sshd:session): session closed for user core
May 14 19:28:58.883871 systemd[1]: sshd@1-172.24.4.14:22-172.24.4.1:56532.service: Deactivated successfully.
May 14 19:28:58.889471 systemd[1]: session-2.scope: Deactivated successfully.
May 14 19:28:58.892637 systemd-logind[1414]: Session 2 logged out. Waiting for processes to exit.
May 14 19:28:58.901698 systemd[1]: Started sshd@2-172.24.4.14:22-172.24.4.1:56546.service - OpenSSH per-connection server daemon (172.24.4.1:56546).
May 14 19:28:58.904951 systemd-logind[1414]: Removed session 2.
May 14 19:28:58.926720 etcd-wrapper[1787]: 2ae710cd8bfe: Verifying Checksum
May 14 19:28:58.926720 etcd-wrapper[1787]: 2ae710cd8bfe: Download complete
May 14 19:28:59.003118 etcd-wrapper[1787]: d462aa345367: Download complete
May 14 19:28:59.074964 etcd-wrapper[1787]: 804c8aba2cc6: Verifying Checksum
May 14 19:28:59.074964 etcd-wrapper[1787]: 804c8aba2cc6: Download complete
May 14 19:28:59.137826 login[1532]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 14 19:28:59.148235 login[1533]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 14 19:28:59.149556 systemd-logind[1414]: New session 3 of user core.
May 14 19:28:59.154337 systemd[1]: Started session-3.scope - Session 3 of User core.
May 14 19:28:59.163387 systemd-logind[1414]: New session 4 of user core.
May 14 19:28:59.169176 systemd[1]: Started session-4.scope - Session 4 of User core.
May 14 19:28:59.187754 etcd-wrapper[1787]: 804c8aba2cc6: Pull complete
May 14 19:28:59.224256 systemd[1]: var-lib-docker-overlay2-ae57edb3c225505de873f43727bcdcfb3a0ac5c71cca195faaec67903529c308-merged.mount: Deactivated successfully.
May 14 19:28:59.258105 etcd-wrapper[1787]: 2ae710cd8bfe: Pull complete
May 14 19:28:59.371849 etcd-wrapper[1787]: d557676654e5: Verifying Checksum
May 14 19:28:59.371849 etcd-wrapper[1787]: d557676654e5: Download complete
May 14 19:28:59.421166 etcd-wrapper[1787]: 0f8b424aa0b9: Verifying Checksum
May 14 19:28:59.421577 etcd-wrapper[1787]: 0f8b424aa0b9: Download complete
May 14 19:28:59.522611 etcd-wrapper[1787]: c8022d07192e: Verifying Checksum
May 14 19:28:59.522845 etcd-wrapper[1787]: c8022d07192e: Download complete
May 14 19:28:59.689293 etcd-wrapper[1787]: d858cbc252ad: Verifying Checksum
May 14 19:28:59.689293 etcd-wrapper[1787]: d858cbc252ad: Download complete
May 14 19:28:59.796240 etcd-wrapper[1787]: d462aa345367: Pull complete
May 14 19:28:59.828578 etcd-wrapper[1787]: 1069fc2daed1: Verifying Checksum
May 14 19:28:59.828578 etcd-wrapper[1787]: 1069fc2daed1: Download complete
May 14 19:28:59.849639 etcd-wrapper[1787]: 0f8b424aa0b9: Pull complete
May 14 19:28:59.886734 etcd-wrapper[1787]: b40161cd83fc: Verifying Checksum
May 14 19:28:59.886734 etcd-wrapper[1787]: b40161cd83fc: Download complete
May 14 19:28:59.904013 etcd-wrapper[1787]: d557676654e5: Pull complete
May 14 19:28:59.953469 etcd-wrapper[1787]: c8022d07192e: Pull complete
May 14 19:29:00.010430 etcd-wrapper[1787]: d858cbc252ad: Pull complete
May 14 19:29:00.063129 etcd-wrapper[1787]: 1069fc2daed1: Pull complete
May 14 19:29:00.100415 systemd[1]: var-lib-docker-overlay2-04e4c30b2614a5548392baef4f6aa74766722cdc591dce2e4a6c3829411caf36-merged.mount: Deactivated successfully.
May 14 19:29:00.111400 systemd[1]: var-lib-docker-overlay2-22128fd00990b13ffac468e912be3a3d8a4df29546097b30b2d31416b476527c-merged.mount: Deactivated successfully.
May 14 19:29:00.141851 etcd-wrapper[1787]: b40161cd83fc: Pull complete
May 14 19:29:00.206582 etcd-wrapper[1787]: 307c1adadb60: Download complete
May 14 19:29:00.318525 etcd-wrapper[1787]: 5318d93a3a65: Verifying Checksum
May 14 19:29:00.318525 etcd-wrapper[1787]: 5318d93a3a65: Download complete
May 14 19:29:00.356413 systemd[1]: var-lib-docker-overlay2-809f585f4d40a8aef104d6871d8a43693e50662c07db72953a38a84203cc9036-merged.mount: Deactivated successfully.
May 14 19:29:00.359623 sshd[1801]: Accepted publickey for core from 172.24.4.1 port 56546 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:29:00.365874 sshd-session[1801]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:29:00.379626 systemd-logind[1414]: New session 5 of user core.
May 14 19:29:00.385577 systemd[1]: Started session-5.scope - Session 5 of User core.
May 14 19:29:00.410040 etcd-wrapper[1787]: 5318d93a3a65: Pull complete
May 14 19:29:00.501197 etcd-wrapper[1787]: 307c1adadb60: Pull complete
May 14 19:29:00.648824 etcd-wrapper[1787]: fbb01d9e9dc9: Verifying Checksum
May 14 19:29:00.648824 etcd-wrapper[1787]: fbb01d9e9dc9: Download complete
May 14 19:29:00.711725 etcd-wrapper[1787]: fbfea02ac3cf: Verifying Checksum
May 14 19:29:00.711725 etcd-wrapper[1787]: fbfea02ac3cf: Download complete
May 14 19:29:00.843890 etcd-wrapper[1787]: 8c26e4bf18e2: Verifying Checksum
May 14 19:29:00.843890 etcd-wrapper[1787]: 8c26e4bf18e2: Download complete
May 14 19:29:01.063394 etcd-wrapper[1787]: 1e59a65f8816: Verifying Checksum
May 14 19:29:01.063829 etcd-wrapper[1787]: 1e59a65f8816: Download complete
May 14 19:29:01.092766 etcd-wrapper[1787]: ffbd4ca5f0bd: Verifying Checksum
May 14 19:29:01.092766 etcd-wrapper[1787]: ffbd4ca5f0bd: Download complete
May 14 19:29:01.096812 systemd[1]: var-lib-docker-overlay2-51be74d42889a8560afd1ffa4479cf1da67b06f899ab4b0034243c250a6b7048-merged.mount: Deactivated successfully.
May 14 19:29:01.146837 sshd[1880]: Connection closed by 172.24.4.1 port 56546
May 14 19:29:01.148026 sshd-session[1801]: pam_unix(sshd:session): session closed for user core
May 14 19:29:01.156865 systemd[1]: sshd@2-172.24.4.14:22-172.24.4.1:56546.service: Deactivated successfully.
May 14 19:29:01.161606 systemd[1]: session-5.scope: Deactivated successfully.
May 14 19:29:01.165992 systemd-logind[1414]: Session 5 logged out. Waiting for processes to exit.
May 14 19:29:01.169005 systemd-logind[1414]: Removed session 5.
May 14 19:29:01.191829 etcd-wrapper[1787]: fbb01d9e9dc9: Pull complete
May 14 19:29:01.466703 systemd[1]: var-lib-docker-overlay2-19de8cc7b80fa874a0e08eec0f0fff00017a36042b7fdee7ec68e8e8a26668d1-merged.mount: Deactivated successfully.
May 14 19:29:01.587706 etcd-wrapper[1787]: fbfea02ac3cf: Pull complete
May 14 19:29:01.821722 systemd[1]: var-lib-docker-overlay2-756c080c80d67ffa77ff84a411a143634507961ad0fe7a45c01cba9a732825cc-merged.mount: Deactivated successfully.
May 14 19:29:01.925378 etcd-wrapper[1787]: 8c26e4bf18e2: Pull complete
May 14 19:29:01.979389 etcd-wrapper[1787]: 1e59a65f8816: Pull complete
May 14 19:29:02.030275 etcd-wrapper[1787]: ffbd4ca5f0bd: Pull complete
May 14 19:29:02.052944 etcd-wrapper[1787]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159
May 14 19:29:02.060991 etcd-wrapper[1787]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16
May 14 19:29:02.217087 containerd[1488]: time="2025-05-14T19:29:02.216583416Z" level=info msg="connecting to shim a50f488b0c7cae55db03d44992c82b96fc6a452093a7ab68e565c0229db95728" address="unix:///run/containerd/s/d9a5b1040c7df2b9e1341a62a12cb85fbdacdae55a77fac21414145fccdb620b" namespace=moby protocol=ttrpc version=3
May 14 19:29:02.264305 systemd[1]: Started docker-a50f488b0c7cae55db03d44992c82b96fc6a452093a7ab68e565c0229db95728.scope - libcontainer container a50f488b0c7cae55db03d44992c82b96fc6a452093a7ab68e565c0229db95728.
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.346461Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.346589Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"9aa8709c5ffd4362897a8ae24c102794"}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.346619Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.346627Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.346634Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.346640Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.346676Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.346703Z","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://172.24.4.14:2379"]}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.346770Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.346783Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]}
May 14 19:29:02.347894 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.347258Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]}
May 14 19:29:02.348302 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.347372Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"9aa8709c5ffd4362897a8ae24c102794","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://172.24.4.14:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"9aa8709c5ffd4362897a8ae24c102794=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"}
May 14 19:29:02.352503 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.352306Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.288353ms"}
May 14 19:29:02.359981 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.359439Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"}
May 14 19:29:02.359981 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.359516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"}
May 14 19:29:02.359981 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.359545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"}
May 14 19:29:02.359981 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.359555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
May 14 19:29:02.359981 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.359563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"}
May 14 19:29:02.359981 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.359600Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
May 14 19:29:02.367681 etcd-wrapper[1787]: {"level":"warn","ts":"2025-05-14T19:29:02.367401Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
May 14 19:29:02.368922 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.368744Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1}
May 14 19:29:02.370474 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.370263Z","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"}
May 14 19:29:02.372005 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.371794Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"}
May 14 19:29:02.372635 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.372466Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
May 14 19:29:02.374567 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.374237Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
May 14 19:29:02.374567 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.374319Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
May 14 19:29:02.374870 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.374600Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
May 14 19:29:02.377248 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.375184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
May 14 19:29:02.377248 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.375282Z","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"]}
May 14 19:29:02.377248 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.372889Z","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"}
May 14 19:29:02.380251 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.380019Z","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://172.24.4.14:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]}
May 14 19:29:02.380519 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.380112Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"}
May 14 19:29:02.380805 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.380580Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"}
May 14 19:29:02.561514 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.560791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"}
May 14 19:29:02.564875 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.564215Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:9aa8709c5ffd4362897a8ae24c102794 ClientURLs:[http://172.24.4.14:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"}
May 14 19:29:02.564875 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.564554Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
May 14 19:29:02.566548 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.564936Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
May 14 19:29:02.566548 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.565008Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
May 14 19:29:02.566801 systemd[1]: Started etcd-member.service - etcd (System Application Container).
May 14 19:29:02.568726 systemd[1]: Reached target multi-user.target - Multi-User System.
May 14 19:29:02.570004 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.566487Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
May 14 19:29:02.570004 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.566814Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
May 14 19:29:02.570004 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.567970Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"}
May 14 19:29:02.569338 systemd[1]: Startup finished in 3.806s (kernel) + 12.241s (initrd) + 12.677s (userspace) = 28.726s.
May 14 19:29:02.571959 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.569047Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"}
May 14 19:29:02.571959 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.570691Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
May 14 19:29:02.571959 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:29:02.570950Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"}
May 14 19:29:11.171905 systemd[1]: Started sshd@3-172.24.4.14:22-172.24.4.1:39984.service - OpenSSH per-connection server daemon (172.24.4.1:39984).
May 14 19:29:12.442086 sshd[1970]: Accepted publickey for core from 172.24.4.1 port 39984 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:29:12.445085 sshd-session[1970]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:29:12.458260 systemd-logind[1414]: New session 6 of user core.
May 14 19:29:12.469556 systemd[1]: Started session-6.scope - Session 6 of User core.
May 14 19:29:13.135656 sshd[1972]: Connection closed by 172.24.4.1 port 39984
May 14 19:29:13.136511 sshd-session[1970]: pam_unix(sshd:session): session closed for user core
May 14 19:29:13.154980 systemd[1]: sshd@3-172.24.4.14:22-172.24.4.1:39984.service: Deactivated successfully.
May 14 19:29:13.160801 systemd[1]: session-6.scope: Deactivated successfully.
May 14 19:29:13.162989 systemd-logind[1414]: Session 6 logged out. Waiting for processes to exit.
May 14 19:29:13.170727 systemd[1]: Started sshd@4-172.24.4.14:22-172.24.4.1:33344.service - OpenSSH per-connection server daemon (172.24.4.1:33344).
May 14 19:29:13.172701 systemd-logind[1414]: Removed session 6.
May 14 19:29:14.664603 sshd[1978]: Accepted publickey for core from 172.24.4.1 port 33344 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:29:14.667987 sshd-session[1978]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:29:14.681273 systemd-logind[1414]: New session 7 of user core.
May 14 19:29:14.687548 systemd[1]: Started session-7.scope - Session 7 of User core.
May 14 19:29:15.262196 sshd[1980]: Connection closed by 172.24.4.1 port 33344
May 14 19:29:15.263413 sshd-session[1978]: pam_unix(sshd:session): session closed for user core
May 14 19:29:15.280736 systemd[1]: sshd@4-172.24.4.14:22-172.24.4.1:33344.service: Deactivated successfully.
May 14 19:29:15.285073 systemd[1]: session-7.scope: Deactivated successfully.
May 14 19:29:15.287741 systemd-logind[1414]: Session 7 logged out. Waiting for processes to exit.
May 14 19:29:15.295199 systemd[1]: Started sshd@5-172.24.4.14:22-172.24.4.1:33348.service - OpenSSH per-connection server daemon (172.24.4.1:33348).
May 14 19:29:15.298709 systemd-logind[1414]: Removed session 7.
May 14 19:29:16.702297 sshd[1986]: Accepted publickey for core from 172.24.4.1 port 33348 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:29:16.720974 sshd-session[1986]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:29:16.733250 systemd-logind[1414]: New session 8 of user core.
May 14 19:29:16.743430 systemd[1]: Started session-8.scope - Session 8 of User core.
May 14 19:29:17.235704 sshd[1988]: Connection closed by 172.24.4.1 port 33348
May 14 19:29:17.236758 sshd-session[1986]: pam_unix(sshd:session): session closed for user core
May 14 19:29:17.253230 systemd[1]: sshd@5-172.24.4.14:22-172.24.4.1:33348.service: Deactivated successfully.
May 14 19:29:17.256936 systemd[1]: session-8.scope: Deactivated successfully.
May 14 19:29:17.259281 systemd-logind[1414]: Session 8 logged out. Waiting for processes to exit.
May 14 19:29:17.264685 systemd[1]: Started sshd@6-172.24.4.14:22-172.24.4.1:33358.service - OpenSSH per-connection server daemon (172.24.4.1:33358).
May 14 19:29:17.266530 systemd-logind[1414]: Removed session 8.
May 14 19:29:18.637590 sshd[1994]: Accepted publickey for core from 172.24.4.1 port 33358 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:29:18.640895 sshd-session[1994]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:29:18.651766 systemd-logind[1414]: New session 9 of user core.
May 14 19:29:18.668540 systemd[1]: Started session-9.scope - Session 9 of User core.
May 14 19:29:19.147426 sshd[1996]: Connection closed by 172.24.4.1 port 33358
May 14 19:29:19.145897 sshd-session[1994]: pam_unix(sshd:session): session closed for user core
May 14 19:29:19.163294 systemd[1]: sshd@6-172.24.4.14:22-172.24.4.1:33358.service: Deactivated successfully.
May 14 19:29:19.166487 systemd[1]: session-9.scope: Deactivated successfully.
May 14 19:29:19.169269 systemd-logind[1414]: Session 9 logged out. Waiting for processes to exit.
May 14 19:29:19.172622 systemd-logind[1414]: Removed session 9.
May 14 19:29:19.175813 systemd[1]: Started sshd@7-172.24.4.14:22-172.24.4.1:33364.service - OpenSSH per-connection server daemon (172.24.4.1:33364).
May 14 19:29:20.593977 sshd[2004]: Accepted publickey for core from 172.24.4.1 port 33364 ssh2: RSA SHA256:Lqai4ED+ZCiaRgUqr3RV15GKRleYCekM0Dh/zZdYZOc
May 14 19:29:20.596835 sshd-session[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 19:29:20.607541 systemd-logind[1414]: New session 10 of user core.
May 14 19:29:20.616417 systemd[1]: Started session-10.scope - Session 10 of User core.
May 14 19:29:21.384209 sshd[2006]: Connection closed by 172.24.4.1 port 33364
May 14 19:29:21.385262 sshd-session[2004]: pam_unix(sshd:session): session closed for user core
May 14 19:29:21.391963 systemd[1]: sshd@7-172.24.4.14:22-172.24.4.1:33364.service: Deactivated successfully.
May 14 19:29:21.395583 systemd[1]: session-10.scope: Deactivated successfully.
May 14 19:29:21.398224 systemd-logind[1414]: Session 10 logged out. Waiting for processes to exit.
May 14 19:29:21.401637 systemd-logind[1414]: Removed session 10.
May 14 19:29:27.522255 systemd-timesyncd[1342]: Contacted time server 51.81.226.229:123 (2.flatcar.pool.ntp.org).
May 14 19:29:27.522358 systemd-timesyncd[1342]: Initial clock synchronization to Wed 2025-05-14 19:29:27.521955 UTC.
May 14 19:29:27.523296 systemd-resolved[1313]: Clock change detected. Flushing caches.
May 14 19:29:38.461838 update_engine[1415]: I20250514 19:29:38.461681  1415 update_attempter.cc:509] Updating boot flags...
May 14 19:31:35.514221 update_engine[1415]: I20250514 19:31:35.512704  1415 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs
May 14 19:31:35.514221 update_engine[1415]: I20250514 19:31:35.513365  1415 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs
May 14 19:31:35.523378 update_engine[1415]: I20250514 19:31:35.517259  1415 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs
May 14 19:31:35.523378 update_engine[1415]: I20250514 19:31:35.522747  1415 omaha_request_params.cc:62] Current group set to developer
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.523730  1415 update_attempter.cc:499] Already updated boot flags. Skipping.
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.523768  1415 update_attempter.cc:643] Scheduling an action processor start.
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.523842  1415 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.524132  1415 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.524367  1415 omaha_request_action.cc:271] Posting an Omaha request to disabled
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.524392  1415 omaha_request_action.cc:272] Request: <?xml version="1.0" encoding="UTF-8"?>
May 14 19:31:35.526287 update_engine[1415]: <request protocol="3.0" version="update_engine-0.4.10" updaterversion="update_engine-0.4.10" installsource="scheduler" ismachine="1">
May 14 19:31:35.526287 update_engine[1415]:     <os version="Chateau" platform="CoreOS" sp="4334.0.0+afterburn-5.8.0_x86_64"></os>
May 14 19:31:35.526287 update_engine[1415]:     <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="4334.0.0+afterburn-5.8.0" track="developer" bootid="{2b08c796-dc07-4b36-9ec9-f4dea13d5f7a}" oem="openstack" oemversion="0" alephversion="4334.0.0+afterburn-5.8.0" machineid="9aa8709c5ffd4362897a8ae24c102794" machinealias="" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
May 14 19:31:35.526287 update_engine[1415]:         <ping active="1"></ping>
May 14 19:31:35.526287 update_engine[1415]:         <updatecheck></updatecheck>
May 14 19:31:35.526287 update_engine[1415]:         <event eventtype="3" eventresult="2" previousversion="0.0.0.0"></event>
May 14 19:31:35.526287 update_engine[1415]:     </app>
May 14 19:31:35.526287 update_engine[1415]: </request>
May 14 19:31:35.526287 update_engine[1415]: I20250514 19:31:35.524423  1415 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 14 19:31:35.530639 locksmithd[1451]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0
May 14 19:31:35.537305 update_engine[1415]: I20250514 19:31:35.537192  1415 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 14 19:31:35.538931 update_engine[1415]: I20250514 19:31:35.538811  1415 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 14 19:31:35.547061 update_engine[1415]: E20250514 19:31:35.546840  1415 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 14 19:31:35.547243 update_engine[1415]: I20250514 19:31:35.547134  1415 libcurl_http_fetcher.cc:283] No HTTP response, retry 1
May 14 19:31:45.455377 update_engine[1415]: I20250514 19:31:45.455134  1415 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 14 19:31:45.456374 update_engine[1415]: I20250514 19:31:45.455564  1415 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 14 19:31:45.456374 update_engine[1415]: I20250514 19:31:45.456326  1415 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 14 19:31:45.461934 update_engine[1415]: E20250514 19:31:45.461829  1415 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 14 19:31:45.462148 update_engine[1415]: I20250514 19:31:45.462105  1415 libcurl_http_fetcher.cc:283] No HTTP response, retry 2
May 14 19:31:55.455881 update_engine[1415]: I20250514 19:31:55.455253  1415 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 14 19:31:55.458170 update_engine[1415]: I20250514 19:31:55.456291  1415 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 14 19:31:55.458170 update_engine[1415]: I20250514 19:31:55.457487  1415 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 14 19:31:55.463755 update_engine[1415]: E20250514 19:31:55.463570  1415 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 14 19:31:55.464166 update_engine[1415]: I20250514 19:31:55.463902  1415 libcurl_http_fetcher.cc:283] No HTTP response, retry 3
May 14 19:32:05.452324 update_engine[1415]: I20250514 19:32:05.451119  1415 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 14 19:32:05.459582 update_engine[1415]: I20250514 19:32:05.455440  1415 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 14 19:32:05.459582 update_engine[1415]: I20250514 19:32:05.456696  1415 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 14 19:32:05.462283 update_engine[1415]: E20250514 19:32:05.462119  1415 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 14 19:32:05.462702 update_engine[1415]: I20250514 19:32:05.462286  1415 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded
May 14 19:32:05.462702 update_engine[1415]: I20250514 19:32:05.462327  1415 omaha_request_action.cc:617] Omaha request response:
May 14 19:32:05.463094 update_engine[1415]: E20250514 19:32:05.462998  1415 omaha_request_action.cc:636] Omaha request network transfer failed.
May 14 19:32:05.463483 update_engine[1415]: I20250514 19:32:05.463397  1415 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing.
May 14 19:32:05.463483 update_engine[1415]: I20250514 19:32:05.463423  1415 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
May 14 19:32:05.463483 update_engine[1415]: I20250514 19:32:05.463435  1415 update_attempter.cc:306] Processing Done.
May 14 19:32:05.463813 update_engine[1415]: E20250514 19:32:05.463495  1415 update_attempter.cc:619] Update failed.
May 14 19:32:05.463813 update_engine[1415]: I20250514 19:32:05.463515  1415 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse
May 14 19:32:05.463813 update_engine[1415]: I20250514 19:32:05.463524  1415 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse)
May 14 19:32:05.463813 update_engine[1415]: I20250514 19:32:05.463533  1415 payload_state.cc:103] Ignoring failures until we get a valid Omaha response.
May 14 19:32:05.464297 update_engine[1415]: I20250514 19:32:05.463961  1415 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction
May 14 19:32:05.464297 update_engine[1415]: I20250514 19:32:05.464082  1415 omaha_request_action.cc:271] Posting an Omaha request to disabled
May 14 19:32:05.464297 update_engine[1415]: I20250514 19:32:05.464094  1415 omaha_request_action.cc:272] Request: <?xml version="1.0" encoding="UTF-8"?>
May 14 19:32:05.464297 update_engine[1415]: <request protocol="3.0" version="update_engine-0.4.10" updaterversion="update_engine-0.4.10" installsource="scheduler" ismachine="1">
May 14 19:32:05.464297 update_engine[1415]:     <os version="Chateau" platform="CoreOS" sp="4334.0.0+afterburn-5.8.0_x86_64"></os>
May 14 19:32:05.464297 update_engine[1415]:     <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="4334.0.0+afterburn-5.8.0" track="developer" bootid="{2b08c796-dc07-4b36-9ec9-f4dea13d5f7a}" oem="openstack" oemversion="0" alephversion="4334.0.0+afterburn-5.8.0" machineid="9aa8709c5ffd4362897a8ae24c102794" machinealias="" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
May 14 19:32:05.464297 update_engine[1415]:         <event eventtype="3" eventresult="0" errorcode="268437456"></event>
May 14 19:32:05.464297 update_engine[1415]:     </app>
May 14 19:32:05.464297 update_engine[1415]: </request>
May 14 19:32:05.464297 update_engine[1415]: I20250514 19:32:05.464111  1415 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 14 19:32:05.465744 update_engine[1415]: I20250514 19:32:05.464319  1415 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 14 19:32:05.465744 update_engine[1415]: I20250514 19:32:05.464706  1415 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 14 19:32:05.469781 locksmithd[1451]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0
May 14 19:32:05.471389 locksmithd[1451]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0
May 14 19:32:05.471512 update_engine[1415]: E20250514 19:32:05.470180  1415 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470266  1415 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470278  1415 omaha_request_action.cc:617] Omaha request response:
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470288  1415 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470294  1415 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470301  1415 update_attempter.cc:306] Processing Done.
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470310  1415 update_attempter.cc:310] Error event sent.
May 14 19:32:05.471512 update_engine[1415]: I20250514 19:32:05.470359  1415 update_check_scheduler.cc:74] Next update check in 49m14s
May 14 19:34:28.986594 etcd-wrapper[1787]: {"level":"info","ts":"2025-05-14T19:34:28.980376Z","caller":"traceutil/trace.go:171","msg":"trace[898047705] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"147.330231ms","start":"2025-05-14T19:34:28.832950Z","end":"2025-05-14T19:34:28.980281Z","steps":["trace[898047705] 'process raft request'  (duration: 86.046058ms)","trace[898047705] 'compare'  (duration: 61.076065ms)"],"step_count":2}