Nov 7 01:20:56.406913 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT_DYNAMIC Thu Nov 6 22:10:46 -00 2025 Nov 7 01:20:56.406974 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=dfca907f387399f05a1f70f0a721c67729758750135d0f481fa9c4c0c2ff9c7e Nov 7 01:20:56.406989 kernel: BIOS-provided physical RAM map: Nov 7 01:20:56.407000 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Nov 7 01:20:56.407022 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Nov 7 01:20:56.407033 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Nov 7 01:20:56.407058 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffdbfff] usable Nov 7 01:20:56.407068 kernel: BIOS-e820: [mem 0x000000007ffdc000-0x000000007fffffff] reserved Nov 7 01:20:56.407078 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Nov 7 01:20:56.407088 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Nov 7 01:20:56.407098 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 7 01:20:56.407121 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Nov 7 01:20:56.407142 kernel: NX (Execute Disable) protection: active Nov 7 01:20:56.407153 kernel: APIC: Static calls initialized Nov 7 01:20:56.407166 kernel: SMBIOS 2.8 present. Nov 7 01:20:56.407177 kernel: DMI: Red Hat KVM/RHEL-AV, BIOS 1.13.0-2.module_el8.5.0+2608+72063365 04/01/2014 Nov 7 01:20:56.407200 kernel: DMI: Memory slots populated: 1/1 Nov 7 01:20:56.407225 kernel: Hypervisor detected: KVM Nov 7 01:20:56.407237 kernel: last_pfn = 0x7ffdc max_arch_pfn = 0x400000000 Nov 7 01:20:56.407249 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 7 01:20:56.407261 kernel: kvm-clock: using sched offset of 4943998998 cycles Nov 7 01:20:56.407273 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 7 01:20:56.407286 kernel: tsc: Detected 2500.032 MHz processor Nov 7 01:20:56.407298 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 7 01:20:56.407311 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 7 01:20:56.407354 kernel: last_pfn = 0x7ffdc max_arch_pfn = 0x400000000 Nov 7 01:20:56.407370 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Nov 7 01:20:56.407382 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 7 01:20:56.407394 kernel: Using GB pages for direct mapping Nov 7 01:20:56.407407 kernel: ACPI: Early table checksum verification disabled Nov 7 01:20:56.407430 kernel: ACPI: RSDP 0x00000000000F5AA0 000014 (v00 BOCHS ) Nov 7 01:20:56.407443 kernel: ACPI: RSDT 0x000000007FFE47A5 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407467 kernel: ACPI: FACP 0x000000007FFE438D 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407480 kernel: ACPI: DSDT 0x000000007FFDFD80 00460D (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407493 kernel: ACPI: FACS 0x000000007FFDFD40 000040 Nov 7 01:20:56.407505 kernel: ACPI: APIC 0x000000007FFE4481 0000F0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407517 kernel: ACPI: SRAT 0x000000007FFE4571 0001D0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407529 kernel: ACPI: MCFG 0x000000007FFE4741 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407548 kernel: ACPI: WAET 0x000000007FFE477D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 01:20:56.407572 kernel: ACPI: Reserving FACP table memory at [mem 0x7ffe438d-0x7ffe4480] Nov 7 01:20:56.407595 kernel: ACPI: Reserving DSDT table memory at [mem 0x7ffdfd80-0x7ffe438c] Nov 7 01:20:56.407608 kernel: ACPI: Reserving FACS table memory at [mem 0x7ffdfd40-0x7ffdfd7f] Nov 7 01:20:56.407621 kernel: ACPI: Reserving APIC table memory at [mem 0x7ffe4481-0x7ffe4570] Nov 7 01:20:56.407634 kernel: ACPI: Reserving SRAT table memory at [mem 0x7ffe4571-0x7ffe4740] Nov 7 01:20:56.407656 kernel: ACPI: Reserving MCFG table memory at [mem 0x7ffe4741-0x7ffe477c] Nov 7 01:20:56.407669 kernel: ACPI: Reserving WAET table memory at [mem 0x7ffe477d-0x7ffe47a4] Nov 7 01:20:56.407681 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Nov 7 01:20:56.407694 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0x7fffffff] Nov 7 01:20:56.407707 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x20800fffff] hotplug Nov 7 01:20:56.407720 kernel: NUMA: Node 0 [mem 0x00001000-0x0009ffff] + [mem 0x00100000-0x7ffdbfff] -> [mem 0x00001000-0x7ffdbfff] Nov 7 01:20:56.407733 kernel: NODE_DATA(0) allocated [mem 0x7ffd4dc0-0x7ffdbfff] Nov 7 01:20:56.407755 kernel: Zone ranges: Nov 7 01:20:56.407768 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 7 01:20:56.407780 kernel: DMA32 [mem 0x0000000001000000-0x000000007ffdbfff] Nov 7 01:20:56.407793 kernel: Normal empty Nov 7 01:20:56.407805 kernel: Device empty Nov 7 01:20:56.407818 kernel: Movable zone start for each node Nov 7 01:20:56.407830 kernel: Early memory node ranges Nov 7 01:20:56.407853 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Nov 7 01:20:56.407866 kernel: node 0: [mem 0x0000000000100000-0x000000007ffdbfff] Nov 7 01:20:56.407879 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdbfff] Nov 7 01:20:56.407892 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 7 01:20:56.407904 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Nov 7 01:20:56.407917 kernel: On node 0, zone DMA32: 36 pages in unavailable ranges Nov 7 01:20:56.407929 kernel: ACPI: PM-Timer IO Port: 0x608 Nov 7 01:20:56.407942 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 7 01:20:56.407965 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Nov 7 01:20:56.407978 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Nov 7 01:20:56.407991 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 7 01:20:56.408003 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 7 01:20:56.408016 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 7 01:20:56.408028 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 7 01:20:56.408041 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 7 01:20:56.408064 kernel: TSC deadline timer available Nov 7 01:20:56.408077 kernel: CPU topo: Max. logical packages: 16 Nov 7 01:20:56.408090 kernel: CPU topo: Max. logical dies: 16 Nov 7 01:20:56.408102 kernel: CPU topo: Max. dies per package: 1 Nov 7 01:20:56.408115 kernel: CPU topo: Max. threads per core: 1 Nov 7 01:20:56.408127 kernel: CPU topo: Num. cores per package: 1 Nov 7 01:20:56.408152 kernel: CPU topo: Num. threads per package: 1 Nov 7 01:20:56.408164 kernel: CPU topo: Allowing 2 present CPUs plus 14 hotplug CPUs Nov 7 01:20:56.408187 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 7 01:20:56.408200 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Nov 7 01:20:56.408212 kernel: Booting paravirtualized kernel on KVM Nov 7 01:20:56.408224 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 7 01:20:56.408250 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:16 nr_cpu_ids:16 nr_node_ids:1 Nov 7 01:20:56.408263 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Nov 7 01:20:56.408275 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Nov 7 01:20:56.408299 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15 Nov 7 01:20:56.408311 kernel: kvm-guest: PV spinlocks enabled Nov 7 01:20:56.408324 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 7 01:20:56.408664 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=dfca907f387399f05a1f70f0a721c67729758750135d0f481fa9c4c0c2ff9c7e Nov 7 01:20:56.408689 kernel: random: crng init done Nov 7 01:20:56.408702 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 7 01:20:56.408731 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Nov 7 01:20:56.408744 kernel: Fallback order for Node 0: 0 Nov 7 01:20:56.408757 kernel: Built 1 zonelists, mobility grouping on. Total pages: 524154 Nov 7 01:20:56.408770 kernel: Policy zone: DMA32 Nov 7 01:20:56.408782 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 7 01:20:56.408795 kernel: software IO TLB: area num 16. Nov 7 01:20:56.408808 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1 Nov 7 01:20:56.408821 kernel: Kernel/User page tables isolation: enabled Nov 7 01:20:56.408844 kernel: ftrace: allocating 40092 entries in 157 pages Nov 7 01:20:56.408857 kernel: ftrace: allocated 157 pages with 5 groups Nov 7 01:20:56.410914 kernel: Dynamic Preempt: voluntary Nov 7 01:20:56.410933 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 7 01:20:56.410947 kernel: rcu: RCU event tracing is enabled. Nov 7 01:20:56.410961 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=16. Nov 7 01:20:56.410973 kernel: Trampoline variant of Tasks RCU enabled. Nov 7 01:20:56.411004 kernel: Rude variant of Tasks RCU enabled. Nov 7 01:20:56.411018 kernel: Tracing variant of Tasks RCU enabled. Nov 7 01:20:56.411031 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 7 01:20:56.411044 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=16 Nov 7 01:20:56.411057 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Nov 7 01:20:56.411070 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Nov 7 01:20:56.411083 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Nov 7 01:20:56.411107 kernel: NR_IRQS: 33024, nr_irqs: 552, preallocated irqs: 16 Nov 7 01:20:56.411121 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 7 01:20:56.411168 kernel: Console: colour VGA+ 80x25 Nov 7 01:20:56.411190 kernel: printk: legacy console [tty0] enabled Nov 7 01:20:56.411203 kernel: printk: legacy console [ttyS0] enabled Nov 7 01:20:56.411216 kernel: ACPI: Core revision 20240827 Nov 7 01:20:56.411229 kernel: APIC: Switch to symmetric I/O mode setup Nov 7 01:20:56.411241 kernel: x2apic enabled Nov 7 01:20:56.411254 kernel: APIC: Switched APIC routing to: physical x2apic Nov 7 01:20:56.411267 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x240957bf147, max_idle_ns: 440795216753 ns Nov 7 01:20:56.411290 kernel: Calibrating delay loop (skipped) preset value.. 5000.06 BogoMIPS (lpj=2500032) Nov 7 01:20:56.411316 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Nov 7 01:20:56.411330 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Nov 7 01:20:56.411343 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Nov 7 01:20:56.411379 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 7 01:20:56.411398 kernel: Spectre V2 : Mitigation: Retpolines Nov 7 01:20:56.411424 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 7 01:20:56.411439 kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Nov 7 01:20:56.411452 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Nov 7 01:20:56.411465 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Nov 7 01:20:56.411478 kernel: MDS: Mitigation: Clear CPU buffers Nov 7 01:20:56.411490 kernel: MMIO Stale Data: Unknown: No mitigations Nov 7 01:20:56.411503 kernel: SRBDS: Unknown: Dependent on hypervisor status Nov 7 01:20:56.411516 kernel: active return thunk: its_return_thunk Nov 7 01:20:56.411541 kernel: ITS: Mitigation: Aligned branch/return thunks Nov 7 01:20:56.411556 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 7 01:20:56.411569 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 7 01:20:56.411582 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 7 01:20:56.411594 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 7 01:20:56.411607 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Nov 7 01:20:56.411620 kernel: Freeing SMP alternatives memory: 32K Nov 7 01:20:56.411633 kernel: pid_max: default: 32768 minimum: 301 Nov 7 01:20:56.411646 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 7 01:20:56.411659 kernel: landlock: Up and running. Nov 7 01:20:56.411683 kernel: SELinux: Initializing. Nov 7 01:20:56.411696 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Nov 7 01:20:56.411709 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Nov 7 01:20:56.411723 kernel: smpboot: CPU0: Intel Xeon E3-12xx v2 (Ivy Bridge, IBRS) (family: 0x6, model: 0x3a, stepping: 0x9) Nov 7 01:20:56.411736 kernel: Performance Events: unsupported p6 CPU model 58 no PMU driver, software events only. Nov 7 01:20:56.411749 kernel: signal: max sigframe size: 1776 Nov 7 01:20:56.411762 kernel: rcu: Hierarchical SRCU implementation. Nov 7 01:20:56.411776 kernel: rcu: Max phase no-delay instances is 400. Nov 7 01:20:56.411789 kernel: Timer migration: 2 hierarchy levels; 8 children per group; 2 crossnode level Nov 7 01:20:56.411814 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Nov 7 01:20:56.411827 kernel: smp: Bringing up secondary CPUs ... Nov 7 01:20:56.411840 kernel: smpboot: x86: Booting SMP configuration: Nov 7 01:20:56.411854 kernel: .... node #0, CPUs: #1 Nov 7 01:20:56.411867 kernel: smp: Brought up 1 node, 2 CPUs Nov 7 01:20:56.411880 kernel: smpboot: Total of 2 processors activated (10000.12 BogoMIPS) Nov 7 01:20:56.411894 kernel: Memory: 1918204K/2096616K available (14336K kernel code, 2443K rwdata, 26064K rodata, 15956K init, 2088K bss, 172396K reserved, 0K cma-reserved) Nov 7 01:20:56.411919 kernel: devtmpfs: initialized Nov 7 01:20:56.411933 kernel: x86/mm: Memory block size: 128MB Nov 7 01:20:56.411947 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 7 01:20:56.411960 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Nov 7 01:20:56.411974 kernel: pinctrl core: initialized pinctrl subsystem Nov 7 01:20:56.411987 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 7 01:20:56.412000 kernel: audit: initializing netlink subsys (disabled) Nov 7 01:20:56.412024 kernel: audit: type=2000 audit(1762478453.414:1): state=initialized audit_enabled=0 res=1 Nov 7 01:20:56.412038 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 7 01:20:56.412051 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 7 01:20:56.412065 kernel: cpuidle: using governor menu Nov 7 01:20:56.412078 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 7 01:20:56.412091 kernel: dca service started, version 1.12.1 Nov 7 01:20:56.412105 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Nov 7 01:20:56.412139 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Nov 7 01:20:56.412153 kernel: PCI: Using configuration type 1 for base access Nov 7 01:20:56.412166 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 7 01:20:56.412191 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 7 01:20:56.412203 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 7 01:20:56.412215 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 7 01:20:56.412228 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 7 01:20:56.412250 kernel: ACPI: Added _OSI(Module Device) Nov 7 01:20:56.412263 kernel: ACPI: Added _OSI(Processor Device) Nov 7 01:20:56.412275 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 7 01:20:56.412288 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 7 01:20:56.412312 kernel: ACPI: Interpreter enabled Nov 7 01:20:56.412324 kernel: ACPI: PM: (supports S0 S5) Nov 7 01:20:56.412336 kernel: ACPI: Using IOAPIC for interrupt routing Nov 7 01:20:56.412545 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 7 01:20:56.412562 kernel: PCI: Using E820 reservations for host bridge windows Nov 7 01:20:56.412575 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Nov 7 01:20:56.412589 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 7 01:20:56.412907 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 7 01:20:56.413147 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 7 01:20:56.413442 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 7 01:20:56.413464 kernel: PCI host bridge to bus 0000:00 Nov 7 01:20:56.413710 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 7 01:20:56.413921 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 7 01:20:56.414137 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 7 01:20:56.416377 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] Nov 7 01:20:56.416640 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Nov 7 01:20:56.416854 kernel: pci_bus 0000:00: root bus resource [mem 0x20c0000000-0x28bfffffff window] Nov 7 01:20:56.417083 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 7 01:20:56.417370 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Nov 7 01:20:56.417627 kernel: pci 0000:00:01.0: [1013:00b8] type 00 class 0x030000 conventional PCI endpoint Nov 7 01:20:56.417862 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfa000000-0xfbffffff pref] Nov 7 01:20:56.418109 kernel: pci 0000:00:01.0: BAR 1 [mem 0xfea50000-0xfea50fff] Nov 7 01:20:56.418349 kernel: pci 0000:00:01.0: ROM [mem 0xfea40000-0xfea4ffff pref] Nov 7 01:20:56.420345 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 7 01:20:56.420618 kernel: pci 0000:00:02.0: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.420846 kernel: pci 0000:00:02.0: BAR 0 [mem 0xfea51000-0xfea51fff] Nov 7 01:20:56.421078 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Nov 7 01:20:56.421314 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Nov 7 01:20:56.421583 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Nov 7 01:20:56.421818 kernel: pci 0000:00:02.1: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.422043 kernel: pci 0000:00:02.1: BAR 0 [mem 0xfea52000-0xfea52fff] Nov 7 01:20:56.422266 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Nov 7 01:20:56.422533 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Nov 7 01:20:56.422757 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Nov 7 01:20:56.422992 kernel: pci 0000:00:02.2: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.423215 kernel: pci 0000:00:02.2: BAR 0 [mem 0xfea53000-0xfea53fff] Nov 7 01:20:56.423489 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Nov 7 01:20:56.423717 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Nov 7 01:20:56.423989 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Nov 7 01:20:56.424253 kernel: pci 0000:00:02.3: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.424517 kernel: pci 0000:00:02.3: BAR 0 [mem 0xfea54000-0xfea54fff] Nov 7 01:20:56.424741 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Nov 7 01:20:56.424965 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Nov 7 01:20:56.425198 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Nov 7 01:20:56.426533 kernel: pci 0000:00:02.4: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.426772 kernel: pci 0000:00:02.4: BAR 0 [mem 0xfea55000-0xfea55fff] Nov 7 01:20:56.426998 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Nov 7 01:20:56.427244 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Nov 7 01:20:56.427580 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Nov 7 01:20:56.427822 kernel: pci 0000:00:02.5: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.428056 kernel: pci 0000:00:02.5: BAR 0 [mem 0xfea56000-0xfea56fff] Nov 7 01:20:56.428297 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Nov 7 01:20:56.428581 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Nov 7 01:20:56.428807 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Nov 7 01:20:56.429047 kernel: pci 0000:00:02.6: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.429307 kernel: pci 0000:00:02.6: BAR 0 [mem 0xfea57000-0xfea57fff] Nov 7 01:20:56.430747 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Nov 7 01:20:56.433250 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Nov 7 01:20:56.433543 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Nov 7 01:20:56.433787 kernel: pci 0000:00:02.7: [1b36:000c] type 01 class 0x060400 PCIe Root Port Nov 7 01:20:56.434032 kernel: pci 0000:00:02.7: BAR 0 [mem 0xfea58000-0xfea58fff] Nov 7 01:20:56.434272 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Nov 7 01:20:56.434626 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Nov 7 01:20:56.434868 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Nov 7 01:20:56.435903 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Nov 7 01:20:56.436133 kernel: pci 0000:00:03.0: BAR 0 [io 0xc0c0-0xc0df] Nov 7 01:20:56.436397 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfea59000-0xfea59fff] Nov 7 01:20:56.436640 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfd000000-0xfd003fff 64bit pref] Nov 7 01:20:56.436864 kernel: pci 0000:00:03.0: ROM [mem 0xfea00000-0xfea3ffff pref] Nov 7 01:20:56.437099 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Nov 7 01:20:56.437336 kernel: pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] Nov 7 01:20:56.438437 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfea5a000-0xfea5afff] Nov 7 01:20:56.438676 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfd004000-0xfd007fff 64bit pref] Nov 7 01:20:56.438963 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Nov 7 01:20:56.439211 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Nov 7 01:20:56.439513 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Nov 7 01:20:56.439740 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc0e0-0xc0ff] Nov 7 01:20:56.439963 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfea5b000-0xfea5bfff] Nov 7 01:20:56.440235 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Nov 7 01:20:56.441545 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Nov 7 01:20:56.441823 kernel: pci 0000:01:00.0: [1b36:000e] type 01 class 0x060400 PCIe to PCI/PCI-X bridge Nov 7 01:20:56.444599 kernel: pci 0000:01:00.0: BAR 0 [mem 0xfda00000-0xfda000ff 64bit] Nov 7 01:20:56.444860 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Nov 7 01:20:56.445086 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Nov 7 01:20:56.445333 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Nov 7 01:20:56.445615 kernel: pci_bus 0000:02: extended config space not accessible Nov 7 01:20:56.445884 kernel: pci 0000:02:01.0: [8086:25ab] type 00 class 0x088000 conventional PCI endpoint Nov 7 01:20:56.446139 kernel: pci 0000:02:01.0: BAR 0 [mem 0xfd800000-0xfd80000f] Nov 7 01:20:56.446386 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Nov 7 01:20:56.446691 kernel: pci 0000:03:00.0: [1b36:000d] type 00 class 0x0c0330 PCIe Endpoint Nov 7 01:20:56.446924 kernel: pci 0000:03:00.0: BAR 0 [mem 0xfe800000-0xfe803fff 64bit] Nov 7 01:20:56.447235 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Nov 7 01:20:56.449217 kernel: pci 0000:04:00.0: [1af4:1044] type 00 class 0x00ff00 PCIe Endpoint Nov 7 01:20:56.449505 kernel: pci 0000:04:00.0: BAR 4 [mem 0xfca00000-0xfca03fff 64bit pref] Nov 7 01:20:56.449779 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Nov 7 01:20:56.450028 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Nov 7 01:20:56.450252 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Nov 7 01:20:56.450908 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Nov 7 01:20:56.451163 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Nov 7 01:20:56.454581 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Nov 7 01:20:56.454615 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 7 01:20:56.454630 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 7 01:20:56.454645 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 7 01:20:56.454658 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 7 01:20:56.454672 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Nov 7 01:20:56.454685 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Nov 7 01:20:56.454699 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Nov 7 01:20:56.454727 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Nov 7 01:20:56.454741 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Nov 7 01:20:56.454754 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Nov 7 01:20:56.454768 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Nov 7 01:20:56.454781 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Nov 7 01:20:56.454795 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Nov 7 01:20:56.454809 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Nov 7 01:20:56.454828 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Nov 7 01:20:56.454842 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Nov 7 01:20:56.454855 kernel: iommu: Default domain type: Translated Nov 7 01:20:56.454869 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 7 01:20:56.454894 kernel: PCI: Using ACPI for IRQ routing Nov 7 01:20:56.454907 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 7 01:20:56.454920 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Nov 7 01:20:56.454937 kernel: e820: reserve RAM buffer [mem 0x7ffdc000-0x7fffffff] Nov 7 01:20:56.455175 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Nov 7 01:20:56.455477 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Nov 7 01:20:56.455705 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 7 01:20:56.455726 kernel: vgaarb: loaded Nov 7 01:20:56.455740 kernel: clocksource: Switched to clocksource kvm-clock Nov 7 01:20:56.455754 kernel: VFS: Disk quotas dquot_6.6.0 Nov 7 01:20:56.455775 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 7 01:20:56.455789 kernel: pnp: PnP ACPI init Nov 7 01:20:56.456023 kernel: system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved Nov 7 01:20:56.456046 kernel: pnp: PnP ACPI: found 5 devices Nov 7 01:20:56.456060 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 7 01:20:56.456074 kernel: NET: Registered PF_INET protocol family Nov 7 01:20:56.456094 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 7 01:20:56.456108 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Nov 7 01:20:56.456122 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 7 01:20:56.456135 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Nov 7 01:20:56.456149 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Nov 7 01:20:56.456162 kernel: TCP: Hash tables configured (established 16384 bind 16384) Nov 7 01:20:56.456176 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Nov 7 01:20:56.456194 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Nov 7 01:20:56.456208 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 7 01:20:56.456222 kernel: NET: Registered PF_XDP protocol family Nov 7 01:20:56.456478 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x0fff] to [bus 01-02] add_size 1000 Nov 7 01:20:56.456706 kernel: pci 0000:00:02.1: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Nov 7 01:20:56.456929 kernel: pci 0000:00:02.2: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Nov 7 01:20:56.457151 kernel: pci 0000:00:02.3: bridge window [io 0x1000-0x0fff] to [bus 05] add_size 1000 Nov 7 01:20:56.457653 kernel: pci 0000:00:02.4: bridge window [io 0x1000-0x0fff] to [bus 06] add_size 1000 Nov 7 01:20:56.457884 kernel: pci 0000:00:02.5: bridge window [io 0x1000-0x0fff] to [bus 07] add_size 1000 Nov 7 01:20:56.458110 kernel: pci 0000:00:02.6: bridge window [io 0x1000-0x0fff] to [bus 08] add_size 1000 Nov 7 01:20:56.458333 kernel: pci 0000:00:02.7: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 Nov 7 01:20:56.458594 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff]: assigned Nov 7 01:20:56.458817 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff]: assigned Nov 7 01:20:56.459050 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff]: assigned Nov 7 01:20:56.459272 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff]: assigned Nov 7 01:20:56.460308 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff]: assigned Nov 7 01:20:56.460577 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff]: assigned Nov 7 01:20:56.461437 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff]: assigned Nov 7 01:20:56.461689 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff]: assigned Nov 7 01:20:56.461924 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Nov 7 01:20:56.462210 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Nov 7 01:20:56.463496 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Nov 7 01:20:56.463743 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff] Nov 7 01:20:56.463980 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Nov 7 01:20:56.464215 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Nov 7 01:20:56.464565 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Nov 7 01:20:56.464820 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff] Nov 7 01:20:56.465068 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Nov 7 01:20:56.465318 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Nov 7 01:20:56.466306 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Nov 7 01:20:56.466578 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff] Nov 7 01:20:56.466804 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Nov 7 01:20:56.467038 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Nov 7 01:20:56.467262 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Nov 7 01:20:56.467537 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff] Nov 7 01:20:56.467762 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Nov 7 01:20:56.467984 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Nov 7 01:20:56.468226 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Nov 7 01:20:56.469219 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff] Nov 7 01:20:56.469487 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Nov 7 01:20:56.469712 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Nov 7 01:20:56.469935 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Nov 7 01:20:56.470157 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff] Nov 7 01:20:56.470426 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Nov 7 01:20:56.470654 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Nov 7 01:20:56.470878 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Nov 7 01:20:56.471111 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff] Nov 7 01:20:56.471335 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Nov 7 01:20:56.473658 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Nov 7 01:20:56.473915 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Nov 7 01:20:56.474153 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff] Nov 7 01:20:56.474398 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Nov 7 01:20:56.474640 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Nov 7 01:20:56.474884 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 7 01:20:56.475103 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 7 01:20:56.475311 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 7 01:20:56.475575 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] Nov 7 01:20:56.475811 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Nov 7 01:20:56.476032 kernel: pci_bus 0000:00: resource 9 [mem 0x20c0000000-0x28bfffffff window] Nov 7 01:20:56.476257 kernel: pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] Nov 7 01:20:56.476545 kernel: pci_bus 0000:01: resource 1 [mem 0xfd800000-0xfdbfffff] Nov 7 01:20:56.476769 kernel: pci_bus 0000:01: resource 2 [mem 0xfce00000-0xfcffffff 64bit pref] Nov 7 01:20:56.477008 kernel: pci_bus 0000:02: resource 1 [mem 0xfd800000-0xfd9fffff] Nov 7 01:20:56.477242 kernel: pci_bus 0000:03: resource 0 [io 0x2000-0x2fff] Nov 7 01:20:56.479479 kernel: pci_bus 0000:03: resource 1 [mem 0xfe800000-0xfe9fffff] Nov 7 01:20:56.479716 kernel: pci_bus 0000:03: resource 2 [mem 0xfcc00000-0xfcdfffff 64bit pref] Nov 7 01:20:56.479953 kernel: pci_bus 0000:04: resource 0 [io 0x3000-0x3fff] Nov 7 01:20:56.480168 kernel: pci_bus 0000:04: resource 1 [mem 0xfe600000-0xfe7fffff] Nov 7 01:20:56.480440 kernel: pci_bus 0000:04: resource 2 [mem 0xfca00000-0xfcbfffff 64bit pref] Nov 7 01:20:56.480670 kernel: pci_bus 0000:05: resource 0 [io 0x4000-0x4fff] Nov 7 01:20:56.480896 kernel: pci_bus 0000:05: resource 1 [mem 0xfe400000-0xfe5fffff] Nov 7 01:20:56.481122 kernel: pci_bus 0000:05: resource 2 [mem 0xfc800000-0xfc9fffff 64bit pref] Nov 7 01:20:56.481382 kernel: pci_bus 0000:06: resource 0 [io 0x5000-0x5fff] Nov 7 01:20:56.481644 kernel: pci_bus 0000:06: resource 1 [mem 0xfe200000-0xfe3fffff] Nov 7 01:20:56.481909 kernel: pci_bus 0000:06: resource 2 [mem 0xfc600000-0xfc7fffff 64bit pref] Nov 7 01:20:56.482148 kernel: pci_bus 0000:07: resource 0 [io 0x6000-0x6fff] Nov 7 01:20:56.482361 kernel: pci_bus 0000:07: resource 1 [mem 0xfe000000-0xfe1fffff] Nov 7 01:20:56.482609 kernel: pci_bus 0000:07: resource 2 [mem 0xfc400000-0xfc5fffff 64bit pref] Nov 7 01:20:56.482879 kernel: pci_bus 0000:08: resource 0 [io 0x7000-0x7fff] Nov 7 01:20:56.483103 kernel: pci_bus 0000:08: resource 1 [mem 0xfde00000-0xfdffffff] Nov 7 01:20:56.483333 kernel: pci_bus 0000:08: resource 2 [mem 0xfc200000-0xfc3fffff 64bit pref] Nov 7 01:20:56.485000 kernel: pci_bus 0000:09: resource 0 [io 0x8000-0x8fff] Nov 7 01:20:56.485225 kernel: pci_bus 0000:09: resource 1 [mem 0xfdc00000-0xfddfffff] Nov 7 01:20:56.485482 kernel: pci_bus 0000:09: resource 2 [mem 0xfc000000-0xfc1fffff 64bit pref] Nov 7 01:20:56.485507 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Nov 7 01:20:56.485522 kernel: PCI: CLS 0 bytes, default 64 Nov 7 01:20:56.485545 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Nov 7 01:20:56.485560 kernel: software IO TLB: mapped [mem 0x0000000079800000-0x000000007d800000] (64MB) Nov 7 01:20:56.485574 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Nov 7 01:20:56.485589 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x240957bf147, max_idle_ns: 440795216753 ns Nov 7 01:20:56.485604 kernel: Initialise system trusted keyrings Nov 7 01:20:56.485618 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Nov 7 01:20:56.485646 kernel: Key type asymmetric registered Nov 7 01:20:56.485661 kernel: Asymmetric key parser 'x509' registered Nov 7 01:20:56.485676 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 7 01:20:56.485699 kernel: io scheduler mq-deadline registered Nov 7 01:20:56.485713 kernel: io scheduler kyber registered Nov 7 01:20:56.485727 kernel: io scheduler bfq registered Nov 7 01:20:56.485960 kernel: pcieport 0000:00:02.0: PME: Signaling with IRQ 24 Nov 7 01:20:56.486190 kernel: pcieport 0000:00:02.0: AER: enabled with IRQ 24 Nov 7 01:20:56.486471 kernel: pcieport 0000:00:02.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.486713 kernel: pcieport 0000:00:02.1: PME: Signaling with IRQ 25 Nov 7 01:20:56.486932 kernel: pcieport 0000:00:02.1: AER: enabled with IRQ 25 Nov 7 01:20:56.487149 kernel: pcieport 0000:00:02.1: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.487443 kernel: pcieport 0000:00:02.2: PME: Signaling with IRQ 26 Nov 7 01:20:56.487669 kernel: pcieport 0000:00:02.2: AER: enabled with IRQ 26 Nov 7 01:20:56.487894 kernel: pcieport 0000:00:02.2: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.488118 kernel: pcieport 0000:00:02.3: PME: Signaling with IRQ 27 Nov 7 01:20:56.488377 kernel: pcieport 0000:00:02.3: AER: enabled with IRQ 27 Nov 7 01:20:56.488619 kernel: pcieport 0000:00:02.3: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.488864 kernel: pcieport 0000:00:02.4: PME: Signaling with IRQ 28 Nov 7 01:20:56.489111 kernel: pcieport 0000:00:02.4: AER: enabled with IRQ 28 Nov 7 01:20:56.489321 kernel: pcieport 0000:00:02.4: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.489604 kernel: pcieport 0000:00:02.5: PME: Signaling with IRQ 29 Nov 7 01:20:56.489861 kernel: pcieport 0000:00:02.5: AER: enabled with IRQ 29 Nov 7 01:20:56.490104 kernel: pcieport 0000:00:02.5: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.490365 kernel: pcieport 0000:00:02.6: PME: Signaling with IRQ 30 Nov 7 01:20:56.490623 kernel: pcieport 0000:00:02.6: AER: enabled with IRQ 30 Nov 7 01:20:56.490848 kernel: pcieport 0000:00:02.6: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.491078 kernel: pcieport 0000:00:02.7: PME: Signaling with IRQ 31 Nov 7 01:20:56.491343 kernel: pcieport 0000:00:02.7: AER: enabled with IRQ 31 Nov 7 01:20:56.491621 kernel: pcieport 0000:00:02.7: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Nov 7 01:20:56.491644 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 7 01:20:56.491660 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Nov 7 01:20:56.491675 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Nov 7 01:20:56.491689 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 7 01:20:56.491720 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 7 01:20:56.491735 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 7 01:20:56.491749 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 7 01:20:56.491763 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 7 01:20:56.491999 kernel: rtc_cmos 00:03: RTC can wake from S4 Nov 7 01:20:56.492023 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Nov 7 01:20:56.492252 kernel: rtc_cmos 00:03: registered as rtc0 Nov 7 01:20:56.492505 kernel: rtc_cmos 00:03: setting system clock to 2025-11-07T01:20:54 UTC (1762478454) Nov 7 01:20:56.492724 kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Nov 7 01:20:56.492745 kernel: intel_pstate: CPU model not supported Nov 7 01:20:56.492759 kernel: NET: Registered PF_INET6 protocol family Nov 7 01:20:56.492774 kernel: Segment Routing with IPv6 Nov 7 01:20:56.492788 kernel: In-situ OAM (IOAM) with IPv6 Nov 7 01:20:56.492818 kernel: NET: Registered PF_PACKET protocol family Nov 7 01:20:56.492833 kernel: Key type dns_resolver registered Nov 7 01:20:56.492847 kernel: IPI shorthand broadcast: enabled Nov 7 01:20:56.492861 kernel: sched_clock: Marking stable (1484003485, 227033309)->(1953194544, -242157750) Nov 7 01:20:56.492875 kernel: registered taskstats version 1 Nov 7 01:20:56.492889 kernel: Loading compiled-in X.509 certificates Nov 7 01:20:56.492903 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: a701a154daed2de4fe9459199e7b4f93a1f30f1e' Nov 7 01:20:56.492927 kernel: Demotion targets for Node 0: null Nov 7 01:20:56.492943 kernel: Key type .fscrypt registered Nov 7 01:20:56.492957 kernel: Key type fscrypt-provisioning registered Nov 7 01:20:56.492970 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 7 01:20:56.492985 kernel: ima: Allocated hash algorithm: sha1 Nov 7 01:20:56.492999 kernel: ima: No architecture policies found Nov 7 01:20:56.493013 kernel: clk: Disabling unused clocks Nov 7 01:20:56.493027 kernel: Freeing unused kernel image (initmem) memory: 15956K Nov 7 01:20:56.493052 kernel: Write protecting the kernel read-only data: 40960k Nov 7 01:20:56.493066 kernel: Freeing unused kernel image (rodata/data gap) memory: 560K Nov 7 01:20:56.493081 kernel: Run /init as init process Nov 7 01:20:56.493095 kernel: with arguments: Nov 7 01:20:56.493109 kernel: /init Nov 7 01:20:56.493122 kernel: with environment: Nov 7 01:20:56.493142 kernel: HOME=/ Nov 7 01:20:56.493166 kernel: TERM=linux Nov 7 01:20:56.493181 kernel: ACPI: bus type USB registered Nov 7 01:20:56.493195 kernel: usbcore: registered new interface driver usbfs Nov 7 01:20:56.493209 kernel: usbcore: registered new interface driver hub Nov 7 01:20:56.493223 kernel: usbcore: registered new device driver usb Nov 7 01:20:56.493493 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Nov 7 01:20:56.493726 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 1 Nov 7 01:20:56.493974 kernel: xhci_hcd 0000:03:00.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Nov 7 01:20:56.494202 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Nov 7 01:20:56.494464 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 2 Nov 7 01:20:56.494695 kernel: xhci_hcd 0000:03:00.0: Host supports USB 3.0 SuperSpeed Nov 7 01:20:56.495010 kernel: hub 1-0:1.0: USB hub found Nov 7 01:20:56.495277 kernel: hub 1-0:1.0: 4 ports detected Nov 7 01:20:56.495601 kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Nov 7 01:20:56.495873 kernel: hub 2-0:1.0: USB hub found Nov 7 01:20:56.496125 kernel: hub 2-0:1.0: 4 ports detected Nov 7 01:20:56.496146 kernel: SCSI subsystem initialized Nov 7 01:20:56.496161 kernel: libata version 3.00 loaded. Nov 7 01:20:56.496447 kernel: ahci 0000:00:1f.2: version 3.0 Nov 7 01:20:56.496471 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Nov 7 01:20:56.496692 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Nov 7 01:20:56.496936 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Nov 7 01:20:56.497160 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Nov 7 01:20:56.497451 kernel: scsi host0: ahci Nov 7 01:20:56.497712 kernel: scsi host1: ahci Nov 7 01:20:56.497955 kernel: scsi host2: ahci Nov 7 01:20:56.498208 kernel: scsi host3: ahci Nov 7 01:20:56.498479 kernel: scsi host4: ahci Nov 7 01:20:56.498720 kernel: scsi host5: ahci Nov 7 01:20:56.498758 kernel: ata1: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b100 irq 35 lpm-pol 1 Nov 7 01:20:56.498774 kernel: ata2: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b180 irq 35 lpm-pol 1 Nov 7 01:20:56.498788 kernel: ata3: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b200 irq 35 lpm-pol 1 Nov 7 01:20:56.498803 kernel: ata4: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b280 irq 35 lpm-pol 1 Nov 7 01:20:56.498817 kernel: ata5: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b300 irq 35 lpm-pol 1 Nov 7 01:20:56.498831 kernel: ata6: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b380 irq 35 lpm-pol 1 Nov 7 01:20:56.499104 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Nov 7 01:20:56.499142 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 7 01:20:56.499157 kernel: ata4: SATA link down (SStatus 0 SControl 300) Nov 7 01:20:56.499171 kernel: ata1: SATA link down (SStatus 0 SControl 300) Nov 7 01:20:56.499185 kernel: ata2: SATA link down (SStatus 0 SControl 300) Nov 7 01:20:56.499199 kernel: ata6: SATA link down (SStatus 0 SControl 300) Nov 7 01:20:56.499213 kernel: ata3: SATA link down (SStatus 0 SControl 300) Nov 7 01:20:56.499238 kernel: ata5: SATA link down (SStatus 0 SControl 300) Nov 7 01:20:56.499529 kernel: virtio_blk virtio1: 2/0/0 default/read/poll queues Nov 7 01:20:56.499553 kernel: usbcore: registered new interface driver usbhid Nov 7 01:20:56.499568 kernel: usbhid: USB HID core driver Nov 7 01:20:56.499788 kernel: virtio_blk virtio1: [vda] 125829120 512-byte logical blocks (64.4 GB/60.0 GiB) Nov 7 01:20:56.499811 kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:02.1/0000:03:00.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 Nov 7 01:20:56.499841 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 7 01:20:56.500122 kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:03:00.0-1/input0 Nov 7 01:20:56.500152 kernel: GPT:25804799 != 125829119 Nov 7 01:20:56.500167 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 7 01:20:56.500180 kernel: GPT:25804799 != 125829119 Nov 7 01:20:56.500194 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 7 01:20:56.500208 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 7 01:20:56.500238 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 7 01:20:56.500253 kernel: device-mapper: uevent: version 1.0.3 Nov 7 01:20:56.500267 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 7 01:20:56.500281 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Nov 7 01:20:56.500295 kernel: raid6: sse2x4 gen() 13647 MB/s Nov 7 01:20:56.500309 kernel: raid6: sse2x2 gen() 9328 MB/s Nov 7 01:20:56.500323 kernel: raid6: sse2x1 gen() 9331 MB/s Nov 7 01:20:56.500364 kernel: raid6: using algorithm sse2x4 gen() 13647 MB/s Nov 7 01:20:56.500379 kernel: raid6: .... xor() 7597 MB/s, rmw enabled Nov 7 01:20:56.500393 kernel: raid6: using ssse3x2 recovery algorithm Nov 7 01:20:56.500416 kernel: xor: automatically using best checksumming function avx Nov 7 01:20:56.500432 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 7 01:20:56.500446 kernel: BTRFS: device fsid e643e10b-d997-4333-8d60-30d1c22703fe devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (194) Nov 7 01:20:56.500461 kernel: BTRFS info (device dm-0): first mount of filesystem e643e10b-d997-4333-8d60-30d1c22703fe Nov 7 01:20:56.500489 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 7 01:20:56.500503 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 7 01:20:56.500517 kernel: BTRFS info (device dm-0): enabling free space tree Nov 7 01:20:56.500532 kernel: loop: module loaded Nov 7 01:20:56.500545 kernel: loop0: detected capacity change from 0 to 100120 Nov 7 01:20:56.500559 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 7 01:20:56.500580 systemd[1]: Successfully made /usr/ read-only. Nov 7 01:20:56.500610 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +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 -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 7 01:20:56.500626 systemd[1]: Detected virtualization kvm. Nov 7 01:20:56.500641 systemd[1]: Detected architecture x86-64. Nov 7 01:20:56.500656 systemd[1]: Running in initrd. Nov 7 01:20:56.500670 systemd[1]: No hostname configured, using default hostname. Nov 7 01:20:56.500696 systemd[1]: Hostname set to . Nov 7 01:20:56.500712 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 7 01:20:56.500726 systemd[1]: Queued start job for default target initrd.target. Nov 7 01:20:56.500741 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 7 01:20:56.500756 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 7 01:20:56.500771 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 7 01:20:56.500787 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 7 01:20:56.500813 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 7 01:20:56.500829 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 7 01:20:56.500845 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 7 01:20:56.500860 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 7 01:20:56.500875 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 7 01:20:56.500901 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 7 01:20:56.500917 systemd[1]: Reached target paths.target - Path Units. Nov 7 01:20:56.500932 systemd[1]: Reached target slices.target - Slice Units. Nov 7 01:20:56.500947 systemd[1]: Reached target swap.target - Swaps. Nov 7 01:20:56.500962 systemd[1]: Reached target timers.target - Timer Units. Nov 7 01:20:56.500977 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 7 01:20:56.500992 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 7 01:20:56.501018 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 7 01:20:56.501034 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 7 01:20:56.501049 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 7 01:20:56.501064 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 7 01:20:56.501080 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 7 01:20:56.501095 systemd[1]: Reached target sockets.target - Socket Units. Nov 7 01:20:56.501111 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 7 01:20:56.501137 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 7 01:20:56.501152 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 7 01:20:56.501167 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 7 01:20:56.501184 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Nov 7 01:20:56.501199 systemd[1]: Starting systemd-fsck-usr.service... Nov 7 01:20:56.501214 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 7 01:20:56.501229 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 7 01:20:56.501254 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 7 01:20:56.501270 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 7 01:20:56.501285 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 7 01:20:56.501311 systemd[1]: Finished systemd-fsck-usr.service. Nov 7 01:20:56.501327 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 7 01:20:56.501404 systemd-journald[330]: Collecting audit messages is disabled. Nov 7 01:20:56.501462 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 7 01:20:56.501479 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 7 01:20:56.501494 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 7 01:20:56.501509 kernel: Bridge firewalling registered Nov 7 01:20:56.501524 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 7 01:20:56.501539 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 7 01:20:56.501555 systemd-journald[330]: Journal started Nov 7 01:20:56.501592 systemd-journald[330]: Runtime Journal (/run/log/journal/1d84d9fd06824403a276afe3781318e8) is 4.7M, max 37.9M, 33.1M free. Nov 7 01:20:56.461778 systemd-modules-load[332]: Inserted module 'br_netfilter' Nov 7 01:20:56.546393 systemd[1]: Started systemd-journald.service - Journal Service. Nov 7 01:20:56.554649 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 7 01:20:56.556787 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 7 01:20:56.563569 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 7 01:20:56.566650 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 7 01:20:56.574806 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 7 01:20:56.577961 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 7 01:20:56.587059 systemd-tmpfiles[355]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 7 01:20:56.597844 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 7 01:20:56.607701 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 7 01:20:56.611569 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 7 01:20:56.649967 dracut-cmdline[372]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=dfca907f387399f05a1f70f0a721c67729758750135d0f481fa9c4c0c2ff9c7e Nov 7 01:20:56.660255 systemd-resolved[358]: Positive Trust Anchors: Nov 7 01:20:56.660286 systemd-resolved[358]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 7 01:20:56.660293 systemd-resolved[358]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 7 01:20:56.660337 systemd-resolved[358]: 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 Nov 7 01:20:56.692956 systemd-resolved[358]: Defaulting to hostname 'linux'. Nov 7 01:20:56.694776 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 7 01:20:56.695573 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 7 01:20:56.789508 kernel: Loading iSCSI transport class v2.0-870. Nov 7 01:20:56.808387 kernel: iscsi: registered transport (tcp) Nov 7 01:20:56.837989 kernel: iscsi: registered transport (qla4xxx) Nov 7 01:20:56.838075 kernel: QLogic iSCSI HBA Driver Nov 7 01:20:56.872983 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 7 01:20:56.895881 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 7 01:20:56.897319 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 7 01:20:56.968370 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 7 01:20:56.971544 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 7 01:20:56.974579 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 7 01:20:57.027557 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 7 01:20:57.032626 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 7 01:20:57.068263 systemd-udevd[612]: Using default interface naming scheme 'v257'. Nov 7 01:20:57.084114 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 7 01:20:57.088556 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 7 01:20:57.124721 dracut-pre-trigger[676]: rd.md=0: removing MD RAID activation Nov 7 01:20:57.128818 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 7 01:20:57.134137 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 7 01:20:57.167487 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 7 01:20:57.172532 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 7 01:20:57.195297 systemd-networkd[722]: lo: Link UP Nov 7 01:20:57.195309 systemd-networkd[722]: lo: Gained carrier Nov 7 01:20:57.196266 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 7 01:20:57.197137 systemd[1]: Reached target network.target - Network. Nov 7 01:20:57.310591 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 7 01:20:57.313914 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 7 01:20:57.440313 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 7 01:20:57.469102 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 7 01:20:57.493952 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 7 01:20:57.510050 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 7 01:20:57.513849 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 7 01:20:57.535569 disk-uuid[775]: Primary Header is updated. Nov 7 01:20:57.535569 disk-uuid[775]: Secondary Entries is updated. Nov 7 01:20:57.535569 disk-uuid[775]: Secondary Header is updated. Nov 7 01:20:57.606382 kernel: cryptd: max_cpu_qlen set to 1000 Nov 7 01:20:57.636435 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 7 01:20:57.649839 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Nov 7 01:20:57.649503 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 7 01:20:57.651724 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 7 01:20:57.658782 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 7 01:20:57.680314 kernel: AES CTR mode by8 optimization enabled Nov 7 01:20:57.766072 systemd-networkd[722]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 7 01:20:57.766086 systemd-networkd[722]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 7 01:20:57.771535 systemd-networkd[722]: eth0: Link UP Nov 7 01:20:57.773587 systemd-networkd[722]: eth0: Gained carrier Nov 7 01:20:57.773606 systemd-networkd[722]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 7 01:20:57.794439 systemd-networkd[722]: eth0: DHCPv4 address 10.230.26.110/30, gateway 10.230.26.109 acquired from 10.230.26.109 Nov 7 01:20:57.841245 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 7 01:20:57.856015 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 7 01:20:57.858594 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 7 01:20:57.864604 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 7 01:20:57.865431 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 7 01:20:57.868937 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 7 01:20:57.899222 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 7 01:20:58.636179 disk-uuid[776]: Warning: The kernel is still using the old partition table. Nov 7 01:20:58.636179 disk-uuid[776]: The new table will be used at the next reboot or after you Nov 7 01:20:58.636179 disk-uuid[776]: run partprobe(8) or kpartx(8) Nov 7 01:20:58.636179 disk-uuid[776]: The operation has completed successfully. Nov 7 01:20:58.647193 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 7 01:20:58.647439 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 7 01:20:58.650738 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 7 01:20:58.690408 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (864) Nov 7 01:20:58.693596 kernel: BTRFS info (device vda6): first mount of filesystem 2ac2db45-4534-4157-8998-4b59cd0cd819 Nov 7 01:20:58.693633 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 7 01:20:58.700957 kernel: BTRFS info (device vda6): turning on async discard Nov 7 01:20:58.701036 kernel: BTRFS info (device vda6): enabling free space tree Nov 7 01:20:58.710371 kernel: BTRFS info (device vda6): last unmount of filesystem 2ac2db45-4534-4157-8998-4b59cd0cd819 Nov 7 01:20:58.711054 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 7 01:20:58.713227 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 7 01:20:58.902561 ignition[883]: Ignition 2.22.0 Nov 7 01:20:58.902585 ignition[883]: Stage: fetch-offline Nov 7 01:20:58.902669 ignition[883]: no configs at "/usr/lib/ignition/base.d" Nov 7 01:20:58.905125 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 7 01:20:58.902690 ignition[883]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:20:58.902843 ignition[883]: parsed url from cmdline: "" Nov 7 01:20:58.902849 ignition[883]: no config URL provided Nov 7 01:20:58.902865 ignition[883]: reading system config file "/usr/lib/ignition/user.ign" Nov 7 01:20:58.902886 ignition[883]: no config at "/usr/lib/ignition/user.ign" Nov 7 01:20:58.909573 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Nov 7 01:20:58.902901 ignition[883]: failed to fetch config: resource requires networking Nov 7 01:20:58.903381 ignition[883]: Ignition finished successfully Nov 7 01:20:58.942822 ignition[889]: Ignition 2.22.0 Nov 7 01:20:58.942845 ignition[889]: Stage: fetch Nov 7 01:20:58.943027 ignition[889]: no configs at "/usr/lib/ignition/base.d" Nov 7 01:20:58.943043 ignition[889]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:20:58.943612 ignition[889]: parsed url from cmdline: "" Nov 7 01:20:58.943620 ignition[889]: no config URL provided Nov 7 01:20:58.943631 ignition[889]: reading system config file "/usr/lib/ignition/user.ign" Nov 7 01:20:58.943644 ignition[889]: no config at "/usr/lib/ignition/user.ign" Nov 7 01:20:58.943800 ignition[889]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1 Nov 7 01:20:58.943825 ignition[889]: config drive ("/dev/disk/by-label/config-2") not found. Waiting... Nov 7 01:20:58.943881 ignition[889]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting... Nov 7 01:20:58.959531 ignition[889]: GET result: OK Nov 7 01:20:58.959635 ignition[889]: parsing config with SHA512: 195a53fc03bd2b466aefec1456924ee56a397d8e849ba79272f74dedfa142c163c7b70421d8d083795389860913348b2e3abcfb67aa6848c873c44aa056555c7 Nov 7 01:20:58.969159 unknown[889]: fetched base config from "system" Nov 7 01:20:58.970106 unknown[889]: fetched base config from "system" Nov 7 01:20:58.970369 ignition[889]: fetch: fetch complete Nov 7 01:20:58.970122 unknown[889]: fetched user config from "openstack" Nov 7 01:20:58.970406 ignition[889]: fetch: fetch passed Nov 7 01:20:58.970472 ignition[889]: Ignition finished successfully Nov 7 01:20:58.974705 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Nov 7 01:20:58.977547 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 7 01:20:59.012984 ignition[896]: Ignition 2.22.0 Nov 7 01:20:59.014014 ignition[896]: Stage: kargs Nov 7 01:20:59.014217 ignition[896]: no configs at "/usr/lib/ignition/base.d" Nov 7 01:20:59.014235 ignition[896]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:20:59.017729 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 7 01:20:59.014954 ignition[896]: kargs: kargs passed Nov 7 01:20:59.015028 ignition[896]: Ignition finished successfully Nov 7 01:20:59.021537 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 7 01:20:59.059953 ignition[902]: Ignition 2.22.0 Nov 7 01:20:59.061042 ignition[902]: Stage: disks Nov 7 01:20:59.061231 ignition[902]: no configs at "/usr/lib/ignition/base.d" Nov 7 01:20:59.061248 ignition[902]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:20:59.062010 ignition[902]: disks: disks passed Nov 7 01:20:59.064760 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 7 01:20:59.062080 ignition[902]: Ignition finished successfully Nov 7 01:20:59.066545 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 7 01:20:59.067913 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 7 01:20:59.069417 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 7 01:20:59.070925 systemd[1]: Reached target sysinit.target - System Initialization. Nov 7 01:20:59.072461 systemd[1]: Reached target basic.target - Basic System. Nov 7 01:20:59.075135 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 7 01:20:59.119366 systemd-fsck[911]: ROOT: clean, 15/1631200 files, 112378/1617920 blocks Nov 7 01:20:59.123311 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 7 01:20:59.127862 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 7 01:20:59.271509 systemd-networkd[722]: eth0: Gained IPv6LL Nov 7 01:20:59.285388 kernel: EXT4-fs (vda9): mounted filesystem 9eac1486-40e9-4edf-8a17-71182690c138 r/w with ordered data mode. Quota mode: none. Nov 7 01:20:59.285513 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 7 01:20:59.287630 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 7 01:20:59.291245 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 7 01:20:59.293130 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 7 01:20:59.295124 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 7 01:20:59.298116 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent... Nov 7 01:20:59.299789 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 7 01:20:59.299835 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 7 01:20:59.311694 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 7 01:20:59.317584 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 7 01:20:59.333436 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (919) Nov 7 01:20:59.336593 kernel: BTRFS info (device vda6): first mount of filesystem 2ac2db45-4534-4157-8998-4b59cd0cd819 Nov 7 01:20:59.339407 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 7 01:20:59.358503 kernel: BTRFS info (device vda6): turning on async discard Nov 7 01:20:59.358583 kernel: BTRFS info (device vda6): enabling free space tree Nov 7 01:20:59.389829 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 7 01:20:59.414365 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Nov 7 01:20:59.433036 initrd-setup-root[948]: cut: /sysroot/etc/passwd: No such file or directory Nov 7 01:20:59.439746 initrd-setup-root[955]: cut: /sysroot/etc/group: No such file or directory Nov 7 01:20:59.446052 initrd-setup-root[962]: cut: /sysroot/etc/shadow: No such file or directory Nov 7 01:20:59.452333 initrd-setup-root[969]: cut: /sysroot/etc/gshadow: No such file or directory Nov 7 01:20:59.571421 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 7 01:20:59.574073 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 7 01:20:59.575738 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 7 01:20:59.604384 kernel: BTRFS info (device vda6): last unmount of filesystem 2ac2db45-4534-4157-8998-4b59cd0cd819 Nov 7 01:20:59.626981 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 7 01:20:59.650283 ignition[1038]: INFO : Ignition 2.22.0 Nov 7 01:20:59.651495 ignition[1038]: INFO : Stage: mount Nov 7 01:20:59.653253 ignition[1038]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 7 01:20:59.653253 ignition[1038]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:20:59.653253 ignition[1038]: INFO : mount: mount passed Nov 7 01:20:59.653253 ignition[1038]: INFO : Ignition finished successfully Nov 7 01:20:59.655788 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 7 01:20:59.678842 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 7 01:21:00.441528 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Nov 7 01:21:00.779431 systemd-networkd[722]: eth0: Ignoring DHCPv6 address 2a02:1348:179:869b:24:19ff:fee6:1a6e/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:179:869b:24:19ff:fee6:1a6e/64 assigned by NDisc. Nov 7 01:21:00.779448 systemd-networkd[722]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Nov 7 01:21:02.448384 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Nov 7 01:21:06.455383 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Nov 7 01:21:06.462574 coreos-metadata[921]: Nov 07 01:21:06.462 WARN failed to locate config-drive, using the metadata service API instead Nov 7 01:21:06.489446 coreos-metadata[921]: Nov 07 01:21:06.489 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Nov 7 01:21:06.506893 coreos-metadata[921]: Nov 07 01:21:06.506 INFO Fetch successful Nov 7 01:21:06.507949 coreos-metadata[921]: Nov 07 01:21:06.507 INFO wrote hostname srv-9bxx3.gb1.brightbox.com to /sysroot/etc/hostname Nov 7 01:21:06.510771 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully. Nov 7 01:21:06.510969 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent. Nov 7 01:21:06.515938 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 7 01:21:06.541506 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 7 01:21:06.572363 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1054) Nov 7 01:21:06.572446 kernel: BTRFS info (device vda6): first mount of filesystem 2ac2db45-4534-4157-8998-4b59cd0cd819 Nov 7 01:21:06.573392 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 7 01:21:06.580512 kernel: BTRFS info (device vda6): turning on async discard Nov 7 01:21:06.580575 kernel: BTRFS info (device vda6): enabling free space tree Nov 7 01:21:06.585106 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 7 01:21:06.626097 ignition[1071]: INFO : Ignition 2.22.0 Nov 7 01:21:06.626097 ignition[1071]: INFO : Stage: files Nov 7 01:21:06.627881 ignition[1071]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 7 01:21:06.627881 ignition[1071]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:21:06.627881 ignition[1071]: DEBUG : files: compiled without relabeling support, skipping Nov 7 01:21:06.630929 ignition[1071]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 7 01:21:06.630929 ignition[1071]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 7 01:21:06.647926 ignition[1071]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 7 01:21:06.649245 ignition[1071]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 7 01:21:06.650287 ignition[1071]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 7 01:21:06.649458 unknown[1071]: wrote ssh authorized keys file for user: core Nov 7 01:21:06.653687 ignition[1071]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 7 01:21:06.654838 ignition[1071]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 7 01:21:06.654838 ignition[1071]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Nov 7 01:21:06.654838 ignition[1071]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/20-clct-provider-override.conf" Nov 7 01:21:06.659452 ignition[1071]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/20-clct-provider-override.conf" Nov 7 01:21:06.659452 ignition[1071]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Nov 7 01:21:06.659452 ignition[1071]: INFO : files: op(6): [started] processing unit "coreos-metadata-sshkeys@.service" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(6): op(7): [started] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata-sshkeys@.service.d/20-clct-provider-override.conf" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(6): op(7): [finished] writing systemd drop-in "20-clct-provider-override.conf" at "/sysroot/etc/systemd/system/coreos-metadata-sshkeys@.service.d/20-clct-provider-override.conf" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(6): [finished] processing unit "coreos-metadata-sshkeys@.service" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(8): [started] processing unit "etcd-member.service" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(8): op(9): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(8): [finished] processing unit "etcd-member.service" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(a): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(a): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(b): [started] setting preset to enabled for "etcd-member.service" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: op(b): [finished] setting preset to enabled for "etcd-member.service" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: createResultFile: createFiles: op(c): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 7 01:21:06.669925 ignition[1071]: INFO : files: files passed Nov 7 01:21:06.669925 ignition[1071]: INFO : Ignition finished successfully Nov 7 01:21:06.670608 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 7 01:21:06.677533 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 7 01:21:06.682551 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 7 01:21:06.698753 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 7 01:21:06.699826 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 7 01:21:06.712501 initrd-setup-root-after-ignition[1103]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 7 01:21:06.712501 initrd-setup-root-after-ignition[1103]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 7 01:21:06.715759 initrd-setup-root-after-ignition[1107]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 7 01:21:06.717626 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 7 01:21:06.718983 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 7 01:21:06.721456 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 7 01:21:06.778572 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 7 01:21:06.778807 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 7 01:21:06.780646 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 7 01:21:06.781929 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 7 01:21:06.783909 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 7 01:21:06.785123 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 7 01:21:06.817180 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 7 01:21:06.820062 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 7 01:21:06.862821 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 7 01:21:06.863077 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 7 01:21:06.864026 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 7 01:21:06.865794 systemd[1]: Stopped target timers.target - Timer Units. Nov 7 01:21:06.867305 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 7 01:21:06.867596 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 7 01:21:06.869415 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 7 01:21:06.870397 systemd[1]: Stopped target basic.target - Basic System. Nov 7 01:21:06.871685 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 7 01:21:06.873417 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 7 01:21:06.874748 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 7 01:21:06.876304 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 7 01:21:06.877797 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 7 01:21:06.879424 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 7 01:21:06.880906 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 7 01:21:06.882798 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 7 01:21:06.884185 systemd[1]: Stopped target swap.target - Swaps. Nov 7 01:21:06.885848 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 7 01:21:06.886147 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 7 01:21:06.887995 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 7 01:21:06.888985 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 7 01:21:06.890298 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 7 01:21:06.890519 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 7 01:21:06.891835 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 7 01:21:06.892106 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 7 01:21:06.893949 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 7 01:21:06.894166 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 7 01:21:06.896167 systemd[1]: ignition-files.service: Deactivated successfully. Nov 7 01:21:06.896432 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 7 01:21:06.898728 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 7 01:21:06.903469 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 7 01:21:06.905021 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 7 01:21:06.905244 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 7 01:21:06.907850 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 7 01:21:06.908139 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 7 01:21:06.909872 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 7 01:21:06.910058 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 7 01:21:06.919099 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 7 01:21:06.919238 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 7 01:21:06.947409 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 7 01:21:06.952312 ignition[1127]: INFO : Ignition 2.22.0 Nov 7 01:21:06.952312 ignition[1127]: INFO : Stage: umount Nov 7 01:21:06.953941 ignition[1127]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 7 01:21:06.953941 ignition[1127]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Nov 7 01:21:06.953941 ignition[1127]: INFO : umount: umount passed Nov 7 01:21:06.953941 ignition[1127]: INFO : Ignition finished successfully Nov 7 01:21:06.956844 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 7 01:21:06.957718 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 7 01:21:06.962994 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 7 01:21:06.963154 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 7 01:21:06.964493 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 7 01:21:06.964645 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 7 01:21:06.966010 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 7 01:21:06.966112 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 7 01:21:06.967470 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 7 01:21:06.967545 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Nov 7 01:21:06.968801 systemd[1]: Stopped target network.target - Network. Nov 7 01:21:06.970127 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 7 01:21:06.970200 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 7 01:21:06.971599 systemd[1]: Stopped target paths.target - Path Units. Nov 7 01:21:06.973023 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 7 01:21:06.976581 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 7 01:21:06.977663 systemd[1]: Stopped target slices.target - Slice Units. Nov 7 01:21:06.979005 systemd[1]: Stopped target sockets.target - Socket Units. Nov 7 01:21:06.980543 systemd[1]: iscsid.socket: Deactivated successfully. Nov 7 01:21:06.980612 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 7 01:21:06.982223 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 7 01:21:06.982308 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 7 01:21:06.983662 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 7 01:21:06.983761 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 7 01:21:06.985166 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 7 01:21:06.985235 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 7 01:21:06.987052 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 7 01:21:06.987177 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 7 01:21:06.988740 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 7 01:21:06.990329 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 7 01:21:06.995827 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 7 01:21:06.996006 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 7 01:21:07.002199 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 7 01:21:07.002405 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 7 01:21:07.007304 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 7 01:21:07.008850 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 7 01:21:07.008938 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 7 01:21:07.011762 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 7 01:21:07.013776 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 7 01:21:07.013868 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 7 01:21:07.015587 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 7 01:21:07.015658 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 7 01:21:07.018499 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 7 01:21:07.018573 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 7 01:21:07.020129 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 7 01:21:07.029810 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 7 01:21:07.030108 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 7 01:21:07.031774 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 7 01:21:07.031845 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 7 01:21:07.034200 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 7 01:21:07.034254 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 7 01:21:07.034947 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 7 01:21:07.035013 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 7 01:21:07.037490 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 7 01:21:07.037570 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 7 01:21:07.039290 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 7 01:21:07.039385 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 7 01:21:07.043695 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 7 01:21:07.048732 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 7 01:21:07.048828 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 7 01:21:07.051505 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 7 01:21:07.051581 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 7 01:21:07.052993 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 7 01:21:07.053081 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 7 01:21:07.054559 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 7 01:21:07.054637 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 7 01:21:07.056365 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 7 01:21:07.056443 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 7 01:21:07.070691 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 7 01:21:07.081969 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 7 01:21:07.084853 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 7 01:21:07.085052 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 7 01:21:07.087278 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 7 01:21:07.089273 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 7 01:21:07.110185 systemd[1]: Switching root. Nov 7 01:21:07.157474 systemd-journald[330]: Journal stopped Nov 7 01:21:08.588450 systemd-journald[330]: Received SIGTERM from PID 1 (systemd). Nov 7 01:21:08.588553 kernel: SELinux: policy capability network_peer_controls=1 Nov 7 01:21:08.588585 kernel: SELinux: policy capability open_perms=1 Nov 7 01:21:08.588610 kernel: SELinux: policy capability extended_socket_class=1 Nov 7 01:21:08.588629 kernel: SELinux: policy capability always_check_network=0 Nov 7 01:21:08.588648 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 7 01:21:08.588676 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 7 01:21:08.588696 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 7 01:21:08.588727 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 7 01:21:08.588748 kernel: SELinux: policy capability userspace_initial_context=0 Nov 7 01:21:08.588774 kernel: audit: type=1403 audit(1762478467.297:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 7 01:21:08.588800 systemd[1]: Successfully loaded SELinux policy in 99.500ms. Nov 7 01:21:08.588840 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 14.938ms. Nov 7 01:21:08.588861 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +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 -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 7 01:21:08.588882 systemd[1]: Detected virtualization kvm. Nov 7 01:21:08.588915 systemd[1]: Detected architecture x86-64. Nov 7 01:21:08.588938 systemd[1]: Detected first boot. Nov 7 01:21:08.588958 systemd[1]: Hostname set to . Nov 7 01:21:08.588979 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 7 01:21:08.589010 zram_generator::config[1171]: No configuration found. Nov 7 01:21:08.589046 kernel: Guest personality initialized and is inactive Nov 7 01:21:08.589079 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Nov 7 01:21:08.589106 kernel: Initialized host personality Nov 7 01:21:08.589126 kernel: NET: Registered PF_VSOCK protocol family Nov 7 01:21:08.589146 systemd[1]: Populated /etc with preset unit settings. Nov 7 01:21:08.589166 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 7 01:21:08.589186 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 7 01:21:08.589207 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 7 01:21:08.589242 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 7 01:21:08.589267 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 7 01:21:08.589289 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Nov 7 01:21:08.589310 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 7 01:21:08.589331 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 7 01:21:08.592027 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 7 01:21:08.592061 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 7 01:21:08.592099 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 7 01:21:08.592123 systemd[1]: Created slice user.slice - User and Session Slice. Nov 7 01:21:08.592144 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 7 01:21:08.592165 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 7 01:21:08.592186 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 7 01:21:08.592207 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 7 01:21:08.592240 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 7 01:21:08.592264 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 7 01:21:08.592285 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 7 01:21:08.592306 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 7 01:21:08.592327 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 7 01:21:08.592371 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 7 01:21:08.592410 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 7 01:21:08.592433 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 7 01:21:08.592453 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 7 01:21:08.592473 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 7 01:21:08.592494 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 7 01:21:08.592515 systemd[1]: Reached target slices.target - Slice Units. Nov 7 01:21:08.592535 systemd[1]: Reached target swap.target - Swaps. Nov 7 01:21:08.592568 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 7 01:21:08.592591 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 7 01:21:08.592613 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 7 01:21:08.592635 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 7 01:21:08.592680 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 7 01:21:08.592715 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 7 01:21:08.592737 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 7 01:21:08.592758 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 7 01:21:08.592779 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 7 01:21:08.592801 systemd[1]: Mounting media.mount - External Media Directory... Nov 7 01:21:08.592821 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:08.592841 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 7 01:21:08.592874 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 7 01:21:08.592897 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 7 01:21:08.592918 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). Nov 7 01:21:08.592939 systemd[1]: Reached target machines.target - Containers. Nov 7 01:21:08.592960 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 7 01:21:08.592982 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 7 01:21:08.593002 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 7 01:21:08.593045 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 7 01:21:08.593069 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 7 01:21:08.593090 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 7 01:21:08.593111 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 7 01:21:08.593131 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 7 01:21:08.593152 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 7 01:21:08.593185 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 7 01:21:08.593209 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 7 01:21:08.593230 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 7 01:21:08.593251 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 7 01:21:08.593272 systemd[1]: Stopped systemd-fsck-usr.service. Nov 7 01:21:08.593295 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). Nov 7 01:21:08.593315 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 7 01:21:08.596388 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 7 01:21:08.596422 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 7 01:21:08.596446 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 7 01:21:08.596469 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 7 01:21:08.596509 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 7 01:21:08.596534 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:08.596555 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 7 01:21:08.596576 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 7 01:21:08.596597 systemd[1]: Mounted media.mount - External Media Directory. Nov 7 01:21:08.596618 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 7 01:21:08.596638 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 7 01:21:08.596673 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 7 01:21:08.596696 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 7 01:21:08.596717 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 7 01:21:08.596739 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 7 01:21:08.596760 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 7 01:21:08.596793 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 7 01:21:08.596818 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 7 01:21:08.596840 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 7 01:21:08.596860 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 7 01:21:08.596881 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 7 01:21:08.596902 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 7 01:21:08.596935 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 7 01:21:08.596959 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 7 01:21:08.596980 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 7 01:21:08.597001 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 7 01:21:08.597033 kernel: fuse: init (API version 7.41) Nov 7 01:21:08.597057 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Nov 7 01:21:08.597133 systemd-journald[1265]: Collecting audit messages is disabled. Nov 7 01:21:08.597173 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 7 01:21:08.597196 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 7 01:21:08.597217 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 7 01:21:08.597253 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 7 01:21:08.597278 systemd-journald[1265]: Journal started Nov 7 01:21:08.597321 systemd-journald[1265]: Runtime Journal (/run/log/journal/1d84d9fd06824403a276afe3781318e8) is 4.7M, max 37.9M, 33.1M free. Nov 7 01:21:08.172691 systemd[1]: Queued start job for default target multi-user.target. Nov 7 01:21:08.199497 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 7 01:21:08.200279 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 7 01:21:08.602421 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 7 01:21:08.606375 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 7 01:21:08.612360 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 7 01:21:08.616371 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 7 01:21:08.623369 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 7 01:21:08.638582 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 7 01:21:08.643815 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 7 01:21:08.646370 systemd[1]: Started systemd-journald.service - Journal Service. Nov 7 01:21:08.650766 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 7 01:21:08.651115 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 7 01:21:08.652424 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 7 01:21:08.653571 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 7 01:21:08.673983 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 7 01:21:08.680270 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 7 01:21:08.684599 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 7 01:21:08.711376 kernel: loop1: detected capacity change from 0 to 8 Nov 7 01:21:08.725368 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 7 01:21:08.737492 systemd-journald[1265]: Time spent on flushing to /var/log/journal/1d84d9fd06824403a276afe3781318e8 is 63.201ms for 1137 entries. Nov 7 01:21:08.737492 systemd-journald[1265]: System Journal (/var/log/journal/1d84d9fd06824403a276afe3781318e8) is 8M, max 588.1M, 580.1M free. Nov 7 01:21:08.821884 systemd-journald[1265]: Received client request to flush runtime journal. Nov 7 01:21:08.821944 kernel: ACPI: bus type drm_connector registered Nov 7 01:21:08.821973 kernel: loop2: detected capacity change from 0 to 110984 Nov 7 01:21:08.822021 kernel: loop3: detected capacity change from 0 to 128048 Nov 7 01:21:08.746967 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 7 01:21:08.748618 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 7 01:21:08.769447 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 7 01:21:08.784681 systemd-tmpfiles[1289]: ACLs are not supported, ignoring. Nov 7 01:21:08.784702 systemd-tmpfiles[1289]: ACLs are not supported, ignoring. Nov 7 01:21:08.802305 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 7 01:21:08.809950 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 7 01:21:08.825529 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 7 01:21:08.856374 kernel: loop4: detected capacity change from 0 to 8 Nov 7 01:21:08.864370 kernel: loop5: detected capacity change from 0 to 110984 Nov 7 01:21:08.879548 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 7 01:21:08.883653 kernel: loop6: detected capacity change from 0 to 128048 Nov 7 01:21:08.896145 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 7 01:21:08.899095 (sd-merge)[1324]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-openstack.raw'. Nov 7 01:21:08.899747 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 7 01:21:08.903619 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 7 01:21:08.906938 (sd-merge)[1324]: Merged extensions into '/usr'. Nov 7 01:21:08.918630 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 7 01:21:08.923687 systemd[1]: Starting ensure-sysext.service... Nov 7 01:21:08.926120 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 7 01:21:08.946651 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 7 01:21:08.955830 systemd-tmpfiles[1328]: ACLs are not supported, ignoring. Nov 7 01:21:08.956243 systemd-tmpfiles[1328]: ACLs are not supported, ignoring. Nov 7 01:21:08.963533 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 7 01:21:08.968562 systemd[1]: Reload requested from client PID 1330 ('systemctl') (unit ensure-sysext.service)... Nov 7 01:21:08.968588 systemd[1]: Reloading... Nov 7 01:21:09.005499 systemd-tmpfiles[1332]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 7 01:21:09.005564 systemd-tmpfiles[1332]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 7 01:21:09.005993 systemd-tmpfiles[1332]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 7 01:21:09.011407 systemd-tmpfiles[1332]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 7 01:21:09.014715 systemd-tmpfiles[1332]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 7 01:21:09.015083 systemd-tmpfiles[1332]: ACLs are not supported, ignoring. Nov 7 01:21:09.015192 systemd-tmpfiles[1332]: ACLs are not supported, ignoring. Nov 7 01:21:09.035662 systemd-tmpfiles[1332]: Detected autofs mount point /boot during canonicalization of boot. Nov 7 01:21:09.035681 systemd-tmpfiles[1332]: Skipping /boot Nov 7 01:21:09.060641 systemd-tmpfiles[1332]: Detected autofs mount point /boot during canonicalization of boot. Nov 7 01:21:09.060662 systemd-tmpfiles[1332]: Skipping /boot Nov 7 01:21:09.110371 zram_generator::config[1366]: No configuration found. Nov 7 01:21:09.223384 systemd-resolved[1327]: Positive Trust Anchors: Nov 7 01:21:09.223845 systemd-resolved[1327]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 7 01:21:09.223931 systemd-resolved[1327]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 7 01:21:09.224492 systemd-resolved[1327]: 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 Nov 7 01:21:09.245593 systemd-resolved[1327]: Using system hostname 'srv-9bxx3.gb1.brightbox.com'. Nov 7 01:21:09.451538 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 7 01:21:09.452149 systemd[1]: Reloading finished in 483 ms. Nov 7 01:21:09.467938 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 7 01:21:09.472004 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 7 01:21:09.496764 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 7 01:21:09.506576 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 7 01:21:09.510018 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 7 01:21:09.515240 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 7 01:21:09.528582 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 7 01:21:09.537574 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 7 01:21:09.544690 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 7 01:21:09.553188 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 7 01:21:09.564498 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 7 01:21:09.570291 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 7 01:21:09.572973 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 7 01:21:09.601235 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:09.602352 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 7 01:21:09.607448 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 7 01:21:09.618794 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 7 01:21:09.623212 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 7 01:21:09.624529 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 7 01:21:09.624702 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). Nov 7 01:21:09.624865 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:09.632163 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:09.633496 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 7 01:21:09.633774 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 7 01:21:09.633922 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). Nov 7 01:21:09.634086 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:09.642851 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:09.643239 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 7 01:21:09.664724 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 7 01:21:09.665727 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 7 01:21:09.666279 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). Nov 7 01:21:09.666660 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 7 01:21:09.670087 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 7 01:21:09.671458 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 7 01:21:09.672945 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 7 01:21:09.674067 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 7 01:21:09.677837 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 7 01:21:09.678911 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 7 01:21:09.693486 systemd[1]: Finished ensure-sysext.service. Nov 7 01:21:09.694638 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 7 01:21:09.695159 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 7 01:21:09.699759 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 7 01:21:09.723194 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 7 01:21:09.724110 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 7 01:21:09.728760 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 7 01:21:09.733901 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 7 01:21:09.741147 augenrules[1464]: No rules Nov 7 01:21:09.746178 systemd[1]: audit-rules.service: Deactivated successfully. Nov 7 01:21:09.747576 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 7 01:21:09.833886 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 7 01:21:09.834888 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). Nov 7 01:21:09.837893 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 7 01:21:09.841641 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 7 01:21:09.872762 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 7 01:21:09.874683 systemd[1]: Reached target time-set.target - System Time Set. Nov 7 01:21:09.889233 systemd-udevd[1475]: Using default interface naming scheme 'v257'. Nov 7 01:21:09.938421 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 7 01:21:09.943934 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 7 01:21:10.064570 systemd-networkd[1480]: lo: Link UP Nov 7 01:21:10.064584 systemd-networkd[1480]: lo: Gained carrier Nov 7 01:21:10.068378 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 7 01:21:10.069541 systemd[1]: Reached target network.target - Network. Nov 7 01:21:10.074398 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 7 01:21:10.078139 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 7 01:21:10.139308 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 7 01:21:10.189375 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 7 01:21:10.293464 systemd-networkd[1480]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 7 01:21:10.293481 systemd-networkd[1480]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 7 01:21:10.296022 systemd-networkd[1480]: eth0: Link UP Nov 7 01:21:10.296304 systemd-networkd[1480]: eth0: Gained carrier Nov 7 01:21:10.296334 systemd-networkd[1480]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 7 01:21:10.315464 systemd-networkd[1480]: eth0: DHCPv4 address 10.230.26.110/30, gateway 10.230.26.109 acquired from 10.230.26.109 Nov 7 01:21:10.319627 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:10.383315 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 7 01:21:10.390436 kernel: mousedev: PS/2 mouse device common for all mice Nov 7 01:21:10.398229 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 7 01:21:10.415019 ldconfig[1429]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 7 01:21:10.424115 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 7 01:21:10.429996 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 7 01:21:10.444807 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 7 01:21:10.458933 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 7 01:21:10.464308 systemd[1]: Reached target sysinit.target - System Initialization. Nov 7 01:21:10.472114 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Nov 7 01:21:10.474827 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 7 01:21:10.477003 kernel: ACPI: button: Power Button [PWRF] Nov 7 01:21:10.477490 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 7 01:21:10.478720 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 7 01:21:10.480157 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 7 01:21:10.481531 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 7 01:21:10.482602 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 7 01:21:10.483765 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 7 01:21:10.483823 systemd[1]: Reached target paths.target - Path Units. Nov 7 01:21:10.484484 systemd[1]: Reached target timers.target - Timer Units. Nov 7 01:21:10.486650 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 7 01:21:10.489635 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 7 01:21:10.494516 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 7 01:21:10.495515 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 7 01:21:10.496273 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 7 01:21:10.504209 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 7 01:21:10.505719 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 7 01:21:10.507530 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 7 01:21:10.509261 systemd[1]: Reached target sockets.target - Socket Units. Nov 7 01:21:10.510411 systemd[1]: Reached target basic.target - Basic System. Nov 7 01:21:10.511116 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 7 01:21:10.511246 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 7 01:21:10.512856 systemd[1]: Starting containerd.service - containerd container runtime... Nov 7 01:21:10.516672 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Nov 7 01:21:10.520727 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Nov 7 01:21:10.527608 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 7 01:21:10.538049 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 7 01:21:10.544654 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 7 01:21:10.547793 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 7 01:21:10.548636 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). Nov 7 01:21:10.555611 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 7 01:21:10.559581 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 7 01:21:10.565835 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 7 01:21:10.572517 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 7 01:21:10.583637 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 7 01:21:10.585195 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 7 01:21:10.586012 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 7 01:21:10.595213 systemd[1]: Starting update-engine.service - Update Engine... Nov 7 01:21:10.599843 jq[1520]: false Nov 7 01:21:10.600615 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 7 01:21:10.609423 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 7 01:21:10.611839 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 7 01:21:10.612184 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 7 01:21:10.653071 jq[1532]: true Nov 7 01:21:10.658635 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Refreshing passwd entry cache Nov 7 01:21:10.658419 oslogin_cache_refresh[1526]: Refreshing passwd entry cache Nov 7 01:21:10.680375 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Nov 7 01:21:10.685527 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Nov 7 01:21:10.693206 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 7 01:21:10.693641 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 7 01:21:10.714742 coreos-metadata[1517]: Nov 07 01:21:10.713 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1 Nov 7 01:21:10.722993 update_engine[1531]: I20251107 01:21:10.720340 1531 main.cc:92] Flatcar Update Engine starting Nov 7 01:21:10.724978 coreos-metadata[1516]: Nov 07 01:21:10.723 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1 Nov 7 01:21:10.725333 coreos-metadata[1517]: Nov 07 01:21:10.724 INFO Fetch failed with 404: resource not found Nov 7 01:21:10.725333 coreos-metadata[1517]: Nov 07 01:21:10.724 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Nov 7 01:21:10.727537 coreos-metadata[1517]: Nov 07 01:21:10.727 INFO Fetch successful Nov 7 01:21:10.727787 systemd[1]: motdgen.service: Deactivated successfully. Nov 7 01:21:10.728165 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 7 01:21:10.730971 coreos-metadata[1517]: Nov 07 01:21:10.729 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1 Nov 7 01:21:10.728182 (ntainerd)[1538]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Nov 7 01:21:10.749806 jq[1541]: true Nov 7 01:21:10.752895 coreos-metadata[1517]: Nov 07 01:21:10.751 INFO Fetch successful Nov 7 01:21:10.752895 coreos-metadata[1517]: Nov 07 01:21:10.752 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1 Nov 7 01:21:10.754086 dbus-daemon[1518]: [system] SELinux support is enabled Nov 7 01:21:10.754399 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 7 01:21:10.757020 extend-filesystems[1523]: Found /dev/vda6 Nov 7 01:21:10.764324 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). Nov 7 01:21:10.764393 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 7 01:21:10.765733 coreos-metadata[1516]: Nov 07 01:21:10.765 INFO Fetch successful Nov 7 01:21:10.767051 coreos-metadata[1516]: Nov 07 01:21:10.765 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1 Nov 7 01:21:10.766329 oslogin_cache_refresh[1526]: Failure getting users, quitting Nov 7 01:21:10.767168 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Failure getting users, quitting Nov 7 01:21:10.766231 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). Nov 7 01:21:10.766262 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 7 01:21:10.767406 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 7 01:21:10.767379 oslogin_cache_refresh[1526]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 7 01:21:10.767488 oslogin_cache_refresh[1526]: Refreshing group entry cache Nov 7 01:21:10.767601 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Refreshing group entry cache Nov 7 01:21:10.769901 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Failure getting groups, quitting Nov 7 01:21:10.769901 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 7 01:21:10.769241 oslogin_cache_refresh[1526]: Failure getting groups, quitting Nov 7 01:21:10.769256 oslogin_cache_refresh[1526]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 7 01:21:10.776759 dbus-daemon[1518]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1480 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Nov 7 01:21:10.778794 extend-filesystems[1523]: Found /dev/vda9 Nov 7 01:21:10.774969 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 7 01:21:10.775286 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 7 01:21:10.785969 systemd[1]: Started update-engine.service - Update Engine. Nov 7 01:21:10.784692 dbus-daemon[1518]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 7 01:21:10.786287 coreos-metadata[1517]: Nov 07 01:21:10.783 INFO Fetch successful Nov 7 01:21:10.786287 coreos-metadata[1517]: Nov 07 01:21:10.783 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1 Nov 7 01:21:10.788935 update_engine[1531]: I20251107 01:21:10.786682 1531 update_check_scheduler.cc:74] Next update check in 4m32s Nov 7 01:21:10.789458 extend-filesystems[1523]: Checking size of /dev/vda9 Nov 7 01:21:10.792183 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Nov 7 01:21:10.800865 coreos-metadata[1517]: Nov 07 01:21:10.800 INFO Fetch successful Nov 7 01:21:10.800865 coreos-metadata[1517]: Nov 07 01:21:10.800 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1 Nov 7 01:21:10.814967 coreos-metadata[1516]: Nov 07 01:21:10.811 INFO Fetch successful Nov 7 01:21:10.815811 coreos-metadata[1517]: Nov 07 01:21:10.815 INFO Fetch successful Nov 7 01:21:10.816069 unknown[1516]: wrote ssh authorized keys file for user: core Nov 7 01:21:10.879668 extend-filesystems[1523]: Resized partition /dev/vda9 Nov 7 01:21:10.890004 extend-filesystems[1589]: resize2fs 1.47.3 (8-Jul-2025) Nov 7 01:21:10.901378 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 14138363 blocks Nov 7 01:21:10.919153 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 7 01:21:10.967794 dbus-daemon[1518]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 7 01:21:10.968653 dbus-daemon[1518]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1567 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Nov 7 01:21:10.975639 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Nov 7 01:21:11.006689 systemd-logind[1530]: New seat seat0. Nov 7 01:21:11.007584 systemd[1]: Starting polkit.service - Authorization Manager... Nov 7 01:21:11.014296 systemd[1]: Started systemd-logind.service - User Login Management. Nov 7 01:21:11.032955 bash[1594]: Updated "/home/core/.ssh/authorized_keys" Nov 7 01:21:11.043018 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 7 01:21:11.054505 systemd[1]: Starting sshkeys.service... Nov 7 01:21:11.119137 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Nov 7 01:21:11.121709 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 7 01:21:11.132287 update-ssh-keys[1597]: Updated "/home/core/.ssh/authorized_keys" Nov 7 01:21:11.133543 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Nov 7 01:21:11.148135 polkitd[1601]: Started polkitd version 126 Nov 7 01:21:11.165084 systemd[1]: Finished sshkeys.service. Nov 7 01:21:11.179672 kernel: EXT4-fs (vda9): resized filesystem to 14138363 Nov 7 01:21:11.182324 polkitd[1601]: Loading rules from directory /etc/polkit-1/rules.d Nov 7 01:21:11.192834 polkitd[1601]: Loading rules from directory /run/polkit-1/rules.d Nov 7 01:21:11.192939 polkitd[1601]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Nov 7 01:21:11.193293 polkitd[1601]: Loading rules from directory /usr/local/share/polkit-1/rules.d Nov 7 01:21:11.193335 polkitd[1601]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Nov 7 01:21:11.193414 polkitd[1601]: Loading rules from directory /usr/share/polkit-1/rules.d Nov 7 01:21:11.198465 extend-filesystems[1589]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Nov 7 01:21:11.198465 extend-filesystems[1589]: old_desc_blocks = 1, new_desc_blocks = 7 Nov 7 01:21:11.198465 extend-filesystems[1589]: The filesystem on /dev/vda9 is now 14138363 (4k) blocks long. Nov 7 01:21:11.198137 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 7 01:21:11.199180 polkitd[1601]: Finished loading, compiling and executing 2 rules Nov 7 01:21:11.208465 extend-filesystems[1523]: Resized filesystem in /dev/vda9 Nov 7 01:21:11.199473 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 7 01:21:11.210529 dbus-daemon[1518]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 7 01:21:11.200966 systemd[1]: Started polkit.service - Authorization Manager. Nov 7 01:21:11.212403 polkitd[1601]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Nov 7 01:21:11.248841 systemd-hostnamed[1567]: Hostname set to (static) Nov 7 01:21:11.421084 systemd-logind[1530]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 7 01:21:11.439942 systemd-logind[1530]: Watching system buttons on /dev/input/event3 (Power Button) Nov 7 01:21:11.473789 systemd-networkd[1480]: eth0: Gained IPv6LL Nov 7 01:21:11.479281 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 7 01:21:11.485596 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:11.495710 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 7 01:21:11.497684 systemd[1]: Reached target network-online.target - Network is Online. Nov 7 01:21:11.504971 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Nov 7 01:21:11.510935 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 7 01:21:11.531636 containerd[1538]: time="2025-11-07T01:21:11Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Nov 7 01:21:11.533735 containerd[1538]: time="2025-11-07T01:21:11.533680307Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Nov 7 01:21:11.546008 (-wrapper)[1630]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Nov 7 01:21:11.580295 locksmithd[1568]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 7 01:21:11.614401 containerd[1538]: time="2025-11-07T01:21:11.614009411Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="20.135µs" Nov 7 01:21:11.614401 containerd[1538]: time="2025-11-07T01:21:11.614069229Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 7 01:21:11.614401 containerd[1538]: time="2025-11-07T01:21:11.614106131Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 7 01:21:11.614593 containerd[1538]: time="2025-11-07T01:21:11.614458770Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 7 01:21:11.614593 containerd[1538]: time="2025-11-07T01:21:11.614485571Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 7 01:21:11.614593 containerd[1538]: time="2025-11-07T01:21:11.614533787Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 7 01:21:11.614703 containerd[1538]: time="2025-11-07T01:21:11.614641405Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 7 01:21:11.614703 containerd[1538]: time="2025-11-07T01:21:11.614673694Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 7 01:21:11.615626 containerd[1538]: time="2025-11-07T01:21:11.614987500Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 7 01:21:11.615626 containerd[1538]: time="2025-11-07T01:21:11.615019435Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 7 01:21:11.615626 containerd[1538]: time="2025-11-07T01:21:11.615038584Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 7 01:21:11.615626 containerd[1538]: time="2025-11-07T01:21:11.615052739Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 7 01:21:11.615626 containerd[1538]: time="2025-11-07T01:21:11.615179968Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 7 01:21:11.633707 containerd[1538]: time="2025-11-07T01:21:11.632713548Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 7 01:21:11.633707 containerd[1538]: time="2025-11-07T01:21:11.632791250Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 7 01:21:11.633707 containerd[1538]: time="2025-11-07T01:21:11.632813259Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 7 01:21:11.633707 containerd[1538]: time="2025-11-07T01:21:11.632861931Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 7 01:21:11.633707 containerd[1538]: time="2025-11-07T01:21:11.633237298Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 7 01:21:11.633707 containerd[1538]: time="2025-11-07T01:21:11.633335949Z" level=info msg="metadata content store policy set" policy=shared Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637378798Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637475937Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637504054Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637543968Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637566033Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637583778Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637620693Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637642914Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637663540Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637700068Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637720151Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 7 01:21:11.637781 containerd[1538]: time="2025-11-07T01:21:11.637740884Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643737185Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643809943Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643863780Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643887601Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643925508Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643954031Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643974293Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.643990884Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.644009495Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.644026488Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.644044173Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.644171545Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.644194188Z" level=info msg="Start snapshots syncer" Nov 7 01:21:11.644611 containerd[1538]: time="2025-11-07T01:21:11.644226086Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 7 01:21:11.649325 containerd[1538]: time="2025-11-07T01:21:11.644711984Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Nov 7 01:21:11.649325 containerd[1538]: time="2025-11-07T01:21:11.644813384Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647459954Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647622420Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647677455Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647725695Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647747102Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647774071Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647793256Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647809758Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647847533Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647868475Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647885735Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647947029Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647973134Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 7 01:21:11.649630 containerd[1538]: time="2025-11-07T01:21:11.647988426Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648003528Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648017098Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648032166Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648048262Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648082472Z" level=info msg="runtime interface created" Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648094363Z" level=info msg="created NRI interface" Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648107050Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648125686Z" level=info msg="Connect containerd service" Nov 7 01:21:11.650073 containerd[1538]: time="2025-11-07T01:21:11.648182593Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 7 01:21:11.656939 containerd[1538]: time="2025-11-07T01:21:11.655241989Z" 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" Nov 7 01:21:11.660076 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 7 01:21:12.080372 containerd[1538]: time="2025-11-07T01:21:12.080193229Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 7 01:21:12.081633 containerd[1538]: time="2025-11-07T01:21:12.081420728Z" level=info msg="Start subscribing containerd event" Nov 7 01:21:12.081776 containerd[1538]: time="2025-11-07T01:21:12.081599220Z" level=info msg="Start recovering state" Nov 7 01:21:12.082694 containerd[1538]: time="2025-11-07T01:21:12.082669480Z" level=info msg="Start event monitor" Nov 7 01:21:12.084530 containerd[1538]: time="2025-11-07T01:21:12.082897088Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084407145Z" level=info msg="Start cni network conf syncer for default" Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084555745Z" level=info msg="Start streaming server" Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084594098Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084607314Z" level=info msg="runtime interface starting up..." Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084621821Z" level=info msg="starting plugins..." Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084669988Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 7 01:21:12.085646 containerd[1538]: time="2025-11-07T01:21:12.084917880Z" level=info msg="containerd successfully booted in 0.554509s" Nov 7 01:21:12.085123 systemd[1]: Started containerd.service - containerd container runtime. Nov 7 01:21:12.101928 systemd[1]: Starting docker.service - Docker Application Container Engine... Nov 7 01:21:12.104510 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 7 01:21:12.120812 (dockerd)[1672]: 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 Nov 7 01:21:12.172727 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:12.177174 systemd-networkd[1480]: eth0: Ignoring DHCPv6 address 2a02:1348:179:869b:24:19ff:fee6:1a6e/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:179:869b:24:19ff:fee6:1a6e/64 assigned by NDisc. Nov 7 01:21:12.177184 systemd-networkd[1480]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Nov 7 01:21:12.496711 sshd_keygen[1560]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 7 01:21:12.536576 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 7 01:21:12.545301 dockerd[1672]: time="2025-11-07T01:21:12.544642871Z" level=info msg="Starting up" Nov 7 01:21:12.545763 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 7 01:21:12.546528 dockerd[1672]: time="2025-11-07T01:21:12.546498811Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Nov 7 01:21:12.566368 dockerd[1672]: time="2025-11-07T01:21:12.566312800Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Nov 7 01:21:12.570475 systemd[1]: issuegen.service: Deactivated successfully. Nov 7 01:21:12.571191 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 7 01:21:12.576907 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 7 01:21:12.607403 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 7 01:21:12.613578 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 7 01:21:12.616271 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 7 01:21:12.617714 systemd[1]: Reached target getty.target - Login Prompts. Nov 7 01:21:12.632958 dockerd[1672]: time="2025-11-07T01:21:12.632864192Z" level=info msg="Loading containers: start." Nov 7 01:21:12.645364 kernel: Initializing XFRM netlink socket Nov 7 01:21:12.916981 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:12.918992 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:12.932192 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:12.976797 systemd-networkd[1480]: docker0: Link UP Nov 7 01:21:12.977244 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:12.980482 dockerd[1672]: time="2025-11-07T01:21:12.980424849Z" level=info msg="Loading containers: done." Nov 7 01:21:12.999298 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1233943977-merged.mount: Deactivated successfully. Nov 7 01:21:13.003226 dockerd[1672]: time="2025-11-07T01:21:13.001602350Z" 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 Nov 7 01:21:13.003226 dockerd[1672]: time="2025-11-07T01:21:13.001724535Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Nov 7 01:21:13.003226 dockerd[1672]: time="2025-11-07T01:21:13.001848471Z" level=info msg="Initializing buildkit" Nov 7 01:21:13.029701 dockerd[1672]: time="2025-11-07T01:21:13.029623905Z" level=info msg="Completed buildkit initialization" Nov 7 01:21:13.045054 dockerd[1672]: time="2025-11-07T01:21:13.044927957Z" level=info msg="Daemon has completed initialization" Nov 7 01:21:13.046108 dockerd[1672]: time="2025-11-07T01:21:13.045898195Z" level=info msg="API listen on /run/docker.sock" Nov 7 01:21:13.046754 systemd[1]: Started docker.service - Docker Application Container Engine. Nov 7 01:21:13.053540 etcd-wrapper[1643]: Error response from daemon: No such container: etcd-member Nov 7 01:21:13.073383 etcd-wrapper[1887]: Error response from daemon: No such container: etcd-member Nov 7 01:21:13.113882 etcd-wrapper[1905]: Unable to find image 'quay.io/coreos/etcd:v3.5.22' locally Nov 7 01:21:13.287608 systemd-timesyncd[1462]: Network configuration changed, trying to establish connection. Nov 7 01:21:14.532598 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 7 01:21:14.535286 systemd[1]: Started sshd@0-10.230.26.110:22-139.178.89.65:36596.service - OpenSSH per-connection server daemon (139.178.89.65:36596). Nov 7 01:21:14.539527 etcd-wrapper[1905]: v3.5.22: Pulling from coreos/etcd Nov 7 01:21:14.908366 etcd-wrapper[1905]: f5083dc2076d: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 2ae710cd8bfe: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: d462aa345367: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 0f8b424aa0b9: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: d557676654e5: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: c8022d07192e: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: d858cbc252ad: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 1069fc2daed1: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: b40161cd83fc: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 5318d93a3a65: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 307c1adadb60: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 60a82e1b19c6: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 6f77055ebb6e: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 67f98bbc9874: Pulling fs layer Nov 7 01:21:14.908366 etcd-wrapper[1905]: 1069fc2daed1: Waiting Nov 7 01:21:14.908366 etcd-wrapper[1905]: b40161cd83fc: Waiting Nov 7 01:21:14.908366 etcd-wrapper[1905]: 5318d93a3a65: Waiting Nov 7 01:21:14.908366 etcd-wrapper[1905]: 307c1adadb60: Waiting Nov 7 01:21:14.908366 etcd-wrapper[1905]: 60a82e1b19c6: Waiting Nov 7 01:21:14.910328 etcd-wrapper[1905]: 6f77055ebb6e: Waiting Nov 7 01:21:14.910328 etcd-wrapper[1905]: 67f98bbc9874: Waiting Nov 7 01:21:14.910328 etcd-wrapper[1905]: d557676654e5: Waiting Nov 7 01:21:14.910328 etcd-wrapper[1905]: c8022d07192e: Waiting Nov 7 01:21:14.910328 etcd-wrapper[1905]: d858cbc252ad: Waiting Nov 7 01:21:14.910328 etcd-wrapper[1905]: 0f8b424aa0b9: Waiting Nov 7 01:21:15.413607 etcd-wrapper[1905]: 2ae710cd8bfe: Verifying Checksum Nov 7 01:21:15.414482 etcd-wrapper[1905]: 2ae710cd8bfe: Download complete Nov 7 01:21:15.424014 etcd-wrapper[1905]: f5083dc2076d: Verifying Checksum Nov 7 01:21:15.425028 etcd-wrapper[1905]: f5083dc2076d: Download complete Nov 7 01:21:15.445059 etcd-wrapper[1905]: d462aa345367: Verifying Checksum Nov 7 01:21:15.445059 etcd-wrapper[1905]: d462aa345367: Download complete Nov 7 01:21:15.470199 etcd-wrapper[1905]: f5083dc2076d: Pull complete Nov 7 01:21:15.478183 sshd[1917]: Accepted publickey for core from 139.178.89.65 port 36596 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:15.482282 sshd-session[1917]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:15.497673 systemd[1]: var-lib-docker-overlay2-22bea7b4b8f4cd63fccd4433b7e55bcd9e5ec19858bd011fcffaea3410f3e3e4-merged.mount: Deactivated successfully. Nov 7 01:21:15.505548 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 7 01:21:15.509016 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 7 01:21:15.517520 etcd-wrapper[1905]: 2ae710cd8bfe: Pull complete Nov 7 01:21:15.526605 systemd-logind[1530]: New session 1 of user core. Nov 7 01:21:15.560539 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 7 01:21:15.569511 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 7 01:21:15.595996 (systemd)[1938]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 7 01:21:15.607104 systemd-logind[1530]: New session c1 of user core. Nov 7 01:21:15.804626 etcd-wrapper[1905]: 0f8b424aa0b9: Verifying Checksum Nov 7 01:21:15.804626 etcd-wrapper[1905]: 0f8b424aa0b9: Download complete Nov 7 01:21:15.822637 systemd[1938]: Queued start job for default target default.target. Nov 7 01:21:15.833195 systemd[1938]: Created slice app.slice - User Application Slice. Nov 7 01:21:15.833244 systemd[1938]: Reached target paths.target - Paths. Nov 7 01:21:15.833319 systemd[1938]: Reached target timers.target - Timers. Nov 7 01:21:15.835457 etcd-wrapper[1905]: c8022d07192e: Verifying Checksum Nov 7 01:21:15.835457 etcd-wrapper[1905]: c8022d07192e: Download complete Nov 7 01:21:15.838322 systemd[1938]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 7 01:21:15.864080 etcd-wrapper[1905]: d557676654e5: Verifying Checksum Nov 7 01:21:15.864080 etcd-wrapper[1905]: d557676654e5: Download complete Nov 7 01:21:15.865240 systemd[1938]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 7 01:21:15.865344 systemd[1938]: Reached target sockets.target - Sockets. Nov 7 01:21:15.865459 systemd[1938]: Reached target basic.target - Basic System. Nov 7 01:21:15.865534 systemd[1938]: Reached target default.target - Main User Target. Nov 7 01:21:15.865599 systemd[1938]: Startup finished in 242ms. Nov 7 01:21:15.866090 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 7 01:21:15.873680 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 7 01:21:16.156216 systemd[1]: var-lib-docker-overlay2-f39867f6d219dd8ea0ac606d5476058de6d04e9afd662c7b37fc669283556282-merged.mount: Deactivated successfully. Nov 7 01:21:16.182913 etcd-wrapper[1905]: b40161cd83fc: Verifying Checksum Nov 7 01:21:16.183141 etcd-wrapper[1905]: b40161cd83fc: Download complete Nov 7 01:21:16.183974 etcd-wrapper[1905]: d858cbc252ad: Verifying Checksum Nov 7 01:21:16.183974 etcd-wrapper[1905]: d858cbc252ad: Download complete Nov 7 01:21:16.227070 etcd-wrapper[1905]: d462aa345367: Pull complete Nov 7 01:21:16.249389 etcd-wrapper[1905]: 1069fc2daed1: Verifying Checksum Nov 7 01:21:16.249776 etcd-wrapper[1905]: 1069fc2daed1: Download complete Nov 7 01:21:16.258456 etcd-wrapper[1905]: 0f8b424aa0b9: Pull complete Nov 7 01:21:16.279370 etcd-wrapper[1905]: d557676654e5: Pull complete Nov 7 01:21:16.310363 etcd-wrapper[1905]: c8022d07192e: Pull complete Nov 7 01:21:16.326028 etcd-wrapper[1905]: d858cbc252ad: Pull complete Nov 7 01:21:16.342050 etcd-wrapper[1905]: 1069fc2daed1: Pull complete Nov 7 01:21:16.361485 etcd-wrapper[1905]: b40161cd83fc: Pull complete Nov 7 01:21:16.524510 systemd[1]: Started sshd@1-10.230.26.110:22-139.178.89.65:43660.service - OpenSSH per-connection server daemon (139.178.89.65:43660). Nov 7 01:21:16.597268 etcd-wrapper[1905]: 307c1adadb60: Verifying Checksum Nov 7 01:21:16.597268 etcd-wrapper[1905]: 307c1adadb60: Download complete Nov 7 01:21:16.597987 etcd-wrapper[1905]: 5318d93a3a65: Verifying Checksum Nov 7 01:21:16.598252 etcd-wrapper[1905]: 5318d93a3a65: Download complete Nov 7 01:21:16.615870 systemd[1]: var-lib-docker-overlay2-d23c30e24b129342619d884b608f35fa79b25e0a0089f7354a864c14d9a91eff-merged.mount: Deactivated successfully. Nov 7 01:21:16.637845 etcd-wrapper[1905]: 5318d93a3a65: Pull complete Nov 7 01:21:16.670303 systemd[1]: var-lib-docker-overlay2-623986ead56d236d6b8c7e92105b9ad6e5a470beaaecd88c7e36fbc433a19251-merged.mount: Deactivated successfully. Nov 7 01:21:16.677160 etcd-wrapper[1905]: 307c1adadb60: Pull complete Nov 7 01:21:16.835171 etcd-wrapper[1905]: 60a82e1b19c6: Verifying Checksum Nov 7 01:21:16.835171 etcd-wrapper[1905]: 60a82e1b19c6: Download complete Nov 7 01:21:17.147544 etcd-wrapper[1905]: 6f77055ebb6e: Verifying Checksum Nov 7 01:21:17.147544 etcd-wrapper[1905]: 6f77055ebb6e: Download complete Nov 7 01:21:17.246538 etcd-wrapper[1905]: 67f98bbc9874: Verifying Checksum Nov 7 01:21:17.246811 etcd-wrapper[1905]: 67f98bbc9874: Download complete Nov 7 01:21:17.389270 etcd-wrapper[1905]: 60a82e1b19c6: Pull complete Nov 7 01:21:17.465378 sshd[1978]: Accepted publickey for core from 139.178.89.65 port 43660 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:17.468086 sshd-session[1978]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:17.478123 systemd-logind[1530]: New session 2 of user core. Nov 7 01:21:17.490591 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 7 01:21:17.686825 systemd[1]: var-lib-docker-overlay2-1edb974471e766377f338caf61633c625319800285328b5d0a3adc63b584de67-merged.mount: Deactivated successfully. Nov 7 01:21:17.742197 etcd-wrapper[1905]: 6f77055ebb6e: Pull complete Nov 7 01:21:17.744104 login[1710]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Nov 7 01:21:17.755585 systemd-logind[1530]: New session 3 of user core. Nov 7 01:21:17.772693 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 7 01:21:18.013305 systemd[1]: var-lib-docker-overlay2-e020bc59a37bc398d2639c97ac80ef811c167b7e8d595ee3656ca16c8dc0bd8b-merged.mount: Deactivated successfully. Nov 7 01:21:18.062423 login[1711]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Nov 7 01:21:18.067327 etcd-wrapper[1905]: 67f98bbc9874: Pull complete Nov 7 01:21:18.075970 systemd-logind[1530]: New session 4 of user core. Nov 7 01:21:18.082558 etcd-wrapper[1905]: Digest: sha256:51efcfc4f3a863c072ebe745942f790878c2a268e713a6d140c4f2593271adc6 Nov 7 01:21:18.082661 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 7 01:21:18.089614 etcd-wrapper[1905]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.22 Nov 7 01:21:18.096421 sshd[2003]: Connection closed by 139.178.89.65 port 43660 Nov 7 01:21:18.096987 sshd-session[1978]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:18.104532 systemd[1]: sshd@1-10.230.26.110:22-139.178.89.65:43660.service: Deactivated successfully. Nov 7 01:21:18.107674 systemd[1]: session-2.scope: Deactivated successfully. Nov 7 01:21:18.112769 systemd-logind[1530]: Session 2 logged out. Waiting for processes to exit. Nov 7 01:21:18.117020 systemd-logind[1530]: Removed session 2. Nov 7 01:21:18.178442 containerd[1538]: time="2025-11-07T01:21:18.178316731Z" level=info msg="connecting to shim 94fa61a236b919e720abc5f68a87809ed5314ec198772f83e323c5e3f34c306c" address="unix:///run/containerd/s/f71b76b4d07f9e2f132ee8c829569bfb5c99da8a35b221b4cb6c08c575527fbb" namespace=moby protocol=ttrpc version=3 Nov 7 01:21:18.215568 systemd[1]: Started docker-94fa61a236b919e720abc5f68a87809ed5314ec198772f83e323c5e3f34c306c.scope - libcontainer container 94fa61a236b919e720abc5f68a87809ed5314ec198772f83e323c5e3f34c306c. Nov 7 01:21:18.264673 systemd[1]: Started sshd@2-10.230.26.110:22-139.178.89.65:43674.service - OpenSSH per-connection server daemon (139.178.89.65:43674). Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.320440Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.320592Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"1d84d9fd06824403a276afe3781318e8"} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.320627Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.320693Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.22"} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.320724Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.320732Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.320803Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.320847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.230.26.110:2379"]} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.320953Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.320976Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Nov 7 01:21:18.322690 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.321678Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Nov 7 01:21:18.323324 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.321900Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.22","git-sha":"7862c85","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"1d84d9fd06824403a276afe3781318e8","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.230.26.110:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"1d84d9fd06824403a276afe3781318e8=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"} Nov 7 01:21:18.325319 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.324981Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.357201ms"} Nov 7 01:21:18.343919 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.343587Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Nov 7 01:21:18.344264 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.343715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Nov 7 01:21:18.344264 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.343746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Nov 7 01:21:18.344264 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.343760Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Nov 7 01:21:18.344264 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.343772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Nov 7 01:21:18.344764 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.344583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Nov 7 01:21:18.347137 etcd-wrapper[1905]: {"level":"warn","ts":"2025-11-07T01:21:18.346888Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Nov 7 01:21:18.348850 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.348046Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Nov 7 01:21:18.348850 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.348089Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Nov 7 01:21:18.349817 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.349605Z","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"} Nov 7 01:21:18.350596 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.350413Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.22","cluster-version":"to_be_decided"} Nov 7 01:21:18.350882 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.350728Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Nov 7 01:21:18.350882 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.350769Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Nov 7 01:21:18.351510 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.351282Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Nov 7 01:21:18.351808 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.351622Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Nov 7 01:21:18.352882 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.352101Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Nov 7 01:21:18.353074 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.352492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Nov 7 01:21:18.353074 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.352606Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"],"added-peer-is-learner":false} Nov 7 01:21:18.354613 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.354316Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.230.26.110:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Nov 7 01:21:18.354613 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.354414Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Nov 7 01:21:18.354856 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.354437Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.545887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.545979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.546005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.546023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.546061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.546077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Nov 7 01:21:18.547982 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.546089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Nov 7 01:21:18.549387 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.548587Z","caller":"etcdserver/server.go:2697","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Nov 7 01:21:18.549625 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.549221Z","caller":"etcdserver/server.go:2144","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:1d84d9fd06824403a276afe3781318e8 ClientURLs:[http://10.230.26.110:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Nov 7 01:21:18.549625 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.549226Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Nov 7 01:21:18.550106 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.549916Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Nov 7 01:21:18.550868 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.550306Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Nov 7 01:21:18.550868 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.550491Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Nov 7 01:21:18.550868 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.550564Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Nov 7 01:21:18.550868 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.550592Z","caller":"etcdserver/server.go:2721","msg":"cluster version is updated","cluster-version":"3.5"} Nov 7 01:21:18.552127 systemd[1]: Started etcd-member.service - etcd (System Application Container). Nov 7 01:21:18.552634 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 7 01:21:18.553589 systemd[1]: Startup finished in 2.883s (kernel) + 11.285s (initrd) + 11.352s (userspace) = 25.521s. Nov 7 01:21:18.554238 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.551870Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Nov 7 01:21:18.554238 etcd-wrapper[1905]: {"level":"info","ts":"2025-11-07T01:21:18.553519Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Nov 7 01:21:19.210187 sshd[2079]: Accepted publickey for core from 139.178.89.65 port 43674 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:19.211026 sshd-session[2079]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:19.218421 systemd-logind[1530]: New session 5 of user core. Nov 7 01:21:19.227592 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 7 01:21:19.848354 sshd[2096]: Connection closed by 139.178.89.65 port 43674 Nov 7 01:21:19.848057 sshd-session[2079]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:19.854464 systemd[1]: sshd@2-10.230.26.110:22-139.178.89.65:43674.service: Deactivated successfully. Nov 7 01:21:19.856733 systemd[1]: session-5.scope: Deactivated successfully. Nov 7 01:21:19.857958 systemd-logind[1530]: Session 5 logged out. Waiting for processes to exit. Nov 7 01:21:19.859656 systemd-logind[1530]: Removed session 5. Nov 7 01:21:30.024001 systemd[1]: Started sshd@3-10.230.26.110:22-139.178.89.65:57602.service - OpenSSH per-connection server daemon (139.178.89.65:57602). Nov 7 01:21:30.968858 sshd[2102]: Accepted publickey for core from 139.178.89.65 port 57602 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:30.970658 sshd-session[2102]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:30.977633 systemd-logind[1530]: New session 6 of user core. Nov 7 01:21:30.988583 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 7 01:21:31.601494 sshd[2105]: Connection closed by 139.178.89.65 port 57602 Nov 7 01:21:31.602333 sshd-session[2102]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:31.607730 systemd[1]: sshd@3-10.230.26.110:22-139.178.89.65:57602.service: Deactivated successfully. Nov 7 01:21:31.610680 systemd[1]: session-6.scope: Deactivated successfully. Nov 7 01:21:31.612593 systemd-logind[1530]: Session 6 logged out. Waiting for processes to exit. Nov 7 01:21:31.613951 systemd-logind[1530]: Removed session 6. Nov 7 01:21:31.762306 systemd[1]: Started sshd@4-10.230.26.110:22-139.178.89.65:57612.service - OpenSSH per-connection server daemon (139.178.89.65:57612). Nov 7 01:21:32.697950 sshd[2111]: Accepted publickey for core from 139.178.89.65 port 57612 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:32.699647 sshd-session[2111]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:32.707404 systemd-logind[1530]: New session 7 of user core. Nov 7 01:21:32.714553 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 7 01:21:33.326403 sshd[2114]: Connection closed by 139.178.89.65 port 57612 Nov 7 01:21:33.327261 sshd-session[2111]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:33.333391 systemd[1]: sshd@4-10.230.26.110:22-139.178.89.65:57612.service: Deactivated successfully. Nov 7 01:21:33.335702 systemd[1]: session-7.scope: Deactivated successfully. Nov 7 01:21:33.337184 systemd-logind[1530]: Session 7 logged out. Waiting for processes to exit. Nov 7 01:21:33.339774 systemd-logind[1530]: Removed session 7. Nov 7 01:21:33.490697 systemd[1]: Started sshd@5-10.230.26.110:22-139.178.89.65:57624.service - OpenSSH per-connection server daemon (139.178.89.65:57624). Nov 7 01:21:34.427188 sshd[2120]: Accepted publickey for core from 139.178.89.65 port 57624 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:34.429027 sshd-session[2120]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:34.436628 systemd-logind[1530]: New session 8 of user core. Nov 7 01:21:34.453815 systemd[1]: Started session-8.scope - Session 8 of User core. Nov 7 01:21:35.072209 sshd[2123]: Connection closed by 139.178.89.65 port 57624 Nov 7 01:21:35.073335 sshd-session[2120]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:35.080333 systemd[1]: sshd@5-10.230.26.110:22-139.178.89.65:57624.service: Deactivated successfully. Nov 7 01:21:35.082970 systemd[1]: session-8.scope: Deactivated successfully. Nov 7 01:21:35.084315 systemd-logind[1530]: Session 8 logged out. Waiting for processes to exit. Nov 7 01:21:35.086257 systemd-logind[1530]: Removed session 8. Nov 7 01:21:35.244864 systemd[1]: Started sshd@6-10.230.26.110:22-139.178.89.65:57634.service - OpenSSH per-connection server daemon (139.178.89.65:57634). Nov 7 01:21:36.197422 sshd[2129]: Accepted publickey for core from 139.178.89.65 port 57634 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:36.199332 sshd-session[2129]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:36.208081 systemd-logind[1530]: New session 9 of user core. Nov 7 01:21:36.218019 systemd[1]: Started session-9.scope - Session 9 of User core. Nov 7 01:21:36.704901 sudo[2133]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 7 01:21:36.705397 sudo[2133]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 7 01:21:36.722073 sudo[2133]: pam_unix(sudo:session): session closed for user root Nov 7 01:21:36.871103 sshd[2132]: Connection closed by 139.178.89.65 port 57634 Nov 7 01:21:36.872260 sshd-session[2129]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:36.879453 systemd[1]: sshd@6-10.230.26.110:22-139.178.89.65:57634.service: Deactivated successfully. Nov 7 01:21:36.882357 systemd[1]: session-9.scope: Deactivated successfully. Nov 7 01:21:36.883690 systemd-logind[1530]: Session 9 logged out. Waiting for processes to exit. Nov 7 01:21:36.885655 systemd-logind[1530]: Removed session 9. Nov 7 01:21:37.027702 systemd[1]: Started sshd@7-10.230.26.110:22-139.178.89.65:50896.service - OpenSSH per-connection server daemon (139.178.89.65:50896). Nov 7 01:21:37.956635 sshd[2139]: Accepted publickey for core from 139.178.89.65 port 50896 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:37.958563 sshd-session[2139]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:37.965832 systemd-logind[1530]: New session 10 of user core. Nov 7 01:21:37.979680 systemd[1]: Started session-10.scope - Session 10 of User core. Nov 7 01:21:38.444364 sudo[2144]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 7 01:21:38.444786 sudo[2144]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 7 01:21:38.452499 sudo[2144]: pam_unix(sudo:session): session closed for user root Nov 7 01:21:38.462114 sudo[2143]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Nov 7 01:21:38.462594 sudo[2143]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 7 01:21:38.477198 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 7 01:21:38.536879 augenrules[2166]: No rules Nov 7 01:21:38.538459 systemd[1]: audit-rules.service: Deactivated successfully. Nov 7 01:21:38.538830 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 7 01:21:38.540018 sudo[2143]: pam_unix(sudo:session): session closed for user root Nov 7 01:21:38.688492 sshd[2142]: Connection closed by 139.178.89.65 port 50896 Nov 7 01:21:38.687727 sshd-session[2139]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:38.692409 systemd-logind[1530]: Session 10 logged out. Waiting for processes to exit. Nov 7 01:21:38.692797 systemd[1]: sshd@7-10.230.26.110:22-139.178.89.65:50896.service: Deactivated successfully. Nov 7 01:21:38.695137 systemd[1]: session-10.scope: Deactivated successfully. Nov 7 01:21:38.698101 systemd-logind[1530]: Removed session 10. Nov 7 01:21:38.848949 systemd[1]: Started sshd@8-10.230.26.110:22-139.178.89.65:50898.service - OpenSSH per-connection server daemon (139.178.89.65:50898). Nov 7 01:21:39.781220 sshd[2175]: Accepted publickey for core from 139.178.89.65 port 50898 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:39.782985 sshd-session[2175]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:39.789839 systemd-logind[1530]: New session 11 of user core. Nov 7 01:21:39.798571 systemd[1]: Started session-11.scope - Session 11 of User core. Nov 7 01:21:40.413745 sshd[2178]: Connection closed by 139.178.89.65 port 50898 Nov 7 01:21:40.413957 sshd-session[2175]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:40.419191 systemd[1]: sshd@8-10.230.26.110:22-139.178.89.65:50898.service: Deactivated successfully. Nov 7 01:21:40.421559 systemd[1]: session-11.scope: Deactivated successfully. Nov 7 01:21:40.423261 systemd-logind[1530]: Session 11 logged out. Waiting for processes to exit. Nov 7 01:21:40.425237 systemd-logind[1530]: Removed session 11. Nov 7 01:21:40.572366 systemd[1]: Started sshd@9-10.230.26.110:22-139.178.89.65:50914.service - OpenSSH per-connection server daemon (139.178.89.65:50914). Nov 7 01:21:41.506930 sshd[2186]: Accepted publickey for core from 139.178.89.65 port 50914 ssh2: RSA SHA256:xyBrW4cB1jVKc7ydGrgU0u6DzLOQbm6jg5G0pPs5yd0 Nov 7 01:21:41.508921 sshd-session[2186]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 7 01:21:41.519302 systemd-logind[1530]: New session 12 of user core. Nov 7 01:21:41.525559 systemd[1]: Started session-12.scope - Session 12 of User core. Nov 7 01:21:42.213179 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Nov 7 01:21:42.260859 sshd[2189]: Connection closed by 139.178.89.65 port 50914 Nov 7 01:21:42.261827 sshd-session[2186]: pam_unix(sshd:session): session closed for user core Nov 7 01:21:42.267910 systemd-logind[1530]: Session 12 logged out. Waiting for processes to exit. Nov 7 01:21:42.268364 systemd[1]: sshd@9-10.230.26.110:22-139.178.89.65:50914.service: Deactivated successfully. Nov 7 01:21:42.271012 systemd[1]: session-12.scope: Deactivated successfully. Nov 7 01:21:42.273273 systemd-logind[1530]: Removed session 12. Nov 7 01:21:44.455144 systemd-resolved[1327]: Clock change detected. Flushing caches. Nov 7 01:21:44.455646 systemd-timesyncd[1462]: Contacted time server [2a00:85c0:1::240:21]:123 (2.flatcar.pool.ntp.org). Nov 7 01:21:44.455760 systemd-timesyncd[1462]: Initial clock synchronization to Fri 2025-11-07 01:21:44.455000 UTC. Nov 7 01:21:56.807611 update_engine[1531]: I20251107 01:21:56.807367 1531 update_attempter.cc:509] Updating boot flags... Nov 7 01:22:23.631420 systemd[1]: Started sshd@10-10.230.26.110:22-78.128.112.74:52354.service - OpenSSH per-connection server daemon (78.128.112.74:52354). Nov 7 01:22:23.910511 sshd[2221]: Invalid user admin from 78.128.112.74 port 52354 Nov 7 01:22:23.958410 sshd[2221]: Connection closed by invalid user admin 78.128.112.74 port 52354 [preauth] Nov 7 01:22:23.961772 systemd[1]: sshd@10-10.230.26.110:22-78.128.112.74:52354.service: Deactivated successfully. Nov 7 01:25:43.895424 update_engine[1531]: I20251107 01:25:43.894870 1531 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Nov 7 01:25:43.895424 update_engine[1531]: I20251107 01:25:43.895087 1531 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Nov 7 01:25:43.897745 update_engine[1531]: I20251107 01:25:43.896109 1531 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Nov 7 01:25:43.897745 update_engine[1531]: I20251107 01:25:43.897325 1531 omaha_request_params.cc:62] Current group set to alpha Nov 7 01:25:43.897745 update_engine[1531]: I20251107 01:25:43.897699 1531 update_attempter.cc:499] Already updated boot flags. Skipping. Nov 7 01:25:43.897745 update_engine[1531]: I20251107 01:25:43.897720 1531 update_attempter.cc:643] Scheduling an action processor start. Nov 7 01:25:43.898008 update_engine[1531]: I20251107 01:25:43.897759 1531 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 7 01:25:43.898008 update_engine[1531]: I20251107 01:25:43.897886 1531 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Nov 7 01:25:43.898116 update_engine[1531]: I20251107 01:25:43.898015 1531 omaha_request_action.cc:271] Posting an Omaha request to disabled Nov 7 01:25:43.898116 update_engine[1531]: I20251107 01:25:43.898034 1531 omaha_request_action.cc:272] Request: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: Nov 7 01:25:43.898116 update_engine[1531]: I20251107 01:25:43.898056 1531 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 7 01:25:43.899803 locksmithd[1568]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Nov 7 01:25:43.900534 update_engine[1531]: I20251107 01:25:43.900486 1531 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 7 01:25:43.901811 update_engine[1531]: I20251107 01:25:43.901732 1531 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 7 01:25:43.919786 update_engine[1531]: E20251107 01:25:43.919653 1531 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (DNS server returned answer with no data) Nov 7 01:25:43.919949 update_engine[1531]: I20251107 01:25:43.919864 1531 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Nov 7 01:25:53.794434 update_engine[1531]: I20251107 01:25:53.794278 1531 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 7 01:25:53.795242 update_engine[1531]: I20251107 01:25:53.794504 1531 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 7 01:25:53.795242 update_engine[1531]: I20251107 01:25:53.795145 1531 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 7 01:25:53.795703 update_engine[1531]: E20251107 01:25:53.795651 1531 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (DNS server returned answer with no data) Nov 7 01:25:53.795781 update_engine[1531]: I20251107 01:25:53.795759 1531 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 Nov 7 01:26:03.803462 update_engine[1531]: I20251107 01:26:03.803290 1531 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 7 01:26:03.803462 update_engine[1531]: I20251107 01:26:03.803472 1531 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 7 01:26:03.804308 update_engine[1531]: I20251107 01:26:03.804112 1531 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 7 01:26:03.804894 update_engine[1531]: E20251107 01:26:03.804847 1531 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (DNS server returned answer with no data) Nov 7 01:26:03.805015 update_engine[1531]: I20251107 01:26:03.804975 1531 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 Nov 7 01:26:13.794809 update_engine[1531]: I20251107 01:26:13.794646 1531 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.794833 1531 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.795475 1531 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 7 01:26:13.797547 update_engine[1531]: E20251107 01:26:13.796062 1531 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (DNS server returned answer with no data) Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796180 1531 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796226 1531 omaha_request_action.cc:617] Omaha request response: Nov 7 01:26:13.797547 update_engine[1531]: E20251107 01:26:13.796443 1531 omaha_request_action.cc:636] Omaha request network transfer failed. Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796509 1531 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796522 1531 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796578 1531 update_attempter.cc:306] Processing Done. Nov 7 01:26:13.797547 update_engine[1531]: E20251107 01:26:13.796615 1531 update_attempter.cc:619] Update failed. Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796635 1531 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796648 1531 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796658 1531 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796778 1531 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796818 1531 omaha_request_action.cc:271] Posting an Omaha request to disabled Nov 7 01:26:13.797547 update_engine[1531]: I20251107 01:26:13.796837 1531 omaha_request_action.cc:272] Request: Nov 7 01:26:13.797547 update_engine[1531]: Nov 7 01:26:13.797547 update_engine[1531]: Nov 7 01:26:13.798415 locksmithd[1568]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 Nov 7 01:26:13.798849 update_engine[1531]: Nov 7 01:26:13.798849 update_engine[1531]: Nov 7 01:26:13.798849 update_engine[1531]: Nov 7 01:26:13.798849 update_engine[1531]: Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.796851 1531 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.796880 1531 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797312 1531 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 7 01:26:13.798849 update_engine[1531]: E20251107 01:26:13.797739 1531 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (DNS server returned answer with no data) Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797807 1531 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797824 1531 omaha_request_action.cc:617] Omaha request response: Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797835 1531 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797844 1531 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797853 1531 update_attempter.cc:306] Processing Done. Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797863 1531 update_attempter.cc:310] Error event sent. Nov 7 01:26:13.798849 update_engine[1531]: I20251107 01:26:13.797894 1531 update_check_scheduler.cc:74] Next update check in 47m43s Nov 7 01:26:13.799520 locksmithd[1568]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0