May 13 01:23:04.018955 kernel: Linux version 6.6.89-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.43 p3) 2.43.1) #1 SMP PREEMPT_DYNAMIC Mon May 12 22:05:47 -00 2025
May 13 01:23:04.018981 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=5fa7c1ec1190c634be13c39e3f7599010d1d102f7681a0d92e31c1dc0e6a7a5d
May 13 01:23:04.018992 kernel: BIOS-provided physical RAM map:
May 13 01:23:04.019000 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
May 13 01:23:04.019007 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
May 13 01:23:04.019017 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
May 13 01:23:04.019026 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable
May 13 01:23:04.019034 kernel: BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved
May 13 01:23:04.019042 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
May 13 01:23:04.019049 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
May 13 01:23:04.019057 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable
May 13 01:23:04.019065 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
May 13 01:23:04.019073 kernel: NX (Execute Disable) protection: active
May 13 01:23:04.019081 kernel: APIC: Static calls initialized
May 13 01:23:04.019092 kernel: SMBIOS 3.0.0 present.
May 13 01:23:04.019100 kernel: DMI: OpenStack Foundation OpenStack Nova, BIOS 1.16.3-debian-1.16.3-2 04/01/2014
May 13 01:23:04.019108 kernel: Hypervisor detected: KVM
May 13 01:23:04.019116 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00
May 13 01:23:04.019124 kernel: kvm-clock: using sched offset of 4213814674 cycles
May 13 01:23:04.019149 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
May 13 01:23:04.019159 kernel: tsc: Detected 1996.249 MHz processor
May 13 01:23:04.019168 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 13 01:23:04.019177 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 13 01:23:04.019185 kernel: last_pfn = 0x140000 max_arch_pfn = 0x400000000
May 13 01:23:04.019194 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
May 13 01:23:04.019202 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
May 13 01:23:04.019211 kernel: last_pfn = 0xbffdd max_arch_pfn = 0x400000000
May 13 01:23:04.019219 kernel: ACPI: Early table checksum verification disabled
May 13 01:23:04.019229 kernel: ACPI: RSDP 0x00000000000F51E0 000014 (v00 BOCHS )
May 13 01:23:04.019238 kernel: ACPI: RSDT 0x00000000BFFE1B65 000030 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 01:23:04.019246 kernel: ACPI: FACP 0x00000000BFFE1A49 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 01:23:04.019255 kernel: ACPI: DSDT 0x00000000BFFE0040 001A09 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 01:23:04.019263 kernel: ACPI: FACS 0x00000000BFFE0000 000040
May 13 01:23:04.019271 kernel: ACPI: APIC 0x00000000BFFE1ABD 000080 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 01:23:04.019279 kernel: ACPI: WAET 0x00000000BFFE1B3D 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 13 01:23:04.019288 kernel: ACPI: Reserving FACP table memory at [mem 0xbffe1a49-0xbffe1abc]
May 13 01:23:04.019296 kernel: ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a48]
May 13 01:23:04.019306 kernel: ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
May 13 01:23:04.019315 kernel: ACPI: Reserving APIC table memory at [mem 0xbffe1abd-0xbffe1b3c]
May 13 01:23:04.019323 kernel: ACPI: Reserving WAET table memory at [mem 0xbffe1b3d-0xbffe1b64]
May 13 01:23:04.019334 kernel: No NUMA configuration found
May 13 01:23:04.019343 kernel: Faking a node at [mem 0x0000000000000000-0x000000013fffffff]
May 13 01:23:04.019352 kernel: NODE_DATA(0) allocated [mem 0x13fff7000-0x13fffcfff]
May 13 01:23:04.019362 kernel: Zone ranges:
May 13 01:23:04.019371 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 13 01:23:04.019379 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
May 13 01:23:04.019388 kernel:   Normal   [mem 0x0000000100000000-0x000000013fffffff]
May 13 01:23:04.019397 kernel: Movable zone start for each node
May 13 01:23:04.019405 kernel: Early memory node ranges
May 13 01:23:04.019414 kernel:   node   0: [mem 0x0000000000001000-0x000000000009efff]
May 13 01:23:04.019423 kernel:   node   0: [mem 0x0000000000100000-0x00000000bffdcfff]
May 13 01:23:04.019433 kernel:   node   0: [mem 0x0000000100000000-0x000000013fffffff]
May 13 01:23:04.019442 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff]
May 13 01:23:04.019451 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 13 01:23:04.019459 kernel: On node 0, zone DMA: 97 pages in unavailable ranges
May 13 01:23:04.019468 kernel: On node 0, zone Normal: 35 pages in unavailable ranges
May 13 01:23:04.019477 kernel: ACPI: PM-Timer IO Port: 0x608
May 13 01:23:04.019486 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
May 13 01:23:04.019494 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
May 13 01:23:04.019503 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
May 13 01:23:04.019513 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
May 13 01:23:04.019522 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 13 01:23:04.019531 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
May 13 01:23:04.019540 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
May 13 01:23:04.019548 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 13 01:23:04.019557 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs
May 13 01:23:04.019566 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
May 13 01:23:04.019574 kernel: [mem 0xc0000000-0xfeffbfff] available for PCI devices
May 13 01:23:04.019583 kernel: Booting paravirtualized kernel on KVM
May 13 01:23:04.019593 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
May 13 01:23:04.019602 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
May 13 01:23:04.019611 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u1048576
May 13 01:23:04.019619 kernel: pcpu-alloc: s197032 r8192 d32344 u1048576 alloc=1*2097152
May 13 01:23:04.019628 kernel: pcpu-alloc: [0] 0 1 
May 13 01:23:04.019636 kernel: kvm-guest: PV spinlocks disabled, no host support
May 13 01:23:04.019671 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=5fa7c1ec1190c634be13c39e3f7599010d1d102f7681a0d92e31c1dc0e6a7a5d
May 13 01:23:04.019682 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 13 01:23:04.019693 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 13 01:23:04.019702 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 13 01:23:04.019711 kernel: Fallback order for Node 0: 0 
May 13 01:23:04.019720 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 1031901
May 13 01:23:04.019728 kernel: Policy zone: Normal
May 13 01:23:04.019737 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 13 01:23:04.019745 kernel: software IO TLB: area num 2.
May 13 01:23:04.019754 kernel: Memory: 3964156K/4193772K available (14336K kernel code, 2295K rwdata, 22864K rodata, 43484K init, 1592K bss, 229356K reserved, 0K cma-reserved)
May 13 01:23:04.019763 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
May 13 01:23:04.019773 kernel: ftrace: allocating 37918 entries in 149 pages
May 13 01:23:04.019782 kernel: ftrace: allocated 149 pages with 4 groups
May 13 01:23:04.019791 kernel: Dynamic Preempt: voluntary
May 13 01:23:04.019800 kernel: rcu: Preemptible hierarchical RCU implementation.
May 13 01:23:04.019809 kernel: rcu:         RCU event tracing is enabled.
May 13 01:23:04.019818 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
May 13 01:23:04.019827 kernel:         Trampoline variant of Tasks RCU enabled.
May 13 01:23:04.019835 kernel:         Rude variant of Tasks RCU enabled.
May 13 01:23:04.019844 kernel:         Tracing variant of Tasks RCU enabled.
May 13 01:23:04.019854 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 13 01:23:04.019863 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
May 13 01:23:04.019872 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16
May 13 01:23:04.019880 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 13 01:23:04.019889 kernel: Console: colour VGA+ 80x25
May 13 01:23:04.019898 kernel: printk: console [tty0] enabled
May 13 01:23:04.019906 kernel: printk: console [ttyS0] enabled
May 13 01:23:04.019915 kernel: ACPI: Core revision 20230628
May 13 01:23:04.019923 kernel: APIC: Switch to symmetric I/O mode setup
May 13 01:23:04.019932 kernel: x2apic enabled
May 13 01:23:04.019942 kernel: APIC: Switched APIC routing to: physical x2apic
May 13 01:23:04.019951 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
May 13 01:23:04.019959 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized
May 13 01:23:04.019968 kernel: Calibrating delay loop (skipped) preset value.. 3992.49 BogoMIPS (lpj=1996249)
May 13 01:23:04.019977 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
May 13 01:23:04.019986 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
May 13 01:23:04.019995 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 13 01:23:04.020003 kernel: Spectre V2 : Mitigation: Retpolines
May 13 01:23:04.020012 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
May 13 01:23:04.020022 kernel: Speculative Store Bypass: Vulnerable
May 13 01:23:04.020031 kernel: x86/fpu: x87 FPU will use FXSAVE
May 13 01:23:04.020039 kernel: Freeing SMP alternatives memory: 32K
May 13 01:23:04.020048 kernel: pid_max: default: 32768 minimum: 301
May 13 01:23:04.020063 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity
May 13 01:23:04.020074 kernel: landlock: Up and running.
May 13 01:23:04.020082 kernel: SELinux:  Initializing.
May 13 01:23:04.020092 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 13 01:23:04.020101 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 13 01:23:04.020110 kernel: smpboot: CPU0: AMD Intel Core i7 9xx (Nehalem Class Core i7) (family: 0x6, model: 0x1a, stepping: 0x3)
May 13 01:23:04.020119 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 13 01:23:04.020130 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 13 01:23:04.020140 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
May 13 01:23:04.020149 kernel: Performance Events: AMD PMU driver.
May 13 01:23:04.020158 kernel: ... version:                0
May 13 01:23:04.020167 kernel: ... bit width:              48
May 13 01:23:04.020177 kernel: ... generic registers:      4
May 13 01:23:04.020186 kernel: ... value mask:             0000ffffffffffff
May 13 01:23:04.020195 kernel: ... max period:             00007fffffffffff
May 13 01:23:04.020204 kernel: ... fixed-purpose events:   0
May 13 01:23:04.020214 kernel: ... event mask:             000000000000000f
May 13 01:23:04.020223 kernel: signal: max sigframe size: 1440
May 13 01:23:04.020232 kernel: rcu: Hierarchical SRCU implementation.
May 13 01:23:04.020241 kernel: rcu:         Max phase no-delay instances is 400.
May 13 01:23:04.020250 kernel: smp: Bringing up secondary CPUs ...
May 13 01:23:04.020261 kernel: smpboot: x86: Booting SMP configuration:
May 13 01:23:04.020270 kernel: .... node  #0, CPUs:      #1
May 13 01:23:04.020279 kernel: smp: Brought up 1 node, 2 CPUs
May 13 01:23:04.020288 kernel: smpboot: Max logical packages: 2
May 13 01:23:04.020297 kernel: smpboot: Total of 2 processors activated (7984.99 BogoMIPS)
May 13 01:23:04.020306 kernel: devtmpfs: initialized
May 13 01:23:04.020315 kernel: x86/mm: Memory block size: 128MB
May 13 01:23:04.020324 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 13 01:23:04.020333 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
May 13 01:23:04.020342 kernel: pinctrl core: initialized pinctrl subsystem
May 13 01:23:04.020353 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 13 01:23:04.020362 kernel: audit: initializing netlink subsys (disabled)
May 13 01:23:04.020371 kernel: audit: type=2000 audit(1747099382.679:1): state=initialized audit_enabled=0 res=1
May 13 01:23:04.020380 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 13 01:23:04.020389 kernel: thermal_sys: Registered thermal governor 'user_space'
May 13 01:23:04.020398 kernel: cpuidle: using governor menu
May 13 01:23:04.020407 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 13 01:23:04.020416 kernel: dca service started, version 1.12.1
May 13 01:23:04.020425 kernel: PCI: Using configuration type 1 for base access
May 13 01:23:04.020436 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 13 01:23:04.020445 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 13 01:23:04.020454 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 13 01:23:04.020463 kernel: ACPI: Added _OSI(Module Device)
May 13 01:23:04.020472 kernel: ACPI: Added _OSI(Processor Device)
May 13 01:23:04.020481 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 13 01:23:04.020490 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 13 01:23:04.020499 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 13 01:23:04.020508 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC
May 13 01:23:04.020518 kernel: ACPI: Interpreter enabled
May 13 01:23:04.020528 kernel: ACPI: PM: (supports S0 S3 S5)
May 13 01:23:04.020536 kernel: ACPI: Using IOAPIC for interrupt routing
May 13 01:23:04.020546 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 13 01:23:04.020555 kernel: PCI: Using E820 reservations for host bridge windows
May 13 01:23:04.020564 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F
May 13 01:23:04.020573 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
May 13 01:23:04.020739 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
May 13 01:23:04.020845 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
May 13 01:23:04.020939 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge
May 13 01:23:04.020953 kernel: acpiphp: Slot [3] registered
May 13 01:23:04.020962 kernel: acpiphp: Slot [4] registered
May 13 01:23:04.020971 kernel: acpiphp: Slot [5] registered
May 13 01:23:04.020980 kernel: acpiphp: Slot [6] registered
May 13 01:23:04.020989 kernel: acpiphp: Slot [7] registered
May 13 01:23:04.020998 kernel: acpiphp: Slot [8] registered
May 13 01:23:04.021010 kernel: acpiphp: Slot [9] registered
May 13 01:23:04.021019 kernel: acpiphp: Slot [10] registered
May 13 01:23:04.021028 kernel: acpiphp: Slot [11] registered
May 13 01:23:04.021037 kernel: acpiphp: Slot [12] registered
May 13 01:23:04.021046 kernel: acpiphp: Slot [13] registered
May 13 01:23:04.021055 kernel: acpiphp: Slot [14] registered
May 13 01:23:04.021064 kernel: acpiphp: Slot [15] registered
May 13 01:23:04.021073 kernel: acpiphp: Slot [16] registered
May 13 01:23:04.021082 kernel: acpiphp: Slot [17] registered
May 13 01:23:04.021093 kernel: acpiphp: Slot [18] registered
May 13 01:23:04.021102 kernel: acpiphp: Slot [19] registered
May 13 01:23:04.021111 kernel: acpiphp: Slot [20] registered
May 13 01:23:04.021119 kernel: acpiphp: Slot [21] registered
May 13 01:23:04.021128 kernel: acpiphp: Slot [22] registered
May 13 01:23:04.021137 kernel: acpiphp: Slot [23] registered
May 13 01:23:04.021146 kernel: acpiphp: Slot [24] registered
May 13 01:23:04.021155 kernel: acpiphp: Slot [25] registered
May 13 01:23:04.021164 kernel: acpiphp: Slot [26] registered
May 13 01:23:04.021173 kernel: acpiphp: Slot [27] registered
May 13 01:23:04.021184 kernel: acpiphp: Slot [28] registered
May 13 01:23:04.021192 kernel: acpiphp: Slot [29] registered
May 13 01:23:04.021201 kernel: acpiphp: Slot [30] registered
May 13 01:23:04.021210 kernel: acpiphp: Slot [31] registered
May 13 01:23:04.021219 kernel: PCI host bridge to bus 0000:00
May 13 01:23:04.021320 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
May 13 01:23:04.021408 kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
May 13 01:23:04.021492 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
May 13 01:23:04.021581 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
May 13 01:23:04.021688 kernel: pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window]
May 13 01:23:04.021773 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
May 13 01:23:04.021887 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
May 13 01:23:04.021993 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
May 13 01:23:04.022095 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
May 13 01:23:04.022199 kernel: pci 0000:00:01.1: reg 0x20: [io  0xc120-0xc12f]
May 13 01:23:04.022305 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
May 13 01:23:04.022400 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
May 13 01:23:04.022495 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
May 13 01:23:04.022590 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
May 13 01:23:04.022725 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
May 13 01:23:04.022826 kernel: pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
May 13 01:23:04.022927 kernel: pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
May 13 01:23:04.023031 kernel: pci 0000:00:02.0: [1af4:1050] type 00 class 0x030000
May 13 01:23:04.023130 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfe000000-0xfe7fffff pref]
May 13 01:23:04.023249 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xc000000000-0xc000003fff 64bit pref]
May 13 01:23:04.023346 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfeb90000-0xfeb90fff]
May 13 01:23:04.023441 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfeb8ffff pref]
May 13 01:23:04.023536 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
May 13 01:23:04.023645 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
May 13 01:23:04.023766 kernel: pci 0000:00:03.0: reg 0x10: [io  0xc080-0xc0bf]
May 13 01:23:04.023862 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfeb91000-0xfeb91fff]
May 13 01:23:04.023958 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xc000004000-0xc000007fff 64bit pref]
May 13 01:23:04.024053 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref]
May 13 01:23:04.024154 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
May 13 01:23:04.024256 kernel: pci 0000:00:04.0: reg 0x10: [io  0xc000-0xc07f]
May 13 01:23:04.024352 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfeb92000-0xfeb92fff]
May 13 01:23:04.024448 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xc000008000-0xc00000bfff 64bit pref]
May 13 01:23:04.024553 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00
May 13 01:23:04.024665 kernel: pci 0000:00:05.0: reg 0x10: [io  0xc0c0-0xc0ff]
May 13 01:23:04.024783 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xc00000c000-0xc00000ffff 64bit pref]
May 13 01:23:04.024888 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00
May 13 01:23:04.024991 kernel: pci 0000:00:06.0: reg 0x10: [io  0xc100-0xc11f]
May 13 01:23:04.025088 kernel: pci 0000:00:06.0: reg 0x14: [mem 0xfeb93000-0xfeb93fff]
May 13 01:23:04.025185 kernel: pci 0000:00:06.0: reg 0x20: [mem 0xc000010000-0xc000013fff 64bit pref]
May 13 01:23:04.025199 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10
May 13 01:23:04.025209 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10
May 13 01:23:04.025218 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11
May 13 01:23:04.025227 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11
May 13 01:23:04.025236 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9
May 13 01:23:04.025245 kernel: iommu: Default domain type: Translated
May 13 01:23:04.025258 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 13 01:23:04.025268 kernel: PCI: Using ACPI for IRQ routing
May 13 01:23:04.025277 kernel: PCI: pci_cache_line_size set to 64 bytes
May 13 01:23:04.025285 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
May 13 01:23:04.025295 kernel: e820: reserve RAM buffer [mem 0xbffdd000-0xbfffffff]
May 13 01:23:04.025388 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device
May 13 01:23:04.025484 kernel: pci 0000:00:02.0: vgaarb: bridge control possible
May 13 01:23:04.025579 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
May 13 01:23:04.025597 kernel: vgaarb: loaded
May 13 01:23:04.025606 kernel: clocksource: Switched to clocksource kvm-clock
May 13 01:23:04.025615 kernel: VFS: Disk quotas dquot_6.6.0
May 13 01:23:04.025624 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 13 01:23:04.025633 kernel: pnp: PnP ACPI init
May 13 01:23:04.027771 kernel: pnp 00:03: [dma 2]
May 13 01:23:04.027792 kernel: pnp: PnP ACPI: found 5 devices
May 13 01:23:04.027802 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 13 01:23:04.027812 kernel: NET: Registered PF_INET protocol family
May 13 01:23:04.027825 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
May 13 01:23:04.027834 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
May 13 01:23:04.027844 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 13 01:23:04.027853 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 13 01:23:04.027862 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
May 13 01:23:04.027872 kernel: TCP: Hash tables configured (established 32768 bind 32768)
May 13 01:23:04.027881 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 13 01:23:04.027891 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 13 01:23:04.027902 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 13 01:23:04.027911 kernel: NET: Registered PF_XDP protocol family
May 13 01:23:04.027996 kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
May 13 01:23:04.028080 kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
May 13 01:23:04.028162 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
May 13 01:23:04.028245 kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
May 13 01:23:04.028328 kernel: pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window]
May 13 01:23:04.028427 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release
May 13 01:23:04.028524 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers
May 13 01:23:04.028543 kernel: PCI: CLS 0 bytes, default 64
May 13 01:23:04.028552 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 13 01:23:04.028562 kernel: software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB)
May 13 01:23:04.028571 kernel: Initialise system trusted keyrings
May 13 01:23:04.028580 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
May 13 01:23:04.028590 kernel: Key type asymmetric registered
May 13 01:23:04.028599 kernel: Asymmetric key parser 'x509' registered
May 13 01:23:04.028608 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
May 13 01:23:04.028619 kernel: io scheduler mq-deadline registered
May 13 01:23:04.028628 kernel: io scheduler kyber registered
May 13 01:23:04.028637 kernel: io scheduler bfq registered
May 13 01:23:04.028670 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
May 13 01:23:04.028681 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10
May 13 01:23:04.028691 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11
May 13 01:23:04.028701 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11
May 13 01:23:04.028710 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10
May 13 01:23:04.028719 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 13 01:23:04.028731 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 13 01:23:04.028740 kernel: random: crng init done
May 13 01:23:04.028749 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
May 13 01:23:04.028759 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
May 13 01:23:04.028768 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
May 13 01:23:04.028867 kernel: rtc_cmos 00:04: RTC can wake from S4
May 13 01:23:04.028883 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
May 13 01:23:04.028966 kernel: rtc_cmos 00:04: registered as rtc0
May 13 01:23:04.029056 kernel: rtc_cmos 00:04: setting system clock to 2025-05-13T01:23:03 UTC (1747099383)
May 13 01:23:04.029141 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram
May 13 01:23:04.029155 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
May 13 01:23:04.029165 kernel: NET: Registered PF_INET6 protocol family
May 13 01:23:04.029174 kernel: Segment Routing with IPv6
May 13 01:23:04.029183 kernel: In-situ OAM (IOAM) with IPv6
May 13 01:23:04.029192 kernel: NET: Registered PF_PACKET protocol family
May 13 01:23:04.029201 kernel: Key type dns_resolver registered
May 13 01:23:04.029210 kernel: IPI shorthand broadcast: enabled
May 13 01:23:04.029223 kernel: sched_clock: Marking stable (985006464, 169591056)->(1187681877, -33084357)
May 13 01:23:04.029232 kernel: registered taskstats version 1
May 13 01:23:04.029241 kernel: Loading compiled-in X.509 certificates
May 13 01:23:04.029250 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: d95820acae50a149bf4631b9744f68258af45186'
May 13 01:23:04.029260 kernel: Key type .fscrypt registered
May 13 01:23:04.029269 kernel: Key type fscrypt-provisioning registered
May 13 01:23:04.029278 kernel: ima: No TPM chip found, activating TPM-bypass!
May 13 01:23:04.029287 kernel: ima: Allocated hash algorithm: sha1
May 13 01:23:04.029296 kernel: ima: No architecture policies found
May 13 01:23:04.029307 kernel: clk: Disabling unused clocks
May 13 01:23:04.029316 kernel: Freeing unused kernel image (initmem) memory: 43484K
May 13 01:23:04.029326 kernel: Write protecting the kernel read-only data: 38912k
May 13 01:23:04.029335 kernel: Freeing unused kernel image (rodata/data gap) memory: 1712K
May 13 01:23:04.029344 kernel: Run /init as init process
May 13 01:23:04.029353 kernel:   with arguments:
May 13 01:23:04.029362 kernel:     /init
May 13 01:23:04.029371 kernel:   with environment:
May 13 01:23:04.029380 kernel:     HOME=/
May 13 01:23:04.029391 kernel:     TERM=linux
May 13 01:23:04.029400 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 13 01:23:04.029410 systemd[1]: Successfully made /usr/ read-only.
May 13 01:23:04.029423 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 13 01:23:04.029434 systemd[1]: Detected virtualization kvm.
May 13 01:23:04.029443 systemd[1]: Detected architecture x86-64.
May 13 01:23:04.029453 systemd[1]: Running in initrd.
May 13 01:23:04.029464 systemd[1]: No hostname configured, using default hostname.
May 13 01:23:04.029475 systemd[1]: Hostname set to <localhost>.
May 13 01:23:04.029484 systemd[1]: Initializing machine ID from VM UUID.
May 13 01:23:04.029494 systemd[1]: Queued start job for default target initrd.target.
May 13 01:23:04.029503 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 13 01:23:04.029513 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 13 01:23:04.029524 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 13 01:23:04.029542 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 13 01:23:04.029554 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 13 01:23:04.029565 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 13 01:23:04.029576 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
May 13 01:23:04.029587 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 13 01:23:04.029599 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 13 01:23:04.029609 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 13 01:23:04.029619 systemd[1]: Reached target paths.target - Path Units.
May 13 01:23:04.029629 systemd[1]: Reached target slices.target - Slice Units.
May 13 01:23:04.029639 systemd[1]: Reached target swap.target - Swaps.
May 13 01:23:04.029664 systemd[1]: Reached target timers.target - Timer Units.
May 13 01:23:04.029675 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 13 01:23:04.029685 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 13 01:23:04.029695 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 13 01:23:04.029708 systemd[1]: Listening on systemd-journald.socket - Journal Sockets.
May 13 01:23:04.029718 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 13 01:23:04.029728 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 13 01:23:04.029738 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 13 01:23:04.029748 systemd[1]: Reached target sockets.target - Socket Units.
May 13 01:23:04.029758 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 13 01:23:04.029769 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 13 01:23:04.029779 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 13 01:23:04.029789 systemd[1]: Starting systemd-fsck-usr.service...
May 13 01:23:04.029801 systemd[1]: Starting systemd-journald.service - Journal Service...
May 13 01:23:04.029811 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 13 01:23:04.029841 systemd-journald[184]: Collecting audit messages is disabled.
May 13 01:23:04.029867 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 01:23:04.029880 systemd-journald[184]: Journal started
May 13 01:23:04.029903 systemd-journald[184]: Runtime Journal (/run/log/journal/9e9d2348319b46ef9d27b950eaebd2ae) is 8M, max 78.3M, 70.3M free.
May 13 01:23:04.038665 systemd[1]: Started systemd-journald.service - Journal Service.
May 13 01:23:04.041441 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 13 01:23:04.042923 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 13 01:23:04.046091 systemd[1]: Finished systemd-fsck-usr.service.
May 13 01:23:04.053422 systemd-modules-load[186]: Inserted module 'overlay'
May 13 01:23:04.100833 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 13 01:23:04.100858 kernel: Bridge firewalling registered
May 13 01:23:04.058777 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 13 01:23:04.081058 systemd-modules-load[186]: Inserted module 'br_netfilter'
May 13 01:23:04.109776 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 13 01:23:04.111332 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 13 01:23:04.112764 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:04.114275 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 13 01:23:04.121832 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 13 01:23:04.123808 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 13 01:23:04.125965 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 13 01:23:04.129261 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 13 01:23:04.136020 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 13 01:23:04.142222 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 13 01:23:04.144760 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 13 01:23:04.151834 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 01:23:04.155778 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 13 01:23:04.168936 dracut-cmdline[223]: dracut-dracut-053
May 13 01:23:04.171711 dracut-cmdline[223]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=5fa7c1ec1190c634be13c39e3f7599010d1d102f7681a0d92e31c1dc0e6a7a5d
May 13 01:23:04.189128 systemd-resolved[214]: Positive Trust Anchors:
May 13 01:23:04.189814 systemd-resolved[214]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 13 01:23:04.190594 systemd-resolved[214]: 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 13 01:23:04.195996 systemd-resolved[214]: Defaulting to hostname 'linux'.
May 13 01:23:04.197353 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 13 01:23:04.197900 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 13 01:23:04.234698 kernel: SCSI subsystem initialized
May 13 01:23:04.245701 kernel: Loading iSCSI transport class v2.0-870.
May 13 01:23:04.257695 kernel: iscsi: registered transport (tcp)
May 13 01:23:04.279956 kernel: iscsi: registered transport (qla4xxx)
May 13 01:23:04.280017 kernel: QLogic iSCSI HBA Driver
May 13 01:23:04.327835 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 13 01:23:04.333917 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 13 01:23:04.380229 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 13 01:23:04.380344 kernel: device-mapper: uevent: version 1.0.3
May 13 01:23:04.383413 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
May 13 01:23:04.445747 kernel: raid6: sse2x4   gen()  5206 MB/s
May 13 01:23:04.464705 kernel: raid6: sse2x2   gen()  5994 MB/s
May 13 01:23:04.483615 kernel: raid6: sse2x1   gen() 10173 MB/s
May 13 01:23:04.483725 kernel: raid6: using algorithm sse2x1 gen() 10173 MB/s
May 13 01:23:04.502589 kernel: raid6: .... xor() 7393 MB/s, rmw enabled
May 13 01:23:04.502695 kernel: raid6: using ssse3x2 recovery algorithm
May 13 01:23:04.525605 kernel: xor: measuring software checksum speed
May 13 01:23:04.525695 kernel:    prefetch64-sse  : 18425 MB/sec
May 13 01:23:04.525727 kernel:    generic_sse     : 16077 MB/sec
May 13 01:23:04.528730 kernel: xor: using function: prefetch64-sse (18425 MB/sec)
May 13 01:23:04.702712 kernel: Btrfs loaded, zoned=no, fsverity=no
May 13 01:23:04.717480 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 13 01:23:04.728889 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 13 01:23:04.742893 systemd-udevd[405]: Using default interface naming scheme 'v255'.
May 13 01:23:04.747881 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 13 01:23:04.756888 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 13 01:23:04.773414 dracut-pre-trigger[417]: rd.md=0: removing MD RAID activation
May 13 01:23:04.811825 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 13 01:23:04.817765 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 13 01:23:04.873594 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 13 01:23:04.887975 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 13 01:23:04.936279 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 13 01:23:04.937872 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 13 01:23:04.939199 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 13 01:23:04.940450 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 13 01:23:04.945792 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 13 01:23:04.956174 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 13 01:23:04.959413 kernel: virtio_blk virtio2: 2/0/0 default/read/poll queues
May 13 01:23:04.976085 kernel: virtio_blk virtio2: [vda] 20971520 512-byte logical blocks (10.7 GB/10.0 GiB)
May 13 01:23:04.992469 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
May 13 01:23:04.992502 kernel: GPT:17805311 != 20971519
May 13 01:23:04.992514 kernel: GPT:Alternate GPT header not at the end of the disk.
May 13 01:23:04.995595 kernel: GPT:17805311 != 20971519
May 13 01:23:04.995620 kernel: GPT: Use GNU Parted to correct GPT errors.
May 13 01:23:04.995971 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 13 01:23:05.001728 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 01:23:04.996113 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 01:23:05.004033 kernel: libata version 3.00 loaded.
May 13 01:23:05.000318 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 13 01:23:05.000877 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 01:23:05.001026 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:05.002748 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 13 01:23:05.009903 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 01:23:05.014891 kernel: ata_piix 0000:00:01.1: version 2.13
May 13 01:23:05.016735 kernel: scsi host0: ata_piix
May 13 01:23:05.016884 kernel: scsi host1: ata_piix
May 13 01:23:05.017706 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14
May 13 01:23:05.019748 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15
May 13 01:23:05.056683 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (458)
May 13 01:23:05.063675 kernel: BTRFS: device fsid 3e20f71b-219b-4481-b973-b1b0271e18c1 devid 1 transid 42 /dev/vda3 scanned by (udev-worker) (471)
May 13 01:23:05.078686 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
May 13 01:23:05.107396 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:05.118699 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
May 13 01:23:05.130270 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 13 01:23:05.139099 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
May 13 01:23:05.139683 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
May 13 01:23:05.145800 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 13 01:23:05.148276 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 13 01:23:05.160864 disk-uuid[508]: Primary Header is updated.
May 13 01:23:05.160864 disk-uuid[508]: Secondary Entries is updated.
May 13 01:23:05.160864 disk-uuid[508]: Secondary Header is updated.
May 13 01:23:05.169639 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 01:23:05.172684 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 01:23:06.194859 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 13 01:23:06.196257 disk-uuid[514]: The operation has completed successfully.
May 13 01:23:06.279732 systemd[1]: disk-uuid.service: Deactivated successfully.
May 13 01:23:06.279842 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 13 01:23:06.336781 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 13 01:23:06.344056 sh[531]: Success
May 13 01:23:06.363748 kernel: device-mapper: verity: sha256 using implementation "sha256-ssse3"
May 13 01:23:06.448924 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 13 01:23:06.450814 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 13 01:23:06.457134 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 13 01:23:06.475704 kernel: BTRFS info (device dm-0): first mount of filesystem 3e20f71b-219b-4481-b973-b1b0271e18c1
May 13 01:23:06.475771 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
May 13 01:23:06.478008 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
May 13 01:23:06.481971 kernel: BTRFS info (device dm-0): disabling log replay at mount time
May 13 01:23:06.482026 kernel: BTRFS info (device dm-0): using free space tree
May 13 01:23:06.499332 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 13 01:23:06.500253 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 13 01:23:06.507807 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 13 01:23:06.511775 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 13 01:23:06.536850 kernel: BTRFS info (device vda6): first mount of filesystem 37df245c-8784-48a4-9eff-5b32614fef7c
May 13 01:23:06.536923 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 13 01:23:06.536965 kernel: BTRFS info (device vda6): using free space tree
May 13 01:23:06.545707 kernel: BTRFS info (device vda6): auto enabling async discard
May 13 01:23:06.555718 kernel: BTRFS info (device vda6): last unmount of filesystem 37df245c-8784-48a4-9eff-5b32614fef7c
May 13 01:23:06.564539 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 13 01:23:06.571854 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 13 01:23:06.638596 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 13 01:23:06.644802 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 13 01:23:06.668730 systemd-networkd[710]: lo: Link UP
May 13 01:23:06.668740 systemd-networkd[710]: lo: Gained carrier
May 13 01:23:06.669926 systemd-networkd[710]: Enumeration completed
May 13 01:23:06.670247 systemd-networkd[710]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 01:23:06.670251 systemd-networkd[710]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 13 01:23:06.671706 systemd-networkd[710]: eth0: Link UP
May 13 01:23:06.671709 systemd-networkd[710]: eth0: Gained carrier
May 13 01:23:06.671718 systemd-networkd[710]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 01:23:06.673005 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 13 01:23:06.675937 systemd[1]: Reached target network.target - Network.
May 13 01:23:06.686696 systemd-networkd[710]: eth0: DHCPv4 address 172.24.4.73/24, gateway 172.24.4.1 acquired from 172.24.4.1
May 13 01:23:06.768955 ignition[630]: Ignition 2.20.0
May 13 01:23:06.769723 ignition[630]: Stage: fetch-offline
May 13 01:23:06.769760 ignition[630]: no configs at "/usr/lib/ignition/base.d"
May 13 01:23:06.769769 ignition[630]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:06.772114 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 13 01:23:06.769864 ignition[630]: parsed url from cmdline: ""
May 13 01:23:06.769868 ignition[630]: no config URL provided
May 13 01:23:06.769873 ignition[630]: reading system config file "/usr/lib/ignition/user.ign"
May 13 01:23:06.769881 ignition[630]: no config at "/usr/lib/ignition/user.ign"
May 13 01:23:06.769886 ignition[630]: failed to fetch config: resource requires networking
May 13 01:23:06.770053 ignition[630]: Ignition finished successfully
May 13 01:23:06.782805 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
May 13 01:23:06.807186 ignition[721]: Ignition 2.20.0
May 13 01:23:06.807214 ignition[721]: Stage: fetch
May 13 01:23:06.807608 ignition[721]: no configs at "/usr/lib/ignition/base.d"
May 13 01:23:06.807635 ignition[721]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:06.807899 ignition[721]: parsed url from cmdline: ""
May 13 01:23:06.807908 ignition[721]: no config URL provided
May 13 01:23:06.807924 ignition[721]: reading system config file "/usr/lib/ignition/user.ign"
May 13 01:23:06.807944 ignition[721]: no config at "/usr/lib/ignition/user.ign"
May 13 01:23:06.808117 ignition[721]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1
May 13 01:23:06.808149 ignition[721]: config drive ("/dev/disk/by-label/config-2") not found. Waiting...
May 13 01:23:06.808183 ignition[721]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting...
May 13 01:23:07.069951 ignition[721]: GET result: OK
May 13 01:23:07.071716 ignition[721]: parsing config with SHA512: e9c9479218e596283b2109fe887625d50742c3481368b57d91f63dc85b2d8a946d88ac8c31a4f3e4ec15d1628f27480d80954981cc5968e0df58658dd834175d
May 13 01:23:07.089908 unknown[721]: fetched base config from "system"
May 13 01:23:07.089937 unknown[721]: fetched base config from "system"
May 13 01:23:07.090447 ignition[721]: fetch: fetch complete
May 13 01:23:07.089952 unknown[721]: fetched user config from "openstack"
May 13 01:23:07.090461 ignition[721]: fetch: fetch passed
May 13 01:23:07.093817 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
May 13 01:23:07.090548 ignition[721]: Ignition finished successfully
May 13 01:23:07.103955 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 13 01:23:07.145194 ignition[727]: Ignition 2.20.0
May 13 01:23:07.145212 ignition[727]: Stage: kargs
May 13 01:23:07.145615 ignition[727]: no configs at "/usr/lib/ignition/base.d"
May 13 01:23:07.145641 ignition[727]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:07.149941 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 13 01:23:07.147387 ignition[727]: kargs: kargs passed
May 13 01:23:07.147478 ignition[727]: Ignition finished successfully
May 13 01:23:07.159946 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 13 01:23:07.191577 ignition[733]: Ignition 2.20.0
May 13 01:23:07.191604 ignition[733]: Stage: disks
May 13 01:23:07.192067 ignition[733]: no configs at "/usr/lib/ignition/base.d"
May 13 01:23:07.192093 ignition[733]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:07.197790 ignition[733]: disks: disks passed
May 13 01:23:07.199611 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 13 01:23:07.197881 ignition[733]: Ignition finished successfully
May 13 01:23:07.202169 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 13 01:23:07.203951 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 13 01:23:07.206573 systemd[1]: Reached target local-fs.target - Local File Systems.
May 13 01:23:07.208999 systemd[1]: Reached target sysinit.target - System Initialization.
May 13 01:23:07.211924 systemd[1]: Reached target basic.target - Basic System.
May 13 01:23:07.225010 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 13 01:23:07.256512 systemd-fsck[741]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks
May 13 01:23:07.269313 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 13 01:23:07.278864 systemd[1]: Mounting sysroot.mount - /sysroot...
May 13 01:23:07.445686 kernel: EXT4-fs (vda9): mounted filesystem 87f139f9-1bcd-498d-9753-0a353ad6da1c r/w with ordered data mode. Quota mode: none.
May 13 01:23:07.446905 systemd[1]: Mounted sysroot.mount - /sysroot.
May 13 01:23:07.448425 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 13 01:23:07.454725 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 13 01:23:07.463798 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 13 01:23:07.467105 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
May 13 01:23:07.469881 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent...
May 13 01:23:07.471358 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 13 01:23:07.471389 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 13 01:23:07.475038 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 13 01:23:07.483743 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (749)
May 13 01:23:07.487502 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 13 01:23:07.514453 kernel: BTRFS info (device vda6): first mount of filesystem 37df245c-8784-48a4-9eff-5b32614fef7c
May 13 01:23:07.514500 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 13 01:23:07.514541 kernel: BTRFS info (device vda6): using free space tree
May 13 01:23:07.514572 kernel: BTRFS info (device vda6): auto enabling async discard
May 13 01:23:07.518618 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 13 01:23:07.642073 initrd-setup-root[776]: cut: /sysroot/etc/passwd: No such file or directory
May 13 01:23:07.649007 initrd-setup-root[784]: cut: /sysroot/etc/group: No such file or directory
May 13 01:23:07.657030 initrd-setup-root[791]: cut: /sysroot/etc/shadow: No such file or directory
May 13 01:23:07.664823 initrd-setup-root[798]: cut: /sysroot/etc/gshadow: No such file or directory
May 13 01:23:07.791362 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 13 01:23:07.798846 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 13 01:23:07.804867 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 13 01:23:07.810741 kernel: BTRFS info (device vda6): last unmount of filesystem 37df245c-8784-48a4-9eff-5b32614fef7c
May 13 01:23:07.810946 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 13 01:23:07.842969 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 13 01:23:07.844358 ignition[865]: INFO     : Ignition 2.20.0
May 13 01:23:07.844358 ignition[865]: INFO     : Stage: mount
May 13 01:23:07.846289 ignition[865]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 13 01:23:07.846289 ignition[865]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:07.846289 ignition[865]: INFO     : mount: mount passed
May 13 01:23:07.846289 ignition[865]: INFO     : Ignition finished successfully
May 13 01:23:07.848837 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 13 01:23:08.079955 systemd-networkd[710]: eth0: Gained IPv6LL
May 13 01:23:14.703831 coreos-metadata[751]: May 13 01:23:14.703 WARN failed to locate config-drive, using the metadata service API instead
May 13 01:23:14.744113 coreos-metadata[751]: May 13 01:23:14.743 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1
May 13 01:23:14.762278 coreos-metadata[751]: May 13 01:23:14.762 INFO Fetch successful
May 13 01:23:14.766132 coreos-metadata[751]: May 13 01:23:14.764 INFO wrote hostname ci-4230-1-1-n-37513c080a.novalocal to /sysroot/etc/hostname
May 13 01:23:14.766131 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully.
May 13 01:23:14.766351 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent.
May 13 01:23:14.787894 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 13 01:23:14.811018 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 13 01:23:14.830885 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (882)
May 13 01:23:14.838419 kernel: BTRFS info (device vda6): first mount of filesystem 37df245c-8784-48a4-9eff-5b32614fef7c
May 13 01:23:14.838485 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 13 01:23:14.842750 kernel: BTRFS info (device vda6): using free space tree
May 13 01:23:14.854769 kernel: BTRFS info (device vda6): auto enabling async discard
May 13 01:23:14.859631 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 13 01:23:14.902554 ignition[900]: INFO     : Ignition 2.20.0
May 13 01:23:14.902554 ignition[900]: INFO     : Stage: files
May 13 01:23:14.905472 ignition[900]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 13 01:23:14.905472 ignition[900]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:14.905472 ignition[900]: DEBUG    : files: compiled without relabeling support, skipping
May 13 01:23:14.911039 ignition[900]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 13 01:23:14.911039 ignition[900]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 13 01:23:14.915240 ignition[900]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 13 01:23:14.915240 ignition[900]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 13 01:23:14.915240 ignition[900]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 13 01:23:14.914628 unknown[900]: wrote ssh authorized keys file for user: core
May 13 01:23:14.924776 ignition[900]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 13 01:23:14.924776 ignition[900]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(4): [started]  processing unit "coreos-metadata-sshkeys@.service"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(4): op(5): [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 13 01:23:14.924776 ignition[900]: INFO     : files: op(4): op(5): [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 13 01:23:14.924776 ignition[900]: INFO     : files: op(4): [finished] processing unit "coreos-metadata-sshkeys@.service"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(6): [started]  processing unit "etcd-member.service"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(6): op(7): [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 13 01:23:14.924776 ignition[900]: INFO     : files: op(6): op(7): [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 13 01:23:14.924776 ignition[900]: INFO     : files: op(6): [finished] processing unit "etcd-member.service"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(8): [started]  processing unit "coreos-metadata.service"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(8): op(9): [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 13 01:23:14.924776 ignition[900]: INFO     : files: op(8): op(9): [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 13 01:23:14.924776 ignition[900]: INFO     : files: op(8): [finished] processing unit "coreos-metadata.service"
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(a): [started]  setting preset to enabled for "coreos-metadata-sshkeys@.service "
May 13 01:23:14.924776 ignition[900]: INFO     : files: op(a): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service "
May 13 01:23:14.957207 ignition[900]: INFO     : files: op(b): [started]  setting preset to enabled for "etcd-member.service"
May 13 01:23:14.957207 ignition[900]: INFO     : files: op(b): [finished] setting preset to enabled for "etcd-member.service"
May 13 01:23:14.957207 ignition[900]: INFO     : files: createResultFile: createFiles: op(c): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 13 01:23:14.957207 ignition[900]: INFO     : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 13 01:23:14.957207 ignition[900]: INFO     : files: files passed
May 13 01:23:14.957207 ignition[900]: INFO     : Ignition finished successfully
May 13 01:23:14.948485 systemd[1]: Finished ignition-files.service - Ignition (files).
May 13 01:23:14.961946 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 13 01:23:14.972804 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 13 01:23:14.978441 systemd[1]: ignition-quench.service: Deactivated successfully.
May 13 01:23:14.978531 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 13 01:23:14.989100 initrd-setup-root-after-ignition[928]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 13 01:23:14.989100 initrd-setup-root-after-ignition[928]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 13 01:23:14.994187 initrd-setup-root-after-ignition[932]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 13 01:23:14.993909 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 13 01:23:14.995144 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 13 01:23:15.007782 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 13 01:23:15.025504 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 13 01:23:15.025612 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 13 01:23:15.026987 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 13 01:23:15.027946 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 13 01:23:15.029088 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 13 01:23:15.030186 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 13 01:23:15.045698 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 13 01:23:15.050771 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 13 01:23:15.061112 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 13 01:23:15.062463 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 13 01:23:15.063160 systemd[1]: Stopped target timers.target - Timer Units.
May 13 01:23:15.067994 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 13 01:23:15.068116 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 13 01:23:15.069251 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 13 01:23:15.069957 systemd[1]: Stopped target basic.target - Basic System.
May 13 01:23:15.071065 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 13 01:23:15.072086 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 13 01:23:15.073092 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 13 01:23:15.074242 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 13 01:23:15.075384 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 13 01:23:15.076541 systemd[1]: Stopped target sysinit.target - System Initialization.
May 13 01:23:15.077662 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 13 01:23:15.078818 systemd[1]: Stopped target swap.target - Swaps.
May 13 01:23:15.079867 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 13 01:23:15.079980 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 13 01:23:15.081159 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 13 01:23:15.081903 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 13 01:23:15.082836 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 13 01:23:15.082938 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 13 01:23:15.083956 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 13 01:23:15.084070 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 13 01:23:15.085531 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 13 01:23:15.085677 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 13 01:23:15.086862 systemd[1]: ignition-files.service: Deactivated successfully.
May 13 01:23:15.087019 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 13 01:23:15.097113 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 13 01:23:15.099869 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 13 01:23:15.100394 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 13 01:23:15.100563 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 13 01:23:15.101851 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 13 01:23:15.102797 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 13 01:23:15.112790 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 13 01:23:15.112881 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 13 01:23:15.120441 ignition[952]: INFO     : Ignition 2.20.0
May 13 01:23:15.120441 ignition[952]: INFO     : Stage: umount
May 13 01:23:15.120441 ignition[952]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 13 01:23:15.120441 ignition[952]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/openstack"
May 13 01:23:15.120441 ignition[952]: INFO     : umount: umount passed
May 13 01:23:15.120441 ignition[952]: INFO     : Ignition finished successfully
May 13 01:23:15.121930 systemd[1]: ignition-mount.service: Deactivated successfully.
May 13 01:23:15.122048 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 13 01:23:15.123750 systemd[1]: ignition-disks.service: Deactivated successfully.
May 13 01:23:15.123828 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 13 01:23:15.125852 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 13 01:23:15.125895 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 13 01:23:15.127818 systemd[1]: ignition-fetch.service: Deactivated successfully.
May 13 01:23:15.127860 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
May 13 01:23:15.128433 systemd[1]: Stopped target network.target - Network.
May 13 01:23:15.128948 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 13 01:23:15.128994 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 13 01:23:15.129500 systemd[1]: Stopped target paths.target - Path Units.
May 13 01:23:15.131061 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 13 01:23:15.131125 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 13 01:23:15.132127 systemd[1]: Stopped target slices.target - Slice Units.
May 13 01:23:15.133089 systemd[1]: Stopped target sockets.target - Socket Units.
May 13 01:23:15.134045 systemd[1]: iscsid.socket: Deactivated successfully.
May 13 01:23:15.134083 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 13 01:23:15.135019 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 13 01:23:15.135049 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 13 01:23:15.135988 systemd[1]: ignition-setup.service: Deactivated successfully.
May 13 01:23:15.136037 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 13 01:23:15.137108 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 13 01:23:15.137148 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 13 01:23:15.138329 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 13 01:23:15.139345 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 13 01:23:15.141373 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 13 01:23:15.141998 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 13 01:23:15.142078 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 13 01:23:15.142974 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 13 01:23:15.143038 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 13 01:23:15.145415 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 13 01:23:15.145500 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 13 01:23:15.149137 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
May 13 01:23:15.149361 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 13 01:23:15.149458 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 13 01:23:15.151302 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
May 13 01:23:15.151915 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 13 01:23:15.151959 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 13 01:23:15.157771 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 13 01:23:15.159614 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 13 01:23:15.159696 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 13 01:23:15.160848 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 13 01:23:15.160892 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 13 01:23:15.162217 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 13 01:23:15.162258 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 13 01:23:15.162959 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 13 01:23:15.162999 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 13 01:23:15.164465 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 13 01:23:15.167206 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
May 13 01:23:15.167265 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully.
May 13 01:23:15.175117 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 13 01:23:15.176120 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 13 01:23:15.177503 systemd[1]: network-cleanup.service: Deactivated successfully.
May 13 01:23:15.177580 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 13 01:23:15.178549 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 13 01:23:15.178597 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 13 01:23:15.179424 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 13 01:23:15.179457 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 13 01:23:15.180473 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 13 01:23:15.180516 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 13 01:23:15.181938 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 13 01:23:15.181978 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 13 01:23:15.183072 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 13 01:23:15.183126 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 13 01:23:15.189996 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 13 01:23:15.190544 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 13 01:23:15.190594 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 13 01:23:15.191270 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
May 13 01:23:15.191314 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 13 01:23:15.191926 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 13 01:23:15.191968 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 13 01:23:15.193130 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 01:23:15.193171 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:15.198026 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 13 01:23:15.198115 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 13 01:23:15.199230 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 13 01:23:15.205008 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 13 01:23:15.212222 systemd[1]: Switching root.
May 13 01:23:15.243173 systemd-journald[184]: Journal stopped
May 13 01:23:16.548867 systemd-journald[184]: Received SIGTERM from PID 1 (systemd).
May 13 01:23:16.548924 kernel: SELinux:  policy capability network_peer_controls=1
May 13 01:23:16.548940 kernel: SELinux:  policy capability open_perms=1
May 13 01:23:16.548952 kernel: SELinux:  policy capability extended_socket_class=1
May 13 01:23:16.548964 kernel: SELinux:  policy capability always_check_network=0
May 13 01:23:16.548976 kernel: SELinux:  policy capability cgroup_seclabel=1
May 13 01:23:16.548988 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 13 01:23:16.549006 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 13 01:23:16.549020 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 13 01:23:16.549031 kernel: audit: type=1403 audit(1747099395.420:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 13 01:23:16.549044 systemd[1]: Successfully loaded SELinux policy in 82.875ms.
May 13 01:23:16.549066 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 26.771ms.
May 13 01:23:16.549084 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 13 01:23:16.549096 systemd[1]: Detected virtualization kvm.
May 13 01:23:16.549112 systemd[1]: Detected architecture x86-64.
May 13 01:23:16.549124 systemd[1]: Detected first boot.
May 13 01:23:16.549137 systemd[1]: Hostname set to <ci-4230-1-1-n-37513c080a.novalocal>.
May 13 01:23:16.549149 systemd[1]: Initializing machine ID from VM UUID.
May 13 01:23:16.549161 zram_generator::config[996]: No configuration found.
May 13 01:23:16.549174 kernel: Guest personality initialized and is inactive
May 13 01:23:16.549185 kernel: VMCI host device registered (name=vmci, major=10, minor=125)
May 13 01:23:16.549196 kernel: Initialized host personality
May 13 01:23:16.549209 kernel: NET: Registered PF_VSOCK protocol family
May 13 01:23:16.549221 systemd[1]: Populated /etc with preset unit settings.
May 13 01:23:16.549234 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully.
May 13 01:23:16.549247 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 13 01:23:16.549259 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 13 01:23:16.549272 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 13 01:23:16.549284 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 13 01:23:16.549296 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 13 01:23:16.549309 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys.
May 13 01:23:16.549324 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 13 01:23:16.549336 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 13 01:23:16.549349 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 13 01:23:16.549361 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 13 01:23:16.549374 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 13 01:23:16.549386 systemd[1]: Created slice user.slice - User and Session Slice.
May 13 01:23:16.549398 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 13 01:23:16.549410 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 13 01:23:16.549423 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 13 01:23:16.549438 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 13 01:23:16.549451 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 13 01:23:16.549464 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 13 01:23:16.549477 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
May 13 01:23:16.549489 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 13 01:23:16.549501 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 13 01:23:16.549516 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 13 01:23:16.549528 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 13 01:23:16.549540 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 13 01:23:16.549553 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 13 01:23:16.549565 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 13 01:23:16.549577 systemd[1]: Reached target slices.target - Slice Units.
May 13 01:23:16.549589 systemd[1]: Reached target swap.target - Swaps.
May 13 01:23:16.549602 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 13 01:23:16.549614 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 13 01:23:16.549629 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption.
May 13 01:23:16.549641 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 13 01:23:16.553586 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 13 01:23:16.553606 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 13 01:23:16.553619 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 13 01:23:16.553632 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 13 01:23:16.553644 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 13 01:23:16.553759 systemd[1]: Mounting media.mount - External Media Directory...
May 13 01:23:16.553776 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:16.553793 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 13 01:23:16.553805 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 13 01:23:16.553818 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 13 01:23:16.553831 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 13 01:23:16.553844 systemd[1]: Reached target machines.target - Containers.
May 13 01:23:16.553856 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 13 01:23:16.553868 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 01:23:16.553881 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 13 01:23:16.553895 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 13 01:23:16.553907 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 13 01:23:16.553920 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 13 01:23:16.553937 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 13 01:23:16.553949 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 13 01:23:16.553961 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 13 01:23:16.553974 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 13 01:23:16.553986 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 13 01:23:16.553998 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 13 01:23:16.554012 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 13 01:23:16.554025 systemd[1]: Stopped systemd-fsck-usr.service.
May 13 01:23:16.554038 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 13 01:23:16.554050 systemd[1]: Starting systemd-journald.service - Journal Service...
May 13 01:23:16.554062 kernel: fuse: init (API version 7.39)
May 13 01:23:16.554074 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 13 01:23:16.554086 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 13 01:23:16.554098 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 13 01:23:16.554112 kernel: loop: module loaded
May 13 01:23:16.554124 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials...
May 13 01:23:16.554136 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 13 01:23:16.554149 systemd[1]: verity-setup.service: Deactivated successfully.
May 13 01:23:16.554161 systemd[1]: Stopped verity-setup.service.
May 13 01:23:16.554174 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:16.554186 kernel: ACPI: bus type drm_connector registered
May 13 01:23:16.554198 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 13 01:23:16.554213 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 13 01:23:16.554225 systemd[1]: Mounted media.mount - External Media Directory.
May 13 01:23:16.554240 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 13 01:23:16.554252 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 13 01:23:16.554265 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 13 01:23:16.554277 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 13 01:23:16.554290 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 13 01:23:16.554302 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 13 01:23:16.554314 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 13 01:23:16.554326 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 13 01:23:16.554339 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 13 01:23:16.554370 systemd-journald[1094]: Collecting audit messages is disabled.
May 13 01:23:16.554394 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 13 01:23:16.554406 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 13 01:23:16.554419 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 13 01:23:16.554431 systemd-journald[1094]: Journal started
May 13 01:23:16.554455 systemd-journald[1094]: Runtime Journal (/run/log/journal/9e9d2348319b46ef9d27b950eaebd2ae) is 8M, max 78.3M, 70.3M free.
May 13 01:23:16.159947 systemd[1]: Queued start job for default target multi-user.target.
May 13 01:23:16.170667 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
May 13 01:23:16.171024 systemd[1]: systemd-journald.service: Deactivated successfully.
May 13 01:23:16.558237 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 13 01:23:16.561402 systemd[1]: Started systemd-journald.service - Journal Service.
May 13 01:23:16.561260 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 13 01:23:16.561536 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 13 01:23:16.562328 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 13 01:23:16.562570 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 13 01:23:16.563406 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 13 01:23:16.564284 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 13 01:23:16.565157 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 13 01:23:16.566012 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials.
May 13 01:23:16.575475 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 13 01:23:16.582806 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 13 01:23:16.586318 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 13 01:23:16.587415 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 13 01:23:16.587528 systemd[1]: Reached target local-fs.target - Local File Systems.
May 13 01:23:16.589369 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management.
May 13 01:23:16.593829 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 13 01:23:16.595868 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 13 01:23:16.596566 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 01:23:16.602803 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 13 01:23:16.607441 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 13 01:23:16.608064 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 13 01:23:16.609371 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 13 01:23:16.610182 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 13 01:23:16.617755 systemd-journald[1094]: Time spent on flushing to /var/log/journal/9e9d2348319b46ef9d27b950eaebd2ae is 78.200ms for 943 entries.
May 13 01:23:16.617755 systemd-journald[1094]: System Journal (/var/log/journal/9e9d2348319b46ef9d27b950eaebd2ae) is 8M, max 584.8M, 576.8M free.
May 13 01:23:16.745877 systemd-journald[1094]: Received client request to flush runtime journal.
May 13 01:23:16.745943 kernel: loop0: detected capacity change from 0 to 138176
May 13 01:23:16.621951 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 13 01:23:16.627848 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 13 01:23:16.629829 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 13 01:23:16.634172 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 13 01:23:16.635301 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 13 01:23:16.636602 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 13 01:23:16.637451 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 13 01:23:16.638926 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 13 01:23:16.646860 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 13 01:23:16.657384 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk...
May 13 01:23:16.659385 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization...
May 13 01:23:16.663614 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 13 01:23:16.678267 udevadm[1145]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in.
May 13 01:23:16.750170 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 13 01:23:16.754405 systemd-tmpfiles[1136]: ACLs are not supported, ignoring.
May 13 01:23:16.754418 systemd-tmpfiles[1136]: ACLs are not supported, ignoring.
May 13 01:23:16.759738 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 13 01:23:16.768784 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 13 01:23:16.770129 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk.
May 13 01:23:16.813674 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 13 01:23:16.824099 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 13 01:23:16.832399 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 13 01:23:16.845687 kernel: loop1: detected capacity change from 0 to 147912
May 13 01:23:16.859209 systemd-tmpfiles[1158]: ACLs are not supported, ignoring.
May 13 01:23:16.859228 systemd-tmpfiles[1158]: ACLs are not supported, ignoring.
May 13 01:23:16.868297 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 13 01:23:16.907671 kernel: loop2: detected capacity change from 0 to 8
May 13 01:23:16.933689 kernel: loop3: detected capacity change from 0 to 138176
May 13 01:23:16.994683 kernel: loop4: detected capacity change from 0 to 147912
May 13 01:23:17.055385 kernel: loop5: detected capacity change from 0 to 8
May 13 01:23:17.058955 (sd-merge)[1164]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-openstack'.
May 13 01:23:17.059698 (sd-merge)[1164]: Merged extensions into '/usr'.
May 13 01:23:17.063952 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 13 01:23:17.073021 systemd[1]: Starting ensure-sysext.service...
May 13 01:23:17.083788 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 13 01:23:17.100387 systemd[1]: Reload requested from client PID 1166 ('systemctl') (unit ensure-sysext.service)...
May 13 01:23:17.100405 systemd[1]: Reloading...
May 13 01:23:17.116235 systemd-tmpfiles[1167]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 13 01:23:17.116498 systemd-tmpfiles[1167]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 13 01:23:17.118938 systemd-tmpfiles[1167]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 13 01:23:17.119329 systemd-tmpfiles[1167]: ACLs are not supported, ignoring.
May 13 01:23:17.119460 systemd-tmpfiles[1167]: ACLs are not supported, ignoring.
May 13 01:23:17.127625 systemd-tmpfiles[1167]: Detected autofs mount point /boot during canonicalization of boot.
May 13 01:23:17.127733 systemd-tmpfiles[1167]: Skipping /boot
May 13 01:23:17.147058 systemd-tmpfiles[1167]: Detected autofs mount point /boot during canonicalization of boot.
May 13 01:23:17.147072 systemd-tmpfiles[1167]: Skipping /boot
May 13 01:23:17.209463 zram_generator::config[1195]: No configuration found.
May 13 01:23:17.410407 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 13 01:23:17.493517 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 13 01:23:17.494016 systemd[1]: Reloading finished in 393 ms.
May 13 01:23:17.518539 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 13 01:23:17.551887 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 13 01:23:17.554083 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 13 01:23:17.560906 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 13 01:23:17.566786 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 13 01:23:17.573810 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 13 01:23:17.594338 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 13 01:23:17.601765 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:17.601981 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 01:23:17.608962 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 13 01:23:17.613893 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 13 01:23:17.617751 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 13 01:23:17.618455 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 01:23:17.618579 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 13 01:23:17.618759 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:17.622999 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 13 01:23:17.623197 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 13 01:23:17.628339 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:17.628526 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 01:23:17.637932 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 13 01:23:17.638569 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 01:23:17.638722 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 13 01:23:17.638857 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:17.650892 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:17.652000 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 13 01:23:17.661594 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 13 01:23:17.662421 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 13 01:23:17.662611 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 13 01:23:17.664676 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 13 01:23:17.669328 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 13 01:23:17.671296 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 13 01:23:17.671460 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 13 01:23:17.674211 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 13 01:23:17.676194 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 13 01:23:17.676819 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 13 01:23:17.682974 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 13 01:23:17.684708 systemd[1]: Finished ensure-sysext.service.
May 13 01:23:17.695280 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 13 01:23:17.695612 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 13 01:23:17.696905 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 13 01:23:17.698370 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 13 01:23:17.707433 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 13 01:23:17.707496 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 13 01:23:17.716810 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
May 13 01:23:17.730345 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 13 01:23:17.733052 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 13 01:23:17.777999 augenrules[1300]: No rules
May 13 01:23:17.779759 systemd[1]: audit-rules.service: Deactivated successfully.
May 13 01:23:17.779960 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 13 01:23:17.782822 systemd-udevd[1292]: Using default interface naming scheme 'v255'.
May 13 01:23:17.800438 ldconfig[1130]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 13 01:23:17.816069 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 13 01:23:17.825801 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 13 01:23:17.829804 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 13 01:23:17.830520 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 13 01:23:17.830692 systemd-resolved[1257]: Positive Trust Anchors:
May 13 01:23:17.830703 systemd-resolved[1257]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 13 01:23:17.830744 systemd-resolved[1257]: 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 13 01:23:17.840143 systemd-resolved[1257]: Using system hostname 'ci-4230-1-1-n-37513c080a.novalocal'.
May 13 01:23:17.841466 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 13 01:23:17.842326 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 13 01:23:17.846001 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 13 01:23:17.849084 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 13 01:23:17.855861 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 13 01:23:17.860954 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
May 13 01:23:17.861579 systemd[1]: Reached target time-set.target - System Time Set.
May 13 01:23:17.933603 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
May 13 01:23:17.944553 systemd-networkd[1312]: lo: Link UP
May 13 01:23:17.944562 systemd-networkd[1312]: lo: Gained carrier
May 13 01:23:17.947000 systemd-networkd[1312]: Enumeration completed
May 13 01:23:17.947138 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 13 01:23:17.948471 systemd[1]: Reached target network.target - Network.
May 13 01:23:17.956914 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd...
May 13 01:23:17.961172 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 13 01:23:17.990068 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd.
May 13 01:23:18.004788 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1316)
May 13 01:23:18.007679 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
May 13 01:23:18.019699 kernel: ACPI: button: Power Button [PWRF]
May 13 01:23:18.040637 systemd-networkd[1312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 01:23:18.040680 systemd-networkd[1312]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 13 01:23:18.041793 systemd-networkd[1312]: eth0: Link UP
May 13 01:23:18.043694 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
May 13 01:23:18.041799 systemd-networkd[1312]: eth0: Gained carrier
May 13 01:23:18.041815 systemd-networkd[1312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 13 01:23:18.053734 systemd-networkd[1312]: eth0: DHCPv4 address 172.24.4.73/24, gateway 172.24.4.1 acquired from 172.24.4.1
May 13 01:23:18.054431 systemd-timesyncd[1291]: Network configuration changed, trying to establish connection.
May 13 01:23:18.084375 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 13 01:23:18.093725 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
May 13 01:23:18.093949 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 13 01:23:18.114890 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 13 01:23:18.121202 kernel: mousedev: PS/2 mouse device common for all mice
May 13 01:23:18.125909 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 01:23:18.142141 kernel: [drm] pci: virtio-vga detected at 0000:00:02.0
May 13 01:23:18.142186 kernel: virtio-pci 0000:00:02.0: vgaarb: deactivate vga console
May 13 01:23:18.145880 kernel: Console: switching to colour dummy device 80x25
May 13 01:23:18.147434 kernel: [drm] features: -virgl +edid -resource_blob -host_visible
May 13 01:23:18.147465 kernel: [drm] features: -context_init
May 13 01:23:18.151768 kernel: [drm] number of scanouts: 1
May 13 01:23:18.151802 kernel: [drm] number of cap sets: 0
May 13 01:23:18.152885 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 01:23:18.153241 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:18.154839 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:02.0 on minor 0
May 13 01:23:18.156519 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 13 01:23:18.163909 kernel: fbcon: virtio_gpudrmfb (fb0) is primary device
May 13 01:23:18.163966 kernel: Console: switching to colour frame buffer device 160x50
May 13 01:23:18.166887 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 01:23:18.172882 kernel: virtio-pci 0000:00:02.0: [drm] fb0: virtio_gpudrmfb frame buffer device
May 13 01:23:18.179260 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 13 01:23:18.179736 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:18.182749 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 13 01:23:18.185077 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization.
May 13 01:23:18.196826 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes...
May 13 01:23:18.212863 lvm[1357]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
May 13 01:23:18.244149 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes.
May 13 01:23:18.244421 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 13 01:23:18.248851 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes...
May 13 01:23:18.253526 lvm[1361]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
May 13 01:23:18.278195 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 13 01:23:18.280118 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes.
May 13 01:23:18.281532 systemd[1]: Reached target sysinit.target - System Initialization.
May 13 01:23:18.283066 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 13 01:23:18.283316 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 13 01:23:18.283899 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 13 01:23:18.284196 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 13 01:23:18.284336 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 13 01:23:18.284454 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 13 01:23:18.284514 systemd[1]: Reached target paths.target - Path Units.
May 13 01:23:18.284620 systemd[1]: Reached target timers.target - Timer Units.
May 13 01:23:18.287510 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 13 01:23:18.290369 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 13 01:23:18.296232 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
May 13 01:23:18.297613 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
May 13 01:23:18.297796 systemd[1]: Reached target ssh-access.target - SSH Access Available.
May 13 01:23:18.310740 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 13 01:23:18.314596 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket.
May 13 01:23:18.318418 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 13 01:23:18.321073 systemd[1]: Reached target sockets.target - Socket Units.
May 13 01:23:18.323547 systemd[1]: Reached target basic.target - Basic System.
May 13 01:23:18.326161 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 13 01:23:18.326345 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 13 01:23:18.342985 systemd[1]: Starting containerd.service - containerd container runtime...
May 13 01:23:18.347931 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)...
May 13 01:23:18.357947 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent...
May 13 01:23:18.373922 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 13 01:23:18.386929 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 13 01:23:18.400820 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 13 01:23:18.402304 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 13 01:23:18.409973 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 13 01:23:18.421805 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 13 01:23:18.436386 coreos-metadata[1370]: May 13 01:23:18.436 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1
May 13 01:23:18.450768 jq[1375]: false
May 13 01:23:18.444529 dbus-daemon[1371]: [system] SELinux support is enabled
May 13 01:23:18.439858 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 13 01:23:18.447825 systemd[1]: Starting systemd-logind.service - User Login Management...
May 13 01:23:18.466754 coreos-metadata[1370]: May 13 01:23:18.452 INFO Fetch successful
May 13 01:23:18.466754 coreos-metadata[1370]: May 13 01:23:18.452 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1
May 13 01:23:18.466754 coreos-metadata[1370]: May 13 01:23:18.465 INFO Fetch successful
May 13 01:23:18.466754 coreos-metadata[1370]: May 13 01:23:18.465 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1
May 13 01:23:18.452350 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 13 01:23:18.452930 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 13 01:23:18.455865 systemd[1]: Starting update-engine.service - Update Engine...
May 13 01:23:18.459786 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 13 01:23:18.460903 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 13 01:23:18.475856 coreos-metadata[1369]: May 13 01:23:18.475 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1
May 13 01:23:18.480006 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 13 01:23:18.480205 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 13 01:23:18.480472 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 13 01:23:18.480638 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 13 01:23:18.486665 coreos-metadata[1370]: May 13 01:23:18.486 INFO Fetch successful
May 13 01:23:18.486665 coreos-metadata[1370]: May 13 01:23:18.486 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1
May 13 01:23:18.497172 update_engine[1382]: I20250513 01:23:18.497056  1382 main.cc:92] Flatcar Update Engine starting
May 13 01:23:18.501463 update_engine[1382]: I20250513 01:23:18.500869  1382 update_check_scheduler.cc:74] Next update check in 6m24s
May 13 01:23:18.501622 coreos-metadata[1369]: May 13 01:23:18.501 INFO Fetch successful
May 13 01:23:18.501622 coreos-metadata[1369]: May 13 01:23:18.501 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1
May 13 01:23:18.501727 coreos-metadata[1370]: May 13 01:23:18.501 INFO Fetch successful
May 13 01:23:18.502466 coreos-metadata[1370]: May 13 01:23:18.501 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1
May 13 01:23:18.502224 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 13 01:23:18.502270 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 13 01:23:18.511250 jq[1383]: true
May 13 01:23:18.505875 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 13 01:23:18.505901 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 13 01:23:18.517916 coreos-metadata[1369]: May 13 01:23:18.517 INFO Fetch successful
May 13 01:23:18.518278 (ntainerd)[1394]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 13 01:23:18.518964 extend-filesystems[1377]: Found loop3
May 13 01:23:18.518964 extend-filesystems[1377]: Found loop4
May 13 01:23:18.541544 extend-filesystems[1377]: Found loop5
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda1
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda2
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda3
May 13 01:23:18.541544 extend-filesystems[1377]: Found usr
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda4
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda6
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda7
May 13 01:23:18.541544 extend-filesystems[1377]: Found vda9
May 13 01:23:18.541544 extend-filesystems[1377]: Checking size of /dev/vda9
May 13 01:23:18.530983 systemd[1]: Started update-engine.service - Update Engine.
May 13 01:23:18.583734 coreos-metadata[1370]: May 13 01:23:18.520 INFO Fetch successful
May 13 01:23:18.583734 coreos-metadata[1370]: May 13 01:23:18.520 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1
May 13 01:23:18.583734 coreos-metadata[1370]: May 13 01:23:18.538 INFO Fetch successful
May 13 01:23:18.583938 extend-filesystems[1377]: Resized partition /dev/vda9
May 13 01:23:18.540877 unknown[1369]: wrote ssh authorized keys file for user: core
May 13 01:23:18.594047 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 2014203 blocks
May 13 01:23:18.594129 jq[1400]: true
May 13 01:23:18.594848 extend-filesystems[1407]: resize2fs 1.47.1 (20-May-2024)
May 13 01:23:18.551866 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 13 01:23:18.572715 systemd[1]: motdgen.service: Deactivated successfully.
May 13 01:23:18.572918 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 13 01:23:18.615207 kernel: EXT4-fs (vda9): resized filesystem to 2014203
May 13 01:23:18.615268 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1329)
May 13 01:23:18.636123 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent.
May 13 01:23:18.637192 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 13 01:23:18.670960 systemd-logind[1381]: New seat seat0.
May 13 01:23:18.697687 systemd-logind[1381]: Watching system buttons on /dev/input/event1 (Power Button)
May 13 01:23:18.697709 systemd-logind[1381]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
May 13 01:23:18.700414 systemd[1]: Started systemd-logind.service - User Login Management.
May 13 01:23:18.702515 extend-filesystems[1407]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required
May 13 01:23:18.702515 extend-filesystems[1407]: old_desc_blocks = 1, new_desc_blocks = 1
May 13 01:23:18.702515 extend-filesystems[1407]: The filesystem on /dev/vda9 is now 2014203 (4k) blocks long.
May 13 01:23:18.703875 extend-filesystems[1377]: Resized filesystem in /dev/vda9
May 13 01:23:18.704636 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 13 01:23:18.704850 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 13 01:23:18.738869 update-ssh-keys[1408]: Updated "/home/core/.ssh/authorized_keys"
May 13 01:23:18.739451 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys).
May 13 01:23:18.756909 locksmithd[1404]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 13 01:23:18.768627 bash[1434]: Updated "/home/core/.ssh/authorized_keys"
May 13 01:23:18.770399 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 13 01:23:18.782822 systemd[1]: Starting sshkeys.service...
May 13 01:23:18.837041 systemd[1]: Finished sshkeys.service.
May 13 01:23:18.939669 sshd_keygen[1398]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 13 01:23:18.963206 containerd[1394]: time="2025-05-13T01:23:18.963078169Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23
May 13 01:23:18.967125 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 13 01:23:18.980902 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 13 01:23:18.990469 systemd[1]: issuegen.service: Deactivated successfully.
May 13 01:23:18.990721 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 13 01:23:18.999858 containerd[1394]: time="2025-05-13T01:23:18.999823495Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.001357 containerd[1394]: time="2025-05-13T01:23:19.001299443Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
May 13 01:23:19.001357 containerd[1394]: time="2025-05-13T01:23:19.001345850Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
May 13 01:23:19.001433 containerd[1394]: time="2025-05-13T01:23:19.001367611Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
May 13 01:23:19.001553 containerd[1394]: time="2025-05-13T01:23:19.001524956Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
May 13 01:23:19.001583 containerd[1394]: time="2025-05-13T01:23:19.001552298Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.001668 containerd[1394]: time="2025-05-13T01:23:19.001620295Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
May 13 01:23:19.001707 containerd[1394]: time="2025-05-13T01:23:19.001642988Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.001904 containerd[1394]: time="2025-05-13T01:23:19.001871887Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
May 13 01:23:19.001904 containerd[1394]: time="2025-05-13T01:23:19.001897836Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.001952 containerd[1394]: time="2025-05-13T01:23:19.001914196Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
May 13 01:23:19.001952 containerd[1394]: time="2025-05-13T01:23:19.001926039Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.002022 containerd[1394]: time="2025-05-13T01:23:19.002004215Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.002229 containerd[1394]: time="2025-05-13T01:23:19.002201676Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
May 13 01:23:19.002349 containerd[1394]: time="2025-05-13T01:23:19.002329345Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
May 13 01:23:19.002374 containerd[1394]: time="2025-05-13T01:23:19.002349713Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
May 13 01:23:19.002458 containerd[1394]: time="2025-05-13T01:23:19.002438640Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
May 13 01:23:19.002511 containerd[1394]: time="2025-05-13T01:23:19.002495046Z" level=info msg="metadata content store policy set" policy=shared
May 13 01:23:19.003278 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 13 01:23:19.014190 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 13 01:23:19.020580 containerd[1394]: time="2025-05-13T01:23:19.020535661Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
May 13 01:23:19.020679 containerd[1394]: time="2025-05-13T01:23:19.020603909Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
May 13 01:23:19.020679 containerd[1394]: time="2025-05-13T01:23:19.020622844Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
May 13 01:23:19.020679 containerd[1394]: time="2025-05-13T01:23:19.020641259Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
May 13 01:23:19.020785 containerd[1394]: time="2025-05-13T01:23:19.020734865Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
May 13 01:23:19.020984 containerd[1394]: time="2025-05-13T01:23:19.020959175Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021272383Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021433896Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021453041Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021469683Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021486053Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021500691Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021514166Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021529064Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021544623Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021559201Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021573768Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021586111Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021607902Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
May 13 01:23:19.021705 containerd[1394]: time="2025-05-13T01:23:19.021622199Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022004 containerd[1394]: time="2025-05-13T01:23:19.021635724Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022062 containerd[1394]: time="2025-05-13T01:23:19.022045172Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022121 containerd[1394]: time="2025-05-13T01:23:19.022108050Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022179 containerd[1394]: time="2025-05-13T01:23:19.022166710Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022243 containerd[1394]: time="2025-05-13T01:23:19.022229628Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022310 containerd[1394]: time="2025-05-13T01:23:19.022294820Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022368 containerd[1394]: time="2025-05-13T01:23:19.022355534Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022428 containerd[1394]: time="2025-05-13T01:23:19.022415246Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022484 containerd[1394]: time="2025-05-13T01:23:19.022471421Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022540 containerd[1394]: time="2025-05-13T01:23:19.022527907Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022597 containerd[1394]: time="2025-05-13T01:23:19.022585515Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022690 containerd[1394]: time="2025-05-13T01:23:19.022673901Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
May 13 01:23:19.022771 containerd[1394]: time="2025-05-13T01:23:19.022757358Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022831 containerd[1394]: time="2025-05-13T01:23:19.022818943Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
May 13 01:23:19.022886 containerd[1394]: time="2025-05-13T01:23:19.022873636Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
May 13 01:23:19.022979 containerd[1394]: time="2025-05-13T01:23:19.022964787Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023036662Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023053533Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023068742Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023079893Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023106432Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023118134Z" level=info msg="NRI interface is disabled by configuration."
May 13 01:23:19.023739 containerd[1394]: time="2025-05-13T01:23:19.023129395Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
May 13 01:23:19.023938 containerd[1394]: time="2025-05-13T01:23:19.023424519Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}"
May 13 01:23:19.023938 containerd[1394]: time="2025-05-13T01:23:19.023479963Z" level=info msg="Connect containerd service"
May 13 01:23:19.023938 containerd[1394]: time="2025-05-13T01:23:19.023522423Z" level=info msg="using legacy CRI server"
May 13 01:23:19.023938 containerd[1394]: time="2025-05-13T01:23:19.023530418Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 13 01:23:19.024164 containerd[1394]: time="2025-05-13T01:23:19.024146042Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
May 13 01:23:19.024747 containerd[1394]: time="2025-05-13T01:23:19.024725830Z" 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 13 01:23:19.024935 containerd[1394]: time="2025-05-13T01:23:19.024895959Z" level=info msg="Start subscribing containerd event"
May 13 01:23:19.024970 containerd[1394]: time="2025-05-13T01:23:19.024959688Z" level=info msg="Start recovering state"
May 13 01:23:19.025042 containerd[1394]: time="2025-05-13T01:23:19.025021524Z" level=info msg="Start event monitor"
May 13 01:23:19.025042 containerd[1394]: time="2025-05-13T01:23:19.025038195Z" level=info msg="Start snapshots syncer"
May 13 01:23:19.025144 containerd[1394]: time="2025-05-13T01:23:19.025050058Z" level=info msg="Start cni network conf syncer for default"
May 13 01:23:19.025144 containerd[1394]: time="2025-05-13T01:23:19.025057782Z" level=info msg="Start streaming server"
May 13 01:23:19.025226 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 13 01:23:19.025385 containerd[1394]: time="2025-05-13T01:23:19.025368625Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 13 01:23:19.025480 containerd[1394]: time="2025-05-13T01:23:19.025464465Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 13 01:23:19.025595 containerd[1394]: time="2025-05-13T01:23:19.025580242Z" level=info msg="containerd successfully booted in 0.063307s"
May 13 01:23:19.036005 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
May 13 01:23:19.037664 systemd[1]: Reached target getty.target - Login Prompts.
May 13 01:23:19.038437 systemd[1]: Started containerd.service - containerd container runtime.
May 13 01:23:19.792173 systemd-networkd[1312]: eth0: Gained IPv6LL
May 13 01:23:19.793238 systemd-timesyncd[1291]: Network configuration changed, trying to establish connection.
May 13 01:23:19.797081 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 13 01:23:19.800786 systemd[1]: Reached target network-online.target - Network is Online.
May 13 01:23:19.811587 systemd[1]: Starting etcd-member.service - etcd (System Application Container)...
May 13 01:23:19.824412 (-wrapper)[1467]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS
May 13 01:23:19.828193 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 13 01:23:19.913820 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 13 01:23:20.072990 (dockerd)[1488]: 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 13 01:23:20.073129 systemd[1]: Starting docker.service - Docker Application Container Engine...
May 13 01:23:20.565237 dockerd[1488]: time="2025-05-13T01:23:20.564752028Z" level=info msg="Starting up"
May 13 01:23:20.729632 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport2454636116-merged.mount: Deactivated successfully.
May 13 01:23:20.771695 dockerd[1488]: time="2025-05-13T01:23:20.771467373Z" level=info msg="Loading containers: start."
May 13 01:23:20.969999 kernel: Initializing XFRM netlink socket
May 13 01:23:21.025499 systemd-timesyncd[1291]: Network configuration changed, trying to establish connection.
May 13 01:23:21.027831 systemd-timesyncd[1291]: Network configuration changed, trying to establish connection.
May 13 01:23:21.032814 systemd-timesyncd[1291]: Network configuration changed, trying to establish connection.
May 13 01:23:21.106839 systemd-networkd[1312]: docker0: Link UP
May 13 01:23:21.107443 systemd-timesyncd[1291]: Network configuration changed, trying to establish connection.
May 13 01:23:21.149490 dockerd[1488]: time="2025-05-13T01:23:21.149460289Z" level=info msg="Loading containers: done."
May 13 01:23:21.162249 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 13 01:23:21.176977 systemd[1]: Started sshd@0-172.24.4.73:22-172.24.4.1:34092.service - OpenSSH per-connection server daemon (172.24.4.1:34092).
May 13 01:23:21.191629 dockerd[1488]: time="2025-05-13T01:23:21.190602861Z" 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 13 01:23:21.191629 dockerd[1488]: time="2025-05-13T01:23:21.190859312Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1
May 13 01:23:21.191629 dockerd[1488]: time="2025-05-13T01:23:21.191080758Z" level=info msg="Daemon has completed initialization"
May 13 01:23:21.268034 dockerd[1488]: time="2025-05-13T01:23:21.267356914Z" level=info msg="API listen on /run/docker.sock"
May 13 01:23:21.267519 systemd[1]: Started docker.service - Docker Application Container Engine.
May 13 01:23:21.270066 etcd-wrapper[1472]: Error response from daemon: No such container: etcd-member
May 13 01:23:21.305004 etcd-wrapper[1666]: Error response from daemon: No such container: etcd-member
May 13 01:23:21.359679 etcd-wrapper[1685]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally
May 13 01:23:22.702397 sshd[1646]: Accepted publickey for core from 172.24.4.1 port 34092 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:22.706402 sshd-session[1646]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:22.733087 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 13 01:23:22.747323 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 13 01:23:22.761111 systemd-logind[1381]: New session 1 of user core.
May 13 01:23:22.772223 etcd-wrapper[1685]: v3.5.16: Pulling from coreos/etcd
May 13 01:23:22.789388 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 13 01:23:22.803265 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 13 01:23:22.820151 (systemd)[1695]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 13 01:23:22.825841 systemd-logind[1381]: New session c1 of user core.
May 13 01:23:23.087233 systemd[1695]: Queued start job for default target default.target.
May 13 01:23:23.094059 systemd[1695]: Created slice app.slice - User Application Slice.
May 13 01:23:23.094165 systemd[1695]: Reached target paths.target - Paths.
May 13 01:23:23.094275 systemd[1695]: Reached target timers.target - Timers.
May 13 01:23:23.095676 etcd-wrapper[1685]: 804c8aba2cc6: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 2ae710cd8bfe: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: d462aa345367: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 0f8b424aa0b9: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: d557676654e5: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: c8022d07192e: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: d858cbc252ad: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 1069fc2daed1: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: b40161cd83fc: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 5318d93a3a65: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 307c1adadb60: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: fbb01d9e9dc9: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: fbfea02ac3cf: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 8c26e4bf18e2: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: 1e59a65f8816: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: ffbd4ca5f0bd: Pulling fs layer
May 13 01:23:23.096375 etcd-wrapper[1685]: b40161cd83fc: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: 5318d93a3a65: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: 307c1adadb60: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: fbb01d9e9dc9: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: fbfea02ac3cf: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: 8c26e4bf18e2: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: 1e59a65f8816: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: ffbd4ca5f0bd: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: c8022d07192e: Waiting
May 13 01:23:23.096375 etcd-wrapper[1685]: d858cbc252ad: Waiting
May 13 01:23:23.097010 etcd-wrapper[1685]: 1069fc2daed1: Waiting
May 13 01:23:23.097010 etcd-wrapper[1685]: 0f8b424aa0b9: Waiting
May 13 01:23:23.097010 etcd-wrapper[1685]: d557676654e5: Waiting
May 13 01:23:23.097180 systemd[1695]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 13 01:23:23.106998 systemd[1695]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 13 01:23:23.107049 systemd[1695]: Reached target sockets.target - Sockets.
May 13 01:23:23.107100 systemd[1695]: Reached target basic.target - Basic System.
May 13 01:23:23.107147 systemd[1695]: Reached target default.target - Main User Target.
May 13 01:23:23.107173 systemd[1695]: Startup finished in 267ms.
May 13 01:23:23.107187 systemd[1]: Started user@500.service - User Manager for UID 500.
May 13 01:23:23.118774 systemd[1]: Started session-1.scope - Session 1 of User core.
May 13 01:23:23.390716 etcd-wrapper[1685]: 2ae710cd8bfe: Verifying Checksum
May 13 01:23:23.390716 etcd-wrapper[1685]: 2ae710cd8bfe: Download complete
May 13 01:23:23.409848 etcd-wrapper[1685]: d462aa345367: Download complete
May 13 01:23:23.451754 etcd-wrapper[1685]: 804c8aba2cc6: Verifying Checksum
May 13 01:23:23.525529 etcd-wrapper[1685]: 804c8aba2cc6: Pull complete
May 13 01:23:23.551372 systemd[1]: var-lib-docker-overlay2-7b45994879ebc264dd8678c56896009ec2de748beed832b08e3302441b3b6f71-merged.mount: Deactivated successfully.
May 13 01:23:23.579953 etcd-wrapper[1685]: 2ae710cd8bfe: Pull complete
May 13 01:23:23.624164 systemd[1]: Started sshd@1-172.24.4.73:22-172.24.4.1:36384.service - OpenSSH per-connection server daemon (172.24.4.1:36384).
May 13 01:23:23.679954 etcd-wrapper[1685]: d557676654e5: Verifying Checksum
May 13 01:23:23.680145 etcd-wrapper[1685]: d557676654e5: Download complete
May 13 01:23:23.698842 etcd-wrapper[1685]: 0f8b424aa0b9: Verifying Checksum
May 13 01:23:23.698972 etcd-wrapper[1685]: 0f8b424aa0b9: Download complete
May 13 01:23:23.750726 etcd-wrapper[1685]: c8022d07192e: Verifying Checksum
May 13 01:23:23.750869 etcd-wrapper[1685]: c8022d07192e: Download complete
May 13 01:23:23.952707 etcd-wrapper[1685]: d858cbc252ad: Verifying Checksum
May 13 01:23:23.952707 etcd-wrapper[1685]: d858cbc252ad: Download complete
May 13 01:23:23.977566 etcd-wrapper[1685]: 1069fc2daed1: Verifying Checksum
May 13 01:23:23.977566 etcd-wrapper[1685]: 1069fc2daed1: Download complete
May 13 01:23:24.023112 systemd[1]: var-lib-docker-overlay2-b3a7e8ac0f5855108681d9f4aa33c97ba2695adf093c9669ec8d28cecc2b49d7-merged.mount: Deactivated successfully.
May 13 01:23:24.079872 login[1465]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 13 01:23:24.087711 login[1464]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 13 01:23:24.095501 etcd-wrapper[1685]: b40161cd83fc: Verifying Checksum
May 13 01:23:24.095501 etcd-wrapper[1685]: b40161cd83fc: Download complete
May 13 01:23:24.100273 systemd-logind[1381]: New session 2 of user core.
May 13 01:23:24.110982 systemd[1]: Started session-2.scope - Session 2 of User core.
May 13 01:23:24.113325 etcd-wrapper[1685]: d462aa345367: Pull complete
May 13 01:23:24.115169 systemd-logind[1381]: New session 3 of user core.
May 13 01:23:24.122444 systemd[1]: Started session-3.scope - Session 3 of User core.
May 13 01:23:24.149831 systemd[1]: var-lib-docker-overlay2-3a38da13a5df06dc24ba564c4a60592de9f52516fd0a2b52876fa37350467845-merged.mount: Deactivated successfully.
May 13 01:23:24.164053 etcd-wrapper[1685]: 0f8b424aa0b9: Pull complete
May 13 01:23:24.213413 etcd-wrapper[1685]: 5318d93a3a65: Verifying Checksum
May 13 01:23:24.213413 etcd-wrapper[1685]: 5318d93a3a65: Download complete
May 13 01:23:24.215834 etcd-wrapper[1685]: d557676654e5: Pull complete
May 13 01:23:24.272117 etcd-wrapper[1685]: c8022d07192e: Pull complete
May 13 01:23:24.296076 etcd-wrapper[1685]: 307c1adadb60: Verifying Checksum
May 13 01:23:24.296076 etcd-wrapper[1685]: 307c1adadb60: Download complete
May 13 01:23:24.331305 etcd-wrapper[1685]: d858cbc252ad: Pull complete
May 13 01:23:24.380951 etcd-wrapper[1685]: 1069fc2daed1: Pull complete
May 13 01:23:24.447376 etcd-wrapper[1685]: b40161cd83fc: Pull complete
May 13 01:23:24.506475 etcd-wrapper[1685]: 5318d93a3a65: Pull complete
May 13 01:23:24.575770 etcd-wrapper[1685]: 307c1adadb60: Pull complete
May 13 01:23:24.679026 etcd-wrapper[1685]: fbb01d9e9dc9: Verifying Checksum
May 13 01:23:24.679026 etcd-wrapper[1685]: fbb01d9e9dc9: Download complete
May 13 01:23:24.715412 etcd-wrapper[1685]: fbfea02ac3cf: Verifying Checksum
May 13 01:23:24.715613 etcd-wrapper[1685]: fbfea02ac3cf: Download complete
May 13 01:23:24.863621 etcd-wrapper[1685]: 8c26e4bf18e2: Verifying Checksum
May 13 01:23:24.864288 etcd-wrapper[1685]: 8c26e4bf18e2: Download complete
May 13 01:23:25.119569 etcd-wrapper[1685]: 1e59a65f8816: Verifying Checksum
May 13 01:23:25.120630 etcd-wrapper[1685]: 1e59a65f8816: Download complete
May 13 01:23:25.120630 etcd-wrapper[1685]: ffbd4ca5f0bd: Verifying Checksum
May 13 01:23:25.120630 etcd-wrapper[1685]: ffbd4ca5f0bd: Download complete
May 13 01:23:25.142700 etcd-wrapper[1685]: fbb01d9e9dc9: Pull complete
May 13 01:23:25.269675 sshd[1720]: Accepted publickey for core from 172.24.4.1 port 36384 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:25.270458 sshd-session[1720]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:25.276800 systemd-logind[1381]: New session 4 of user core.
May 13 01:23:25.281767 systemd[1]: Started session-4.scope - Session 4 of User core.
May 13 01:23:25.370991 systemd[1]: var-lib-docker-overlay2-c25f07ff2d41b3c3f783a36d49a82b7c454b34ab8f92bc5d9d85e0666cae18f7-merged.mount: Deactivated successfully.
May 13 01:23:25.473566 etcd-wrapper[1685]: fbfea02ac3cf: Pull complete
May 13 01:23:25.684127 systemd[1]: var-lib-docker-overlay2-0c35ffea684a267353de3ad065fff274be7b57d9c0ce6fb08189dcbe4b6e6a97-merged.mount: Deactivated successfully.
May 13 01:23:25.823701 sshd[1799]: Connection closed by 172.24.4.1 port 36384
May 13 01:23:25.825460 sshd-session[1720]: pam_unix(sshd:session): session closed for user core
May 13 01:23:25.840453 systemd[1]: sshd@1-172.24.4.73:22-172.24.4.1:36384.service: Deactivated successfully.
May 13 01:23:25.844963 systemd[1]: session-4.scope: Deactivated successfully.
May 13 01:23:25.848164 systemd-logind[1381]: Session 4 logged out. Waiting for processes to exit.
May 13 01:23:25.850489 etcd-wrapper[1685]: 8c26e4bf18e2: Pull complete
May 13 01:23:25.858380 systemd[1]: Started sshd@2-172.24.4.73:22-172.24.4.1:36394.service - OpenSSH per-connection server daemon (172.24.4.1:36394).
May 13 01:23:25.864188 systemd-logind[1381]: Removed session 4.
May 13 01:23:25.913710 etcd-wrapper[1685]: 1e59a65f8816: Pull complete
May 13 01:23:25.956803 etcd-wrapper[1685]: ffbd4ca5f0bd: Pull complete
May 13 01:23:25.978395 etcd-wrapper[1685]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159
May 13 01:23:25.986459 etcd-wrapper[1685]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16
May 13 01:23:26.405194 containerd[1394]: time="2025-05-13T01:23:26.404726970Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 13 01:23:26.405194 containerd[1394]: time="2025-05-13T01:23:26.404787213Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 13 01:23:26.405194 containerd[1394]: time="2025-05-13T01:23:26.404802011Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 13 01:23:26.405194 containerd[1394]: time="2025-05-13T01:23:26.404887321Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 13 01:23:26.426785 systemd[1]: Started docker-900411ecfe25856b017b27bf7936f62ff4e0bcb095c8735aa1f39a533e068be5.scope - libcontainer container 900411ecfe25856b017b27bf7936f62ff4e0bcb095c8735aa1f39a533e068be5.
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.481203Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.481343Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"9e9d2348319b46ef9d27b950eaebd2ae"}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.481372Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.481380Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.481387Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.481391Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.481448Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.481460Z","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.73:2379"]}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.481521Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
May 13 01:23:26.481859 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.481531Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]}
May 13 01:23:26.482667 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.481990Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]}
May 13 01:23:26.482667 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.482095Z","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":"9e9d2348319b46ef9d27b950eaebd2ae","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.73:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"9e9d2348319b46ef9d27b950eaebd2ae=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 13 01:23:26.488096 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.487940Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.575246ms"}
May 13 01:23:26.494297 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.494120Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"}
May 13 01:23:26.494524 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.494195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"}
May 13 01:23:26.494524 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.494224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"}
May 13 01:23:26.494524 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.494234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
May 13 01:23:26.494524 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.494242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"}
May 13 01:23:26.494524 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.494274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
May 13 01:23:26.502591 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:23:26.502469Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
May 13 01:23:26.504709 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.504491Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1}
May 13 01:23:26.505789 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.505609Z","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 13 01:23:26.507274 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.506758Z","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 13 01:23:26.507274 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.506997Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
May 13 01:23:26.510193 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.508279Z","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 13 01:23:26.510193 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.508727Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
May 13 01:23:26.510193 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.508765Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
May 13 01:23:26.510193 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.508774Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
May 13 01:23:26.510193 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.509143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
May 13 01:23:26.510193 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.509897Z","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 13 01:23:26.510630 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.510527Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"}
May 13 01:23:26.510630 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.510545Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"}
May 13 01:23:26.510959 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:26.510854Z","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.73:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]}
May 13 01:23:27.055928 sshd[1809]: Accepted publickey for core from 172.24.4.1 port 36394 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:27.058481 sshd-session[1809]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:27.070757 systemd-logind[1381]: New session 5 of user core.
May 13 01:23:27.076952 systemd[1]: Started session-5.scope - Session 5 of User core.
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.495937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"}
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.496017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"}
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.496045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"}
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.496069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"}
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.496083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"}
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.496102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"}
May 13 01:23:27.497187 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.496117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"}
May 13 01:23:27.498298 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.497595Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
May 13 01:23:27.500200 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.498736Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
May 13 01:23:27.499590 systemd[1]: Started etcd-member.service - etcd (System Application Container).
May 13 01:23:27.500921 systemd[1]: Reached target multi-user.target - Multi-User System.
May 13 01:23:27.502771 systemd[1]: Startup finished in 1.183s (kernel) + 11.617s (initrd) + 12.163s (userspace) = 24.964s.
May 13 01:23:27.504991 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.500099Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
May 13 01:23:27.504991 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.498322Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:9e9d2348319b46ef9d27b950eaebd2ae ClientURLs:[http://172.24.4.73:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"}
May 13 01:23:27.504991 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.498375Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
May 13 01:23:27.504991 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.502309Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"}
May 13 01:23:27.504991 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.502419Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
May 13 01:23:27.504991 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.502453Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"}
May 13 01:23:27.506779 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.505239Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
May 13 01:23:27.506779 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:23:27.506460Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"}
May 13 01:23:27.681639 sshd[1866]: Connection closed by 172.24.4.1 port 36394
May 13 01:23:27.682777 sshd-session[1809]: pam_unix(sshd:session): session closed for user core
May 13 01:23:27.690084 systemd[1]: sshd@2-172.24.4.73:22-172.24.4.1:36394.service: Deactivated successfully.
May 13 01:23:27.693577 systemd[1]: session-5.scope: Deactivated successfully.
May 13 01:23:27.695776 systemd-logind[1381]: Session 5 logged out. Waiting for processes to exit.
May 13 01:23:27.698221 systemd-logind[1381]: Removed session 5.
May 13 01:23:37.709162 systemd[1]: Started sshd@3-172.24.4.73:22-172.24.4.1:51302.service - OpenSSH per-connection server daemon (172.24.4.1:51302).
May 13 01:23:39.104624 sshd[1874]: Accepted publickey for core from 172.24.4.1 port 51302 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:39.107413 sshd-session[1874]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:39.119541 systemd-logind[1381]: New session 6 of user core.
May 13 01:23:39.131946 systemd[1]: Started session-6.scope - Session 6 of User core.
May 13 01:23:39.934685 sshd[1876]: Connection closed by 172.24.4.1 port 51302
May 13 01:23:39.935599 sshd-session[1874]: pam_unix(sshd:session): session closed for user core
May 13 01:23:39.954783 systemd[1]: sshd@3-172.24.4.73:22-172.24.4.1:51302.service: Deactivated successfully.
May 13 01:23:39.958242 systemd[1]: session-6.scope: Deactivated successfully.
May 13 01:23:39.960330 systemd-logind[1381]: Session 6 logged out. Waiting for processes to exit.
May 13 01:23:39.968193 systemd[1]: Started sshd@4-172.24.4.73:22-172.24.4.1:51308.service - OpenSSH per-connection server daemon (172.24.4.1:51308).
May 13 01:23:39.971303 systemd-logind[1381]: Removed session 6.
May 13 01:23:41.242026 sshd[1881]: Accepted publickey for core from 172.24.4.1 port 51308 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:41.244467 sshd-session[1881]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:41.258576 systemd-logind[1381]: New session 7 of user core.
May 13 01:23:41.267015 systemd[1]: Started session-7.scope - Session 7 of User core.
May 13 01:23:42.076186 sshd[1884]: Connection closed by 172.24.4.1 port 51308
May 13 01:23:42.077584 sshd-session[1881]: pam_unix(sshd:session): session closed for user core
May 13 01:23:42.094117 systemd[1]: sshd@4-172.24.4.73:22-172.24.4.1:51308.service: Deactivated successfully.
May 13 01:23:42.097593 systemd[1]: session-7.scope: Deactivated successfully.
May 13 01:23:42.100983 systemd-logind[1381]: Session 7 logged out. Waiting for processes to exit.
May 13 01:23:42.106209 systemd[1]: Started sshd@5-172.24.4.73:22-172.24.4.1:51312.service - OpenSSH per-connection server daemon (172.24.4.1:51312).
May 13 01:23:42.109626 systemd-logind[1381]: Removed session 7.
May 13 01:23:43.748303 sshd[1889]: Accepted publickey for core from 172.24.4.1 port 51312 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:43.751575 sshd-session[1889]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:43.766824 systemd-logind[1381]: New session 8 of user core.
May 13 01:23:43.773996 systemd[1]: Started session-8.scope - Session 8 of User core.
May 13 01:23:44.481711 sshd[1892]: Connection closed by 172.24.4.1 port 51312
May 13 01:23:44.480562 sshd-session[1889]: pam_unix(sshd:session): session closed for user core
May 13 01:23:44.500226 systemd[1]: sshd@5-172.24.4.73:22-172.24.4.1:51312.service: Deactivated successfully.
May 13 01:23:44.504300 systemd[1]: session-8.scope: Deactivated successfully.
May 13 01:23:44.510010 systemd-logind[1381]: Session 8 logged out. Waiting for processes to exit.
May 13 01:23:44.516427 systemd[1]: Started sshd@6-172.24.4.73:22-172.24.4.1:56746.service - OpenSSH per-connection server daemon (172.24.4.1:56746).
May 13 01:23:44.520837 systemd-logind[1381]: Removed session 8.
May 13 01:23:46.064150 sshd[1897]: Accepted publickey for core from 172.24.4.1 port 56746 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:46.067495 sshd-session[1897]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:46.081096 systemd-logind[1381]: New session 9 of user core.
May 13 01:23:46.092015 systemd[1]: Started session-9.scope - Session 9 of User core.
May 13 01:23:46.797704 sshd[1900]: Connection closed by 172.24.4.1 port 56746
May 13 01:23:46.798066 sshd-session[1897]: pam_unix(sshd:session): session closed for user core
May 13 01:23:46.818358 systemd[1]: sshd@6-172.24.4.73:22-172.24.4.1:56746.service: Deactivated successfully.
May 13 01:23:46.822451 systemd[1]: session-9.scope: Deactivated successfully.
May 13 01:23:46.825039 systemd-logind[1381]: Session 9 logged out. Waiting for processes to exit.
May 13 01:23:46.840195 systemd[1]: Started sshd@7-172.24.4.73:22-172.24.4.1:56762.service - OpenSSH per-connection server daemon (172.24.4.1:56762).
May 13 01:23:46.845743 systemd-logind[1381]: Removed session 9.
May 13 01:23:48.381530 sshd[1907]: Accepted publickey for core from 172.24.4.1 port 56762 ssh2: RSA SHA256:7MSEtrPG90KNfI15lLQovLaAMNL7On+IiaAlP51zje4
May 13 01:23:48.384583 sshd-session[1907]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 13 01:23:48.398782 systemd-logind[1381]: New session 10 of user core.
May 13 01:23:48.406009 systemd[1]: Started session-10.scope - Session 10 of User core.
May 13 01:23:49.211770 sshd[1910]: Connection closed by 172.24.4.1 port 56762
May 13 01:23:49.212815 sshd-session[1907]: pam_unix(sshd:session): session closed for user core
May 13 01:23:49.219575 systemd-logind[1381]: Session 10 logged out. Waiting for processes to exit.
May 13 01:23:49.221280 systemd[1]: sshd@7-172.24.4.73:22-172.24.4.1:56762.service: Deactivated successfully.
May 13 01:23:49.225480 systemd[1]: session-10.scope: Deactivated successfully.
May 13 01:23:49.228444 systemd-logind[1381]: Removed session 10.
May 13 01:23:51.472960 systemd-timesyncd[1291]: Contacted time server 23.186.168.131:123 (2.flatcar.pool.ntp.org).
May 13 01:23:51.473077 systemd-timesyncd[1291]: Initial clock synchronization to Tue 2025-05-13 01:23:51.537951 UTC.
May 13 01:24:03.553822 update_engine[1382]: I20250513 01:24:03.553625  1382 update_attempter.cc:509] Updating boot flags...
May 13 01:24:03.616830 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1929)
May 13 01:24:03.696833 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1927)
May 13 01:24:03.764001 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1927)
May 13 01:28:09.366545 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:28:09.365241Z","caller":"traceutil/trace.go:171","msg":"trace[1074211587] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"103.409774ms","start":"2025-05-13T01:28:09.261534Z","end":"2025-05-13T01:28:09.364944Z","steps":["trace[1074211587] 'process raft request'  (duration: 103.16764ms)"],"step_count":1}
May 13 01:28:09.595564 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:28:09.594004Z","caller":"traceutil/trace.go:171","msg":"trace[1246909895] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"184.109468ms","start":"2025-05-13T01:28:09.409863Z","end":"2025-05-13T01:28:09.593973Z","steps":["trace[1246909895] 'read index received'  (duration: 149.665491ms)","trace[1246909895] 'applied index is now lower than readState.Index'  (duration: 34.442875ms)"],"step_count":2}
May 13 01:28:09.595564 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:28:09.594185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.274396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
May 13 01:28:09.595564 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:28:09.594231Z","caller":"traceutil/trace.go:171","msg":"trace[1234852686] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:298; }","duration":"184.394201ms","start":"2025-05-13T01:28:09.409821Z","end":"2025-05-13T01:28:09.594215Z","steps":["trace[1234852686] 'agreement among raft nodes before linearized reading'  (duration: 184.266812ms)"],"step_count":1}
May 13 01:28:09.595564 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:28:09.594565Z","caller":"traceutil/trace.go:171","msg":"trace[1562298421] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"198.966128ms","start":"2025-05-13T01:28:09.395562Z","end":"2025-05-13T01:28:09.594528Z","steps":["trace[1562298421] 'process raft request'  (duration: 164.043444ms)","trace[1562298421] 'compare'  (duration: 34.245773ms)"],"step_count":2}
May 13 01:28:12.131588 etcd-wrapper[1685]: {"level":"warn","ts":"2025-05-13T01:28:12.130892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.282968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
May 13 01:28:12.131588 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:28:12.130976Z","caller":"traceutil/trace.go:171","msg":"trace[189785753] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:322; }","duration":"121.402411ms","start":"2025-05-13T01:28:12.009549Z","end":"2025-05-13T01:28:12.130951Z","steps":["trace[189785753] 'range keys from in-memory index tree'  (duration: 121.130772ms)"],"step_count":1}
May 13 01:28:20.745425 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:28:20.744551Z","caller":"traceutil/trace.go:171","msg":"trace[1705199404] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"147.649023ms","start":"2025-05-13T01:28:20.596865Z","end":"2025-05-13T01:28:20.744514Z","steps":["trace[1705199404] 'process raft request'  (duration: 117.037262ms)","trace[1705199404] 'compare'  (duration: 30.479331ms)"],"step_count":2}
May 13 01:29:42.611837 update_engine[1382]: I20250513 01:29:42.609934  1382 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs
May 13 01:29:42.611837 update_engine[1382]: I20250513 01:29:42.610538  1382 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.612597  1382 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.616552  1382 omaha_request_params.cc:62] Current group set to beta
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.617882  1382 update_attempter.cc:499] Already updated boot flags. Skipping.
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.617918  1382 update_attempter.cc:643] Scheduling an action processor start.
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.618016  1382 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.618235  1382 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.618438  1382 omaha_request_action.cc:271] Posting an Omaha request to disabled
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.618476  1382 omaha_request_action.cc:272] Request: <?xml version="1.0" encoding="UTF-8"?>
May 13 01:29:42.620629 update_engine[1382]: <request protocol="3.0" version="update_engine-0.4.10" updaterversion="update_engine-0.4.10" installsource="scheduler" ismachine="1">
May 13 01:29:42.620629 update_engine[1382]:     <os version="Chateau" platform="CoreOS" sp="4230.1.1+nightly-20250512-2100_x86_64"></os>
May 13 01:29:42.620629 update_engine[1382]:     <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="4230.1.1+nightly-20250512-2100" track="beta" bootid="{e376f39e-2723-4a99-a887-07aa9e8dace7}" oem="openstack" oemversion="0" alephversion="4230.1.1+nightly-20250512-2100" machineid="9e9d2348319b46ef9d27b950eaebd2ae" machinealias="" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
May 13 01:29:42.620629 update_engine[1382]:         <ping active="1"></ping>
May 13 01:29:42.620629 update_engine[1382]:         <updatecheck></updatecheck>
May 13 01:29:42.620629 update_engine[1382]:         <event eventtype="3" eventresult="2" previousversion="0.0.0.0"></event>
May 13 01:29:42.620629 update_engine[1382]:     </app>
May 13 01:29:42.620629 update_engine[1382]: </request>
May 13 01:29:42.620629 update_engine[1382]: I20250513 01:29:42.618513  1382 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 13 01:29:42.627930 locksmithd[1404]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0
May 13 01:29:42.629754 update_engine[1382]: I20250513 01:29:42.629572  1382 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 13 01:29:42.631719 update_engine[1382]: I20250513 01:29:42.631573  1382 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 13 01:29:42.639503 update_engine[1382]: E20250513 01:29:42.639330  1382 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 13 01:29:42.639759 update_engine[1382]: I20250513 01:29:42.639528  1382 libcurl_http_fetcher.cc:283] No HTTP response, retry 1
May 13 01:29:52.546180 update_engine[1382]: I20250513 01:29:52.545948  1382 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 13 01:29:52.547505 update_engine[1382]: I20250513 01:29:52.546583  1382 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 13 01:29:52.547620 update_engine[1382]: I20250513 01:29:52.547484  1382 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 13 01:29:52.552629 update_engine[1382]: E20250513 01:29:52.552497  1382 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 13 01:29:52.552916 update_engine[1382]: I20250513 01:29:52.552748  1382 libcurl_http_fetcher.cc:283] No HTTP response, retry 2
May 13 01:30:02.549593 update_engine[1382]: I20250513 01:30:02.549041  1382 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 13 01:30:02.551453 update_engine[1382]: I20250513 01:30:02.550495  1382 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 13 01:30:02.552018 update_engine[1382]: I20250513 01:30:02.551918  1382 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 13 01:30:02.557453 update_engine[1382]: E20250513 01:30:02.557301  1382 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 13 01:30:02.557630 update_engine[1382]: I20250513 01:30:02.557526  1382 libcurl_http_fetcher.cc:283] No HTTP response, retry 3
May 13 01:30:12.541188 update_engine[1382]: I20250513 01:30:12.540251  1382 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 13 01:30:12.544253 update_engine[1382]: I20250513 01:30:12.542164  1382 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 13 01:30:12.544253 update_engine[1382]: I20250513 01:30:12.543516  1382 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 13 01:30:12.548618 update_engine[1382]: E20250513 01:30:12.548480  1382 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 13 01:30:12.548618 update_engine[1382]: I20250513 01:30:12.548592  1382 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.548616  1382 omaha_request_action.cc:617] Omaha request response:
May 13 01:30:12.550089 update_engine[1382]: E20250513 01:30:12.549249  1382 omaha_request_action.cc:636] Omaha request network transfer failed.
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.549492  1382 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing.
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.549520  1382 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.549543  1382 update_attempter.cc:306] Processing Done.
May 13 01:30:12.550089 update_engine[1382]: E20250513 01:30:12.549623  1382 update_attempter.cc:619] Update failed.
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.549715  1382 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.549746  1382 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse)
May 13 01:30:12.550089 update_engine[1382]: I20250513 01:30:12.549770  1382 payload_state.cc:103] Ignoring failures until we get a valid Omaha response.
May 13 01:30:12.550964 update_engine[1382]: I20250513 01:30:12.550710  1382 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction
May 13 01:30:12.550964 update_engine[1382]: I20250513 01:30:12.550804  1382 omaha_request_action.cc:271] Posting an Omaha request to disabled
May 13 01:30:12.550964 update_engine[1382]: I20250513 01:30:12.550822  1382 omaha_request_action.cc:272] Request: <?xml version="1.0" encoding="UTF-8"?>
May 13 01:30:12.550964 update_engine[1382]: <request protocol="3.0" version="update_engine-0.4.10" updaterversion="update_engine-0.4.10" installsource="scheduler" ismachine="1">
May 13 01:30:12.550964 update_engine[1382]:     <os version="Chateau" platform="CoreOS" sp="4230.1.1+nightly-20250512-2100_x86_64"></os>
May 13 01:30:12.550964 update_engine[1382]:     <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="4230.1.1+nightly-20250512-2100" track="beta" bootid="{e376f39e-2723-4a99-a887-07aa9e8dace7}" oem="openstack" oemversion="0" alephversion="4230.1.1+nightly-20250512-2100" machineid="9e9d2348319b46ef9d27b950eaebd2ae" machinealias="" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
May 13 01:30:12.550964 update_engine[1382]:         <event eventtype="3" eventresult="0" errorcode="268437456"></event>
May 13 01:30:12.550964 update_engine[1382]:     </app>
May 13 01:30:12.550964 update_engine[1382]: </request>
May 13 01:30:12.550964 update_engine[1382]: I20250513 01:30:12.550853  1382 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
May 13 01:30:12.551823 update_engine[1382]: I20250513 01:30:12.551194  1382 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP
May 13 01:30:12.551959 update_engine[1382]: I20250513 01:30:12.551846  1382 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
May 13 01:30:12.552619 locksmithd[1404]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0
May 13 01:30:12.557037 update_engine[1382]: E20250513 01:30:12.556959  1382 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled
May 13 01:30:12.557191 update_engine[1382]: I20250513 01:30:12.557142  1382 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded
May 13 01:30:12.557191 update_engine[1382]: I20250513 01:30:12.557173  1382 omaha_request_action.cc:617] Omaha request response:
May 13 01:30:12.557356 update_engine[1382]: I20250513 01:30:12.557186  1382 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
May 13 01:30:12.557356 update_engine[1382]: I20250513 01:30:12.557199  1382 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
May 13 01:30:12.557356 update_engine[1382]: I20250513 01:30:12.557210  1382 update_attempter.cc:306] Processing Done.
May 13 01:30:12.557356 update_engine[1382]: I20250513 01:30:12.557224  1382 update_attempter.cc:310] Error event sent.
May 13 01:30:12.557356 update_engine[1382]: I20250513 01:30:12.557291  1382 update_check_scheduler.cc:74] Next update check in 42m21s
May 13 01:30:12.558136 locksmithd[1404]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0
May 13 01:31:42.272486 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:31:42.267329Z","caller":"traceutil/trace.go:171","msg":"trace[651274501] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"132.57762ms","start":"2025-05-13T01:31:42.134592Z","end":"2025-05-13T01:31:42.267170Z","steps":["trace[651274501] 'process raft request'  (duration: 131.752243ms)"],"step_count":1}
May 13 01:32:49.924153 etcd-wrapper[1685]: {"level":"info","ts":"2025-05-13T01:32:49.920859Z","caller":"traceutil/trace.go:171","msg":"trace[1170946743] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"108.644145ms","start":"2025-05-13T01:32:49.812091Z","end":"2025-05-13T01:32:49.920735Z","steps":["trace[1170946743] 'process raft request'  (duration: 108.340055ms)"],"step_count":1}