Oct 29 01:52:13.854122 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Tue Oct 28 22:17:03 -00 2025 Oct 29 01:52:13.854148 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=3712f4aa3d5ecdc33a05d6cb95187265998ea757b06dac816207e4f222678133 Oct 29 01:52:13.854159 kernel: BIOS-provided physical RAM map: Oct 29 01:52:13.854166 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Oct 29 01:52:13.854176 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Oct 29 01:52:13.854183 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Oct 29 01:52:13.854191 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffdbfff] usable Oct 29 01:52:13.854199 kernel: BIOS-e820: [mem 0x000000007ffdc000-0x000000007fffffff] reserved Oct 29 01:52:13.854206 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Oct 29 01:52:13.854214 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Oct 29 01:52:13.854221 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Oct 29 01:52:13.854228 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Oct 29 01:52:13.854236 kernel: NX (Execute Disable) protection: active Oct 29 01:52:13.854246 kernel: APIC: Static calls initialized Oct 29 01:52:13.854255 kernel: SMBIOS 2.8 present. Oct 29 01:52:13.854264 kernel: DMI: Red Hat KVM/RHEL-AV, BIOS 1.13.0-2.module_el8.5.0+2608+72063365 04/01/2014 Oct 29 01:52:13.854272 kernel: DMI: Memory slots populated: 1/1 Oct 29 01:52:13.854281 kernel: Hypervisor detected: KVM Oct 29 01:52:13.854291 kernel: last_pfn = 0x7ffdc max_arch_pfn = 0x400000000 Oct 29 01:52:13.854300 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 29 01:52:13.854308 kernel: kvm-clock: using sched offset of 5467079276 cycles Oct 29 01:52:13.854317 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 29 01:52:13.854326 kernel: tsc: Detected 2294.576 MHz processor Oct 29 01:52:13.854335 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 29 01:52:13.854344 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 29 01:52:13.854352 kernel: last_pfn = 0x7ffdc max_arch_pfn = 0x400000000 Oct 29 01:52:13.854360 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Oct 29 01:52:13.854369 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 29 01:52:13.854379 kernel: Using GB pages for direct mapping Oct 29 01:52:13.854388 kernel: ACPI: Early table checksum verification disabled Oct 29 01:52:13.854396 kernel: ACPI: RSDP 0x00000000000F5AA0 000014 (v00 BOCHS ) Oct 29 01:52:13.854405 kernel: ACPI: RSDT 0x000000007FFE47A5 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854413 kernel: ACPI: FACP 0x000000007FFE438D 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854422 kernel: ACPI: DSDT 0x000000007FFDFD80 00460D (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854430 kernel: ACPI: FACS 0x000000007FFDFD40 000040 Oct 29 01:52:13.854438 kernel: ACPI: APIC 0x000000007FFE4481 0000F0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854447 kernel: ACPI: SRAT 0x000000007FFE4571 0001D0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854458 kernel: ACPI: MCFG 0x000000007FFE4741 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854466 kernel: ACPI: WAET 0x000000007FFE477D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 01:52:13.854475 kernel: ACPI: Reserving FACP table memory at [mem 0x7ffe438d-0x7ffe4480] Oct 29 01:52:13.854487 kernel: ACPI: Reserving DSDT table memory at [mem 0x7ffdfd80-0x7ffe438c] Oct 29 01:52:13.854496 kernel: ACPI: Reserving FACS table memory at [mem 0x7ffdfd40-0x7ffdfd7f] Oct 29 01:52:13.854505 kernel: ACPI: Reserving APIC table memory at [mem 0x7ffe4481-0x7ffe4570] Oct 29 01:52:13.854516 kernel: ACPI: Reserving SRAT table memory at [mem 0x7ffe4571-0x7ffe4740] Oct 29 01:52:13.854525 kernel: ACPI: Reserving MCFG table memory at [mem 0x7ffe4741-0x7ffe477c] Oct 29 01:52:13.854533 kernel: ACPI: Reserving WAET table memory at [mem 0x7ffe477d-0x7ffe47a4] Oct 29 01:52:13.854542 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Oct 29 01:52:13.854551 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0x7fffffff] Oct 29 01:52:13.855586 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x20800fffff] hotplug Oct 29 01:52:13.855601 kernel: NUMA: Node 0 [mem 0x00001000-0x0009ffff] + [mem 0x00100000-0x7ffdbfff] -> [mem 0x00001000-0x7ffdbfff] Oct 29 01:52:13.855611 kernel: NODE_DATA(0) allocated [mem 0x7ffd4dc0-0x7ffdbfff] Oct 29 01:52:13.855624 kernel: Zone ranges: Oct 29 01:52:13.855633 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 29 01:52:13.855642 kernel: DMA32 [mem 0x0000000001000000-0x000000007ffdbfff] Oct 29 01:52:13.855651 kernel: Normal empty Oct 29 01:52:13.855660 kernel: Device empty Oct 29 01:52:13.855669 kernel: Movable zone start for each node Oct 29 01:52:13.855678 kernel: Early memory node ranges Oct 29 01:52:13.855687 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Oct 29 01:52:13.855696 kernel: node 0: [mem 0x0000000000100000-0x000000007ffdbfff] Oct 29 01:52:13.855707 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdbfff] Oct 29 01:52:13.855716 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 29 01:52:13.855725 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Oct 29 01:52:13.855734 kernel: On node 0, zone DMA32: 36 pages in unavailable ranges Oct 29 01:52:13.855743 kernel: ACPI: PM-Timer IO Port: 0x608 Oct 29 01:52:13.855752 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 29 01:52:13.855760 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 29 01:52:13.855769 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 29 01:52:13.855778 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 29 01:52:13.855799 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 29 01:52:13.855808 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 29 01:52:13.855817 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 29 01:52:13.855826 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 29 01:52:13.855834 kernel: TSC deadline timer available Oct 29 01:52:13.855843 kernel: CPU topo: Max. logical packages: 16 Oct 29 01:52:13.855852 kernel: CPU topo: Max. logical dies: 16 Oct 29 01:52:13.855861 kernel: CPU topo: Max. dies per package: 1 Oct 29 01:52:13.855869 kernel: CPU topo: Max. threads per core: 1 Oct 29 01:52:13.855878 kernel: CPU topo: Num. cores per package: 1 Oct 29 01:52:13.855889 kernel: CPU topo: Num. threads per package: 1 Oct 29 01:52:13.855898 kernel: CPU topo: Allowing 2 present CPUs plus 14 hotplug CPUs Oct 29 01:52:13.855907 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Oct 29 01:52:13.855916 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Oct 29 01:52:13.855925 kernel: Booting paravirtualized kernel on KVM Oct 29 01:52:13.855934 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 29 01:52:13.855943 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:16 nr_cpu_ids:16 nr_node_ids:1 Oct 29 01:52:13.855952 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Oct 29 01:52:13.855960 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Oct 29 01:52:13.855972 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15 Oct 29 01:52:13.855981 kernel: kvm-guest: PV spinlocks enabled Oct 29 01:52:13.855990 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 29 01:52:13.856000 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=3712f4aa3d5ecdc33a05d6cb95187265998ea757b06dac816207e4f222678133 Oct 29 01:52:13.856009 kernel: random: crng init done Oct 29 01:52:13.856018 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 01:52:13.856027 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 29 01:52:13.856035 kernel: Fallback order for Node 0: 0 Oct 29 01:52:13.856047 kernel: Built 1 zonelists, mobility grouping on. Total pages: 524154 Oct 29 01:52:13.856056 kernel: Policy zone: DMA32 Oct 29 01:52:13.856064 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 01:52:13.856073 kernel: software IO TLB: area num 16. Oct 29 01:52:13.856082 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1 Oct 29 01:52:13.856091 kernel: ftrace: allocating 40021 entries in 157 pages Oct 29 01:52:13.856100 kernel: ftrace: allocated 157 pages with 5 groups Oct 29 01:52:13.856108 kernel: Dynamic Preempt: voluntary Oct 29 01:52:13.856117 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 01:52:13.856130 kernel: rcu: RCU event tracing is enabled. Oct 29 01:52:13.856139 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=16. Oct 29 01:52:13.856148 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 01:52:13.856157 kernel: Rude variant of Tasks RCU enabled. Oct 29 01:52:13.856166 kernel: Tracing variant of Tasks RCU enabled. Oct 29 01:52:13.856175 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 01:52:13.856184 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=16 Oct 29 01:52:13.856193 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Oct 29 01:52:13.856202 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Oct 29 01:52:13.856213 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Oct 29 01:52:13.856222 kernel: NR_IRQS: 33024, nr_irqs: 552, preallocated irqs: 16 Oct 29 01:52:13.856231 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 29 01:52:13.856240 kernel: Console: colour VGA+ 80x25 Oct 29 01:52:13.856257 kernel: printk: legacy console [tty0] enabled Oct 29 01:52:13.856269 kernel: printk: legacy console [ttyS0] enabled Oct 29 01:52:13.856279 kernel: ACPI: Core revision 20240827 Oct 29 01:52:13.856288 kernel: APIC: Switch to symmetric I/O mode setup Oct 29 01:52:13.856298 kernel: x2apic enabled Oct 29 01:52:13.856307 kernel: APIC: Switched APIC routing to: physical x2apic Oct 29 01:52:13.856316 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2113312ac93, max_idle_ns: 440795244843 ns Oct 29 01:52:13.856326 kernel: Calibrating delay loop (skipped) preset value.. 4589.15 BogoMIPS (lpj=2294576) Oct 29 01:52:13.856338 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 29 01:52:13.856347 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Oct 29 01:52:13.856357 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Oct 29 01:52:13.856366 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 29 01:52:13.856375 kernel: Spectre V2 : Spectre BHI mitigation: SW BHB clearing on syscall and VM exit Oct 29 01:52:13.856387 kernel: Spectre V2 : Mitigation: Enhanced / Automatic IBRS Oct 29 01:52:13.856396 kernel: Spectre V2 : Spectre v2 / PBRSB-eIBRS: Retire a single CALL on VMEXIT Oct 29 01:52:13.856405 kernel: RETBleed: Mitigation: Enhanced IBRS Oct 29 01:52:13.856415 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Oct 29 01:52:13.856424 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Oct 29 01:52:13.856433 kernel: TAA: Mitigation: Clear CPU buffers Oct 29 01:52:13.856442 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 29 01:52:13.856452 kernel: GDS: Unknown: Dependent on hypervisor status Oct 29 01:52:13.856461 kernel: active return thunk: its_return_thunk Oct 29 01:52:13.856470 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 29 01:52:13.856479 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 29 01:52:13.856492 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 29 01:52:13.856501 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 29 01:52:13.856510 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Oct 29 01:52:13.856519 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Oct 29 01:52:13.856529 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Oct 29 01:52:13.856538 kernel: x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' Oct 29 01:52:13.856547 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 29 01:52:13.856557 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Oct 29 01:52:13.856586 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Oct 29 01:52:13.856595 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Oct 29 01:52:13.856604 kernel: x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 Oct 29 01:52:13.856616 kernel: x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. Oct 29 01:52:13.856626 kernel: Freeing SMP alternatives memory: 32K Oct 29 01:52:13.856635 kernel: pid_max: default: 32768 minimum: 301 Oct 29 01:52:13.856644 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 29 01:52:13.856654 kernel: landlock: Up and running. Oct 29 01:52:13.856663 kernel: SELinux: Initializing. Oct 29 01:52:13.856672 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 29 01:52:13.856682 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 29 01:52:13.856691 kernel: smpboot: CPU0: Intel Xeon Processor (Cascadelake) (family: 0x6, model: 0x55, stepping: 0x6) Oct 29 01:52:13.856700 kernel: Performance Events: unsupported p6 CPU model 85 no PMU driver, software events only. Oct 29 01:52:13.856710 kernel: signal: max sigframe size: 3632 Oct 29 01:52:13.856722 kernel: rcu: Hierarchical SRCU implementation. Oct 29 01:52:13.856732 kernel: rcu: Max phase no-delay instances is 400. Oct 29 01:52:13.856741 kernel: Timer migration: 2 hierarchy levels; 8 children per group; 2 crossnode level Oct 29 01:52:13.856750 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 29 01:52:13.856760 kernel: smp: Bringing up secondary CPUs ... Oct 29 01:52:13.856769 kernel: smpboot: x86: Booting SMP configuration: Oct 29 01:52:13.856779 kernel: .... node #0, CPUs: #1 Oct 29 01:52:13.856799 kernel: smp: Brought up 1 node, 2 CPUs Oct 29 01:52:13.856809 kernel: smpboot: Total of 2 processors activated (9178.30 BogoMIPS) Oct 29 01:52:13.856821 kernel: Memory: 1889556K/2096616K available (14336K kernel code, 2436K rwdata, 26048K rodata, 45548K init, 1180K bss, 201068K reserved, 0K cma-reserved) Oct 29 01:52:13.856831 kernel: devtmpfs: initialized Oct 29 01:52:13.856840 kernel: x86/mm: Memory block size: 128MB Oct 29 01:52:13.856850 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 01:52:13.856859 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Oct 29 01:52:13.856869 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 01:52:13.856878 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 29 01:52:13.856888 kernel: audit: initializing netlink subsys (disabled) Oct 29 01:52:13.856897 kernel: audit: type=2000 audit(1761702730.018:1): state=initialized audit_enabled=0 res=1 Oct 29 01:52:13.856909 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 01:52:13.856919 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 29 01:52:13.856928 kernel: cpuidle: using governor menu Oct 29 01:52:13.856938 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 01:52:13.856947 kernel: dca service started, version 1.12.1 Oct 29 01:52:13.856956 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Oct 29 01:52:13.856966 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Oct 29 01:52:13.856975 kernel: PCI: Using configuration type 1 for base access Oct 29 01:52:13.856985 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 29 01:52:13.856997 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 01:52:13.857006 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 29 01:52:13.857016 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 01:52:13.857025 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 29 01:52:13.857035 kernel: ACPI: Added _OSI(Module Device) Oct 29 01:52:13.857044 kernel: ACPI: Added _OSI(Processor Device) Oct 29 01:52:13.857053 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 01:52:13.857062 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 01:52:13.857072 kernel: ACPI: Interpreter enabled Oct 29 01:52:13.857084 kernel: ACPI: PM: (supports S0 S5) Oct 29 01:52:13.857093 kernel: ACPI: Using IOAPIC for interrupt routing Oct 29 01:52:13.857103 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 29 01:52:13.857112 kernel: PCI: Using E820 reservations for host bridge windows Oct 29 01:52:13.857121 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Oct 29 01:52:13.857131 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 01:52:13.857310 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 01:52:13.857410 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 29 01:52:13.857505 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 29 01:52:13.857517 kernel: PCI host bridge to bus 0000:00 Oct 29 01:52:13.858676 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 29 01:52:13.858773 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 29 01:52:13.858868 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 29 01:52:13.858950 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] Oct 29 01:52:13.859032 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Oct 29 01:52:13.859153 kernel: pci_bus 0000:00: root bus resource [mem 0x20c0000000-0x28bfffffff window] Oct 29 01:52:13.859237 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 01:52:13.859358 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Oct 29 01:52:13.859468 kernel: pci 0000:00:01.0: [1013:00b8] type 00 class 0x030000 conventional PCI endpoint Oct 29 01:52:13.859574 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfa000000-0xfbffffff pref] Oct 29 01:52:13.859668 kernel: pci 0000:00:01.0: BAR 1 [mem 0xfea50000-0xfea50fff] Oct 29 01:52:13.859764 kernel: pci 0000:00:01.0: ROM [mem 0xfea40000-0xfea4ffff pref] Oct 29 01:52:13.859884 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 29 01:52:13.859992 kernel: pci 0000:00:02.0: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.860085 kernel: pci 0000:00:02.0: BAR 0 [mem 0xfea51000-0xfea51fff] Oct 29 01:52:13.860175 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Oct 29 01:52:13.860266 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Oct 29 01:52:13.860357 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Oct 29 01:52:13.860462 kernel: pci 0000:00:02.1: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.860555 kernel: pci 0000:00:02.1: BAR 0 [mem 0xfea52000-0xfea52fff] Oct 29 01:52:13.860945 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Oct 29 01:52:13.861040 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Oct 29 01:52:13.861131 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Oct 29 01:52:13.862718 kernel: pci 0000:00:02.2: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.862849 kernel: pci 0000:00:02.2: BAR 0 [mem 0xfea53000-0xfea53fff] Oct 29 01:52:13.863587 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Oct 29 01:52:13.863714 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Oct 29 01:52:13.863821 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Oct 29 01:52:13.863922 kernel: pci 0000:00:02.3: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.864016 kernel: pci 0000:00:02.3: BAR 0 [mem 0xfea54000-0xfea54fff] Oct 29 01:52:13.864107 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Oct 29 01:52:13.864199 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Oct 29 01:52:13.864297 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Oct 29 01:52:13.864396 kernel: pci 0000:00:02.4: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.864490 kernel: pci 0000:00:02.4: BAR 0 [mem 0xfea55000-0xfea55fff] Oct 29 01:52:13.864614 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Oct 29 01:52:13.864714 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Oct 29 01:52:13.864815 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Oct 29 01:52:13.864915 kernel: pci 0000:00:02.5: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.865011 kernel: pci 0000:00:02.5: BAR 0 [mem 0xfea56000-0xfea56fff] Oct 29 01:52:13.865103 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Oct 29 01:52:13.865194 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Oct 29 01:52:13.865285 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Oct 29 01:52:13.865382 kernel: pci 0000:00:02.6: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.865474 kernel: pci 0000:00:02.6: BAR 0 [mem 0xfea57000-0xfea57fff] Oct 29 01:52:13.866542 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Oct 29 01:52:13.867254 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Oct 29 01:52:13.867363 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Oct 29 01:52:13.867466 kernel: pci 0000:00:02.7: [1b36:000c] type 01 class 0x060400 PCIe Root Port Oct 29 01:52:13.867570 kernel: pci 0000:00:02.7: BAR 0 [mem 0xfea58000-0xfea58fff] Oct 29 01:52:13.870714 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Oct 29 01:52:13.870826 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Oct 29 01:52:13.870923 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Oct 29 01:52:13.871031 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Oct 29 01:52:13.871124 kernel: pci 0000:00:03.0: BAR 0 [io 0xc0c0-0xc0df] Oct 29 01:52:13.871217 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfea59000-0xfea59fff] Oct 29 01:52:13.871309 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfd000000-0xfd003fff 64bit pref] Oct 29 01:52:13.871399 kernel: pci 0000:00:03.0: ROM [mem 0xfea00000-0xfea3ffff pref] Oct 29 01:52:13.871504 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Oct 29 01:52:13.872626 kernel: pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] Oct 29 01:52:13.872739 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfea5a000-0xfea5afff] Oct 29 01:52:13.872844 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfd004000-0xfd007fff 64bit pref] Oct 29 01:52:13.872945 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Oct 29 01:52:13.873040 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Oct 29 01:52:13.873138 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Oct 29 01:52:13.873231 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc0e0-0xc0ff] Oct 29 01:52:13.873326 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfea5b000-0xfea5bfff] Oct 29 01:52:13.873423 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Oct 29 01:52:13.873515 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Oct 29 01:52:13.875655 kernel: pci 0000:01:00.0: [1b36:000e] type 01 class 0x060400 PCIe to PCI/PCI-X bridge Oct 29 01:52:13.875760 kernel: pci 0000:01:00.0: BAR 0 [mem 0xfda00000-0xfda000ff 64bit] Oct 29 01:52:13.875863 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Oct 29 01:52:13.875960 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Oct 29 01:52:13.876062 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Oct 29 01:52:13.876173 kernel: pci_bus 0000:02: extended config space not accessible Oct 29 01:52:13.876283 kernel: pci 0000:02:01.0: [8086:25ab] type 00 class 0x088000 conventional PCI endpoint Oct 29 01:52:13.876384 kernel: pci 0000:02:01.0: BAR 0 [mem 0xfd800000-0xfd80000f] Oct 29 01:52:13.876479 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Oct 29 01:52:13.880623 kernel: pci 0000:03:00.0: [1b36:000d] type 00 class 0x0c0330 PCIe Endpoint Oct 29 01:52:13.880743 kernel: pci 0000:03:00.0: BAR 0 [mem 0xfe800000-0xfe803fff 64bit] Oct 29 01:52:13.880858 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Oct 29 01:52:13.880966 kernel: pci 0000:04:00.0: [1af4:1044] type 00 class 0x00ff00 PCIe Endpoint Oct 29 01:52:13.881065 kernel: pci 0000:04:00.0: BAR 4 [mem 0xfca00000-0xfca03fff 64bit pref] Oct 29 01:52:13.881160 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Oct 29 01:52:13.881256 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Oct 29 01:52:13.881352 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Oct 29 01:52:13.881450 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Oct 29 01:52:13.881542 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Oct 29 01:52:13.881644 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Oct 29 01:52:13.881658 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 29 01:52:13.881668 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 29 01:52:13.881679 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 29 01:52:13.881688 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 29 01:52:13.881703 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Oct 29 01:52:13.881726 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Oct 29 01:52:13.881741 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Oct 29 01:52:13.881757 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Oct 29 01:52:13.881774 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Oct 29 01:52:13.881795 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Oct 29 01:52:13.881812 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Oct 29 01:52:13.881826 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Oct 29 01:52:13.881843 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Oct 29 01:52:13.881859 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Oct 29 01:52:13.881879 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Oct 29 01:52:13.881893 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Oct 29 01:52:13.881907 kernel: iommu: Default domain type: Translated Oct 29 01:52:13.881917 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 29 01:52:13.881926 kernel: PCI: Using ACPI for IRQ routing Oct 29 01:52:13.881936 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 29 01:52:13.881946 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Oct 29 01:52:13.881955 kernel: e820: reserve RAM buffer [mem 0x7ffdc000-0x7fffffff] Oct 29 01:52:13.882050 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Oct 29 01:52:13.882146 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Oct 29 01:52:13.882238 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 29 01:52:13.882251 kernel: vgaarb: loaded Oct 29 01:52:13.882261 kernel: clocksource: Switched to clocksource kvm-clock Oct 29 01:52:13.882271 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 01:52:13.882281 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 01:52:13.882290 kernel: pnp: PnP ACPI init Oct 29 01:52:13.882390 kernel: system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved Oct 29 01:52:13.882407 kernel: pnp: PnP ACPI: found 5 devices Oct 29 01:52:13.882417 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 29 01:52:13.882427 kernel: NET: Registered PF_INET protocol family Oct 29 01:52:13.882437 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 01:52:13.882446 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 29 01:52:13.882456 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 29 01:52:13.882466 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 29 01:52:13.882476 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Oct 29 01:52:13.882485 kernel: TCP: Hash tables configured (established 16384 bind 16384) Oct 29 01:52:13.882498 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 29 01:52:13.882507 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 29 01:52:13.882517 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 29 01:52:13.882527 kernel: NET: Registered PF_XDP protocol family Oct 29 01:52:13.885671 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x0fff] to [bus 01-02] add_size 1000 Oct 29 01:52:13.885789 kernel: pci 0000:00:02.1: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Oct 29 01:52:13.885888 kernel: pci 0000:00:02.2: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Oct 29 01:52:13.885985 kernel: pci 0000:00:02.3: bridge window [io 0x1000-0x0fff] to [bus 05] add_size 1000 Oct 29 01:52:13.886089 kernel: pci 0000:00:02.4: bridge window [io 0x1000-0x0fff] to [bus 06] add_size 1000 Oct 29 01:52:13.886184 kernel: pci 0000:00:02.5: bridge window [io 0x1000-0x0fff] to [bus 07] add_size 1000 Oct 29 01:52:13.886278 kernel: pci 0000:00:02.6: bridge window [io 0x1000-0x0fff] to [bus 08] add_size 1000 Oct 29 01:52:13.886372 kernel: pci 0000:00:02.7: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 Oct 29 01:52:13.886464 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff]: assigned Oct 29 01:52:13.886595 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff]: assigned Oct 29 01:52:13.886693 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff]: assigned Oct 29 01:52:13.886794 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff]: assigned Oct 29 01:52:13.886891 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff]: assigned Oct 29 01:52:13.886984 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff]: assigned Oct 29 01:52:13.887077 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff]: assigned Oct 29 01:52:13.887169 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff]: assigned Oct 29 01:52:13.887269 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Oct 29 01:52:13.887365 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Oct 29 01:52:13.887459 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Oct 29 01:52:13.887550 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff] Oct 29 01:52:13.887655 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Oct 29 01:52:13.887754 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Oct 29 01:52:13.887855 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Oct 29 01:52:13.887949 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff] Oct 29 01:52:13.888059 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Oct 29 01:52:13.888263 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Oct 29 01:52:13.888427 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Oct 29 01:52:13.888519 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff] Oct 29 01:52:13.890724 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Oct 29 01:52:13.890848 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Oct 29 01:52:13.890961 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Oct 29 01:52:13.891067 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff] Oct 29 01:52:13.891161 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Oct 29 01:52:13.891253 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Oct 29 01:52:13.891356 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Oct 29 01:52:13.891450 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff] Oct 29 01:52:13.891542 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Oct 29 01:52:13.891693 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Oct 29 01:52:13.891796 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Oct 29 01:52:13.891890 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff] Oct 29 01:52:13.891987 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Oct 29 01:52:13.892079 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Oct 29 01:52:13.892172 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Oct 29 01:52:13.892265 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff] Oct 29 01:52:13.892359 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Oct 29 01:52:13.892451 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Oct 29 01:52:13.892544 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Oct 29 01:52:13.892655 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff] Oct 29 01:52:13.892748 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Oct 29 01:52:13.892848 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Oct 29 01:52:13.892944 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 29 01:52:13.893028 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 29 01:52:13.893112 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 29 01:52:13.893195 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] Oct 29 01:52:13.893279 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Oct 29 01:52:13.893361 kernel: pci_bus 0000:00: resource 9 [mem 0x20c0000000-0x28bfffffff window] Oct 29 01:52:13.893459 kernel: pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] Oct 29 01:52:13.893551 kernel: pci_bus 0000:01: resource 1 [mem 0xfd800000-0xfdbfffff] Oct 29 01:52:13.893650 kernel: pci_bus 0000:01: resource 2 [mem 0xfce00000-0xfcffffff 64bit pref] Oct 29 01:52:13.893747 kernel: pci_bus 0000:02: resource 1 [mem 0xfd800000-0xfd9fffff] Oct 29 01:52:13.893852 kernel: pci_bus 0000:03: resource 0 [io 0x2000-0x2fff] Oct 29 01:52:13.893941 kernel: pci_bus 0000:03: resource 1 [mem 0xfe800000-0xfe9fffff] Oct 29 01:52:13.894028 kernel: pci_bus 0000:03: resource 2 [mem 0xfcc00000-0xfcdfffff 64bit pref] Oct 29 01:52:13.894127 kernel: pci_bus 0000:04: resource 0 [io 0x3000-0x3fff] Oct 29 01:52:13.894219 kernel: pci_bus 0000:04: resource 1 [mem 0xfe600000-0xfe7fffff] Oct 29 01:52:13.894306 kernel: pci_bus 0000:04: resource 2 [mem 0xfca00000-0xfcbfffff 64bit pref] Oct 29 01:52:13.894398 kernel: pci_bus 0000:05: resource 0 [io 0x4000-0x4fff] Oct 29 01:52:13.894485 kernel: pci_bus 0000:05: resource 1 [mem 0xfe400000-0xfe5fffff] Oct 29 01:52:13.894600 kernel: pci_bus 0000:05: resource 2 [mem 0xfc800000-0xfc9fffff 64bit pref] Oct 29 01:52:13.894693 kernel: pci_bus 0000:06: resource 0 [io 0x5000-0x5fff] Oct 29 01:52:13.894788 kernel: pci_bus 0000:06: resource 1 [mem 0xfe200000-0xfe3fffff] Oct 29 01:52:13.894879 kernel: pci_bus 0000:06: resource 2 [mem 0xfc600000-0xfc7fffff 64bit pref] Oct 29 01:52:13.894971 kernel: pci_bus 0000:07: resource 0 [io 0x6000-0x6fff] Oct 29 01:52:13.895057 kernel: pci_bus 0000:07: resource 1 [mem 0xfe000000-0xfe1fffff] Oct 29 01:52:13.895143 kernel: pci_bus 0000:07: resource 2 [mem 0xfc400000-0xfc5fffff 64bit pref] Oct 29 01:52:13.895238 kernel: pci_bus 0000:08: resource 0 [io 0x7000-0x7fff] Oct 29 01:52:13.895325 kernel: pci_bus 0000:08: resource 1 [mem 0xfde00000-0xfdffffff] Oct 29 01:52:13.895413 kernel: pci_bus 0000:08: resource 2 [mem 0xfc200000-0xfc3fffff 64bit pref] Oct 29 01:52:13.895505 kernel: pci_bus 0000:09: resource 0 [io 0x8000-0x8fff] Oct 29 01:52:13.895605 kernel: pci_bus 0000:09: resource 1 [mem 0xfdc00000-0xfddfffff] Oct 29 01:52:13.895691 kernel: pci_bus 0000:09: resource 2 [mem 0xfc000000-0xfc1fffff 64bit pref] Oct 29 01:52:13.895705 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Oct 29 01:52:13.895717 kernel: PCI: CLS 0 bytes, default 64 Oct 29 01:52:13.895727 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 29 01:52:13.895738 kernel: software IO TLB: mapped [mem 0x0000000079800000-0x000000007d800000] (64MB) Oct 29 01:52:13.895753 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Oct 29 01:52:13.895764 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2113312ac93, max_idle_ns: 440795244843 ns Oct 29 01:52:13.895774 kernel: Initialise system trusted keyrings Oct 29 01:52:13.895792 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Oct 29 01:52:13.895802 kernel: Key type asymmetric registered Oct 29 01:52:13.895812 kernel: Asymmetric key parser 'x509' registered Oct 29 01:52:13.895826 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 29 01:52:13.895836 kernel: io scheduler mq-deadline registered Oct 29 01:52:13.895847 kernel: io scheduler kyber registered Oct 29 01:52:13.895860 kernel: io scheduler bfq registered Oct 29 01:52:13.895960 kernel: pcieport 0000:00:02.0: PME: Signaling with IRQ 24 Oct 29 01:52:13.896056 kernel: pcieport 0000:00:02.0: AER: enabled with IRQ 24 Oct 29 01:52:13.896152 kernel: pcieport 0000:00:02.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.896246 kernel: pcieport 0000:00:02.1: PME: Signaling with IRQ 25 Oct 29 01:52:13.896340 kernel: pcieport 0000:00:02.1: AER: enabled with IRQ 25 Oct 29 01:52:13.896433 kernel: pcieport 0000:00:02.1: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.896530 kernel: pcieport 0000:00:02.2: PME: Signaling with IRQ 26 Oct 29 01:52:13.896646 kernel: pcieport 0000:00:02.2: AER: enabled with IRQ 26 Oct 29 01:52:13.896740 kernel: pcieport 0000:00:02.2: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.896846 kernel: pcieport 0000:00:02.3: PME: Signaling with IRQ 27 Oct 29 01:52:13.896939 kernel: pcieport 0000:00:02.3: AER: enabled with IRQ 27 Oct 29 01:52:13.897031 kernel: pcieport 0000:00:02.3: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.897130 kernel: pcieport 0000:00:02.4: PME: Signaling with IRQ 28 Oct 29 01:52:13.897223 kernel: pcieport 0000:00:02.4: AER: enabled with IRQ 28 Oct 29 01:52:13.897316 kernel: pcieport 0000:00:02.4: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.897409 kernel: pcieport 0000:00:02.5: PME: Signaling with IRQ 29 Oct 29 01:52:13.897502 kernel: pcieport 0000:00:02.5: AER: enabled with IRQ 29 Oct 29 01:52:13.897625 kernel: pcieport 0000:00:02.5: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.897728 kernel: pcieport 0000:00:02.6: PME: Signaling with IRQ 30 Oct 29 01:52:13.897829 kernel: pcieport 0000:00:02.6: AER: enabled with IRQ 30 Oct 29 01:52:13.897922 kernel: pcieport 0000:00:02.6: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.898013 kernel: pcieport 0000:00:02.7: PME: Signaling with IRQ 31 Oct 29 01:52:13.898107 kernel: pcieport 0000:00:02.7: AER: enabled with IRQ 31 Oct 29 01:52:13.898200 kernel: pcieport 0000:00:02.7: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 29 01:52:13.898219 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 29 01:52:13.898230 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Oct 29 01:52:13.898242 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Oct 29 01:52:13.898252 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 01:52:13.898263 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 29 01:52:13.898273 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 29 01:52:13.898284 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 29 01:52:13.898295 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 29 01:52:13.898400 kernel: rtc_cmos 00:03: RTC can wake from S4 Oct 29 01:52:13.898415 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 29 01:52:13.898500 kernel: rtc_cmos 00:03: registered as rtc0 Oct 29 01:52:13.898606 kernel: rtc_cmos 00:03: setting system clock to 2025-10-29T01:52:13 UTC (1761702733) Oct 29 01:52:13.898692 kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Oct 29 01:52:13.898705 kernel: intel_pstate: CPU model not supported Oct 29 01:52:13.898716 kernel: NET: Registered PF_INET6 protocol family Oct 29 01:52:13.898726 kernel: Segment Routing with IPv6 Oct 29 01:52:13.898741 kernel: In-situ OAM (IOAM) with IPv6 Oct 29 01:52:13.898751 kernel: NET: Registered PF_PACKET protocol family Oct 29 01:52:13.898761 kernel: Key type dns_resolver registered Oct 29 01:52:13.898772 kernel: IPI shorthand broadcast: enabled Oct 29 01:52:13.898800 kernel: sched_clock: Marking stable (3213005541, 119580984)->(3475852137, -143265612) Oct 29 01:52:13.898811 kernel: registered taskstats version 1 Oct 29 01:52:13.898821 kernel: Loading compiled-in X.509 certificates Oct 29 01:52:13.898832 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: 91bfdda5569887ee7cf726e5260755a94abb2fda' Oct 29 01:52:13.898842 kernel: Demotion targets for Node 0: null Oct 29 01:52:13.898855 kernel: Key type .fscrypt registered Oct 29 01:52:13.898865 kernel: Key type fscrypt-provisioning registered Oct 29 01:52:13.898875 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 01:52:13.898885 kernel: ima: Allocated hash algorithm: sha1 Oct 29 01:52:13.898895 kernel: ima: No architecture policies found Oct 29 01:52:13.898906 kernel: clk: Disabling unused clocks Oct 29 01:52:13.898916 kernel: Warning: unable to open an initial console. Oct 29 01:52:13.898927 kernel: Freeing unused kernel image (initmem) memory: 45548K Oct 29 01:52:13.898937 kernel: Write protecting the kernel read-only data: 40960k Oct 29 01:52:13.898950 kernel: Freeing unused kernel image (rodata/data gap) memory: 576K Oct 29 01:52:13.898960 kernel: Run /init as init process Oct 29 01:52:13.898970 kernel: with arguments: Oct 29 01:52:13.898981 kernel: /init Oct 29 01:52:13.898990 kernel: with environment: Oct 29 01:52:13.899000 kernel: HOME=/ Oct 29 01:52:13.899010 kernel: TERM=linux Oct 29 01:52:13.899022 systemd[1]: Successfully made /usr/ read-only. Oct 29 01:52:13.899036 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 29 01:52:13.899050 systemd[1]: Detected virtualization kvm. Oct 29 01:52:13.899061 systemd[1]: Detected architecture x86-64. Oct 29 01:52:13.899071 systemd[1]: Running in initrd. Oct 29 01:52:13.899081 systemd[1]: No hostname configured, using default hostname. Oct 29 01:52:13.899092 systemd[1]: Hostname set to . Oct 29 01:52:13.899103 systemd[1]: Initializing machine ID from VM UUID. Oct 29 01:52:13.899113 systemd[1]: Queued start job for default target initrd.target. Oct 29 01:52:13.899127 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 01:52:13.899138 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 01:52:13.899150 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 29 01:52:13.899161 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 29 01:52:13.899172 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 29 01:52:13.899183 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 29 01:52:13.899195 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 29 01:52:13.899209 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 29 01:52:13.899220 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 01:52:13.899231 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 29 01:52:13.899242 systemd[1]: Reached target paths.target - Path Units. Oct 29 01:52:13.899253 systemd[1]: Reached target slices.target - Slice Units. Oct 29 01:52:13.899263 systemd[1]: Reached target swap.target - Swaps. Oct 29 01:52:13.899274 systemd[1]: Reached target timers.target - Timer Units. Oct 29 01:52:13.899285 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 29 01:52:13.899298 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 29 01:52:13.899309 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 29 01:52:13.899320 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 29 01:52:13.899331 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 29 01:52:13.899342 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 29 01:52:13.899353 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 01:52:13.899364 systemd[1]: Reached target sockets.target - Socket Units. Oct 29 01:52:13.899374 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 29 01:52:13.899385 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 29 01:52:13.899398 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 29 01:52:13.899409 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). Oct 29 01:52:13.899420 systemd[1]: Starting systemd-fsck-usr.service... Oct 29 01:52:13.899431 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 29 01:52:13.899441 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 29 01:52:13.899452 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 01:52:13.899463 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 29 01:52:13.899477 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 01:52:13.899489 systemd[1]: Finished systemd-fsck-usr.service. Oct 29 01:52:13.899536 systemd-journald[208]: Collecting audit messages is disabled. Oct 29 01:52:13.899576 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 29 01:52:13.899588 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 01:52:13.899600 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 29 01:52:13.899610 kernel: Bridge firewalling registered Oct 29 01:52:13.899622 systemd-journald[208]: Journal started Oct 29 01:52:13.899648 systemd-journald[208]: Runtime Journal (/run/log/journal/e291cdcb792147ae8e08fb11214206c9) is 4.7M, max 37.9M, 33.1M free. Oct 29 01:52:13.861637 systemd-modules-load[210]: Inserted module 'overlay' Oct 29 01:52:13.925915 systemd[1]: Started systemd-journald.service - Journal Service. Oct 29 01:52:13.891059 systemd-modules-load[210]: Inserted module 'br_netfilter' Oct 29 01:52:13.927096 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 29 01:52:13.928048 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 01:52:13.931232 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 29 01:52:13.932340 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 29 01:52:13.935683 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 29 01:52:13.939738 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 29 01:52:13.957554 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 29 01:52:13.959282 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 01:52:13.961546 systemd-tmpfiles[227]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 29 01:52:13.969862 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 01:52:13.971762 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 29 01:52:13.975369 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 29 01:52:13.977729 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 29 01:52:14.011696 dracut-cmdline[249]: 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=3712f4aa3d5ecdc33a05d6cb95187265998ea757b06dac816207e4f222678133 Oct 29 01:52:14.023523 systemd-resolved[250]: Positive Trust Anchors: Oct 29 01:52:14.023542 systemd-resolved[250]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 01:52:14.023591 systemd-resolved[250]: 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 Oct 29 01:52:14.030087 systemd-resolved[250]: Defaulting to hostname 'linux'. Oct 29 01:52:14.031613 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 29 01:52:14.032321 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 29 01:52:14.135586 kernel: SCSI subsystem initialized Oct 29 01:52:14.149608 kernel: Loading iSCSI transport class v2.0-870. Oct 29 01:52:14.160604 kernel: iscsi: registered transport (tcp) Oct 29 01:52:14.185923 kernel: iscsi: registered transport (qla4xxx) Oct 29 01:52:14.185988 kernel: QLogic iSCSI HBA Driver Oct 29 01:52:14.208355 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 29 01:52:14.227745 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 29 01:52:14.232553 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 29 01:52:14.296603 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 29 01:52:14.301304 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 29 01:52:14.367676 kernel: raid6: avx512x4 gen() 17293 MB/s Oct 29 01:52:14.383709 kernel: raid6: avx512x2 gen() 17619 MB/s Oct 29 01:52:14.400610 kernel: raid6: avx512x1 gen() 17408 MB/s Oct 29 01:52:14.417764 kernel: raid6: avx2x4 gen() 17548 MB/s Oct 29 01:52:14.434630 kernel: raid6: avx2x2 gen() 17223 MB/s Oct 29 01:52:14.451671 kernel: raid6: avx2x1 gen() 13261 MB/s Oct 29 01:52:14.451830 kernel: raid6: using algorithm avx512x2 gen() 17619 MB/s Oct 29 01:52:14.469759 kernel: raid6: .... xor() 21873 MB/s, rmw enabled Oct 29 01:52:14.469923 kernel: raid6: using avx512x2 recovery algorithm Oct 29 01:52:14.491611 kernel: xor: automatically using best checksumming function avx Oct 29 01:52:14.669596 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 29 01:52:14.684557 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 29 01:52:14.689979 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 01:52:14.722148 systemd-udevd[459]: Using default interface naming scheme 'v255'. Oct 29 01:52:14.728996 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 01:52:14.734825 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 29 01:52:14.765230 dracut-pre-trigger[469]: rd.md=0: removing MD RAID activation Oct 29 01:52:14.807428 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 29 01:52:14.809552 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 29 01:52:14.896108 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 01:52:14.900120 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 29 01:52:14.974891 kernel: ACPI: bus type USB registered Oct 29 01:52:14.974953 kernel: usbcore: registered new interface driver usbfs Oct 29 01:52:14.974968 kernel: usbcore: registered new interface driver hub Oct 29 01:52:14.976593 kernel: usbcore: registered new device driver usb Oct 29 01:52:15.010551 kernel: cryptd: max_cpu_qlen set to 1000 Oct 29 01:52:15.017601 kernel: virtio_blk virtio1: 2/0/0 default/read/poll queues Oct 29 01:52:15.027600 kernel: virtio_blk virtio1: [vda] 125829120 512-byte logical blocks (64.4 GB/60.0 GiB) Oct 29 01:52:15.045197 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Oct 29 01:52:15.045420 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 29 01:52:15.045436 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 1 Oct 29 01:52:15.045574 kernel: GPT:17805311 != 125829119 Oct 29 01:52:15.045589 kernel: xhci_hcd 0000:03:00.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Oct 29 01:52:15.045715 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 29 01:52:15.045728 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Oct 29 01:52:15.045843 kernel: GPT:17805311 != 125829119 Oct 29 01:52:15.045862 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 2 Oct 29 01:52:15.045978 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 29 01:52:15.045991 kernel: xhci_hcd 0000:03:00.0: Host supports USB 3.0 SuperSpeed Oct 29 01:52:15.046105 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 01:52:15.046119 kernel: hub 1-0:1.0: USB hub found Oct 29 01:52:15.051609 kernel: hub 1-0:1.0: 4 ports detected Oct 29 01:52:15.053002 kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Oct 29 01:52:15.053725 kernel: hub 2-0:1.0: USB hub found Oct 29 01:52:15.053888 kernel: hub 2-0:1.0: 4 ports detected Oct 29 01:52:15.059727 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Oct 29 01:52:15.060577 kernel: libata version 3.00 loaded. Oct 29 01:52:15.062059 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 01:52:15.063813 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 01:52:15.072788 kernel: AES CTR mode by8 optimization enabled Oct 29 01:52:15.069439 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 01:52:15.074276 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 01:52:15.076396 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Oct 29 01:52:15.143003 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 29 01:52:15.181385 kernel: ahci 0000:00:1f.2: version 3.0 Oct 29 01:52:15.181596 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Oct 29 01:52:15.181612 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Oct 29 01:52:15.181750 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Oct 29 01:52:15.181863 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Oct 29 01:52:15.181980 kernel: scsi host0: ahci Oct 29 01:52:15.182089 kernel: scsi host1: ahci Oct 29 01:52:15.182187 kernel: scsi host2: ahci Oct 29 01:52:15.182293 kernel: scsi host3: ahci Oct 29 01:52:15.182388 kernel: scsi host4: ahci Oct 29 01:52:15.182485 kernel: scsi host5: ahci Oct 29 01:52:15.182581 kernel: ata1: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b100 irq 41 lpm-pol 1 Oct 29 01:52:15.182619 kernel: ata2: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b180 irq 41 lpm-pol 1 Oct 29 01:52:15.182631 kernel: ata3: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b200 irq 41 lpm-pol 1 Oct 29 01:52:15.182643 kernel: ata4: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b280 irq 41 lpm-pol 1 Oct 29 01:52:15.182658 kernel: ata5: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b300 irq 41 lpm-pol 1 Oct 29 01:52:15.182669 kernel: ata6: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b380 irq 41 lpm-pol 1 Oct 29 01:52:15.181512 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 01:52:15.197924 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 29 01:52:15.204756 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 29 01:52:15.205195 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 29 01:52:15.219287 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 29 01:52:15.221427 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 29 01:52:15.246646 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 01:52:15.247220 disk-uuid[614]: Primary Header is updated. Oct 29 01:52:15.247220 disk-uuid[614]: Secondary Entries is updated. Oct 29 01:52:15.247220 disk-uuid[614]: Secondary Header is updated. Oct 29 01:52:15.291618 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Oct 29 01:52:15.439624 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 01:52:15.467620 kernel: ata1: SATA link down (SStatus 0 SControl 300) Oct 29 01:52:15.471155 kernel: ata3: SATA link down (SStatus 0 SControl 300) Oct 29 01:52:15.471259 kernel: ata2: SATA link down (SStatus 0 SControl 300) Oct 29 01:52:15.475644 kernel: ata5: SATA link down (SStatus 0 SControl 300) Oct 29 01:52:15.475788 kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 29 01:52:15.477859 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 29 01:52:15.494649 kernel: usbcore: registered new interface driver usbhid Oct 29 01:52:15.494771 kernel: usbhid: USB HID core driver Oct 29 01:52:15.500683 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/input3 Oct 29 01:52:15.500785 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 Oct 29 01:52:15.519346 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 29 01:52:15.521046 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 29 01:52:15.521936 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 01:52:15.523076 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 29 01:52:15.525498 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 29 01:52:15.555203 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 29 01:52:16.260629 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 01:52:16.262583 disk-uuid[615]: The operation has completed successfully. Oct 29 01:52:16.310421 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 01:52:16.310546 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 29 01:52:16.345352 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 29 01:52:16.367188 sh[640]: Success Oct 29 01:52:16.391704 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 29 01:52:16.391763 kernel: device-mapper: uevent: version 1.0.3 Oct 29 01:52:16.391778 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 29 01:52:16.403587 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 29 01:52:16.443409 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 29 01:52:16.446398 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 29 01:52:16.458865 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 29 01:52:16.468576 kernel: BTRFS: device fsid dd0044f5-e677-42ed-8e54-50bf9e096c5c devid 1 transid 38 /dev/mapper/usr (253:0) scanned by mount (653) Oct 29 01:52:16.471180 kernel: BTRFS info (device dm-0): first mount of filesystem dd0044f5-e677-42ed-8e54-50bf9e096c5c Oct 29 01:52:16.471213 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 29 01:52:16.477696 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 29 01:52:16.477740 kernel: BTRFS info (device dm-0): enabling free space tree Oct 29 01:52:16.479878 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 29 01:52:16.480705 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 29 01:52:16.481384 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 29 01:52:16.483692 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 29 01:52:16.484735 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 29 01:52:16.510614 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (685) Oct 29 01:52:16.514142 kernel: BTRFS info (device vda6): first mount of filesystem b1f50962-01a2-418c-81c4-4f4695f5a8b8 Oct 29 01:52:16.514186 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 29 01:52:16.518655 kernel: BTRFS info (device vda6): turning on async discard Oct 29 01:52:16.518694 kernel: BTRFS info (device vda6): enabling free space tree Oct 29 01:52:16.525609 kernel: BTRFS info (device vda6): last unmount of filesystem b1f50962-01a2-418c-81c4-4f4695f5a8b8 Oct 29 01:52:16.526233 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 29 01:52:16.527881 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 29 01:52:16.646461 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 29 01:52:16.649756 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 29 01:52:16.696268 systemd-networkd[825]: lo: Link UP Oct 29 01:52:16.696278 systemd-networkd[825]: lo: Gained carrier Oct 29 01:52:16.698693 systemd-networkd[825]: Enumeration completed Oct 29 01:52:16.699039 systemd-networkd[825]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 29 01:52:16.699043 systemd-networkd[825]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 29 01:52:16.699555 systemd-networkd[825]: eth0: Link UP Oct 29 01:52:16.699869 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 29 01:52:16.700382 systemd[1]: Reached target network.target - Network. Oct 29 01:52:16.702007 systemd-networkd[825]: eth0: Gained carrier Oct 29 01:52:16.702019 systemd-networkd[825]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 29 01:52:16.725301 ignition[732]: Ignition 2.22.0 Oct 29 01:52:16.725318 ignition[732]: Stage: fetch-offline Oct 29 01:52:16.725379 ignition[732]: no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:16.727296 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 29 01:52:16.725389 ignition[732]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:16.730749 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 29 01:52:16.725522 ignition[732]: parsed url from cmdline: "" Oct 29 01:52:16.734991 systemd-networkd[825]: eth0: DHCPv4 address 10.244.101.194/30, gateway 10.244.101.193 acquired from 10.244.101.193 Oct 29 01:52:16.725526 ignition[732]: no config URL provided Oct 29 01:52:16.725532 ignition[732]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 01:52:16.725540 ignition[732]: no config at "/usr/lib/ignition/user.ign" Oct 29 01:52:16.725548 ignition[732]: failed to fetch config: resource requires networking Oct 29 01:52:16.725910 ignition[732]: Ignition finished successfully Oct 29 01:52:16.764011 ignition[834]: Ignition 2.22.0 Oct 29 01:52:16.764028 ignition[834]: Stage: fetch Oct 29 01:52:16.764194 ignition[834]: no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:16.764205 ignition[834]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:16.764300 ignition[834]: parsed url from cmdline: "" Oct 29 01:52:16.764304 ignition[834]: no config URL provided Oct 29 01:52:16.764309 ignition[834]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 01:52:16.764318 ignition[834]: no config at "/usr/lib/ignition/user.ign" Oct 29 01:52:16.764445 ignition[834]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1 Oct 29 01:52:16.764745 ignition[834]: config drive ("/dev/disk/by-label/config-2") not found. Waiting... Oct 29 01:52:16.764777 ignition[834]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting... Oct 29 01:52:16.781340 ignition[834]: GET result: OK Oct 29 01:52:16.782043 ignition[834]: parsing config with SHA512: 241a13360bfeba45afc2c7438b9ec621308a9f8c5badcdfdfa17b782c41ca31b0061502206812559033d669dca5f4bafabdf79fe429e8c0b3d08e4c4309e5647 Oct 29 01:52:16.789983 unknown[834]: fetched base config from "system" Oct 29 01:52:16.789994 unknown[834]: fetched base config from "system" Oct 29 01:52:16.790213 ignition[834]: fetch: fetch complete Oct 29 01:52:16.790001 unknown[834]: fetched user config from "openstack" Oct 29 01:52:16.790219 ignition[834]: fetch: fetch passed Oct 29 01:52:16.790260 ignition[834]: Ignition finished successfully Oct 29 01:52:16.792805 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 29 01:52:16.795811 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 29 01:52:16.840535 ignition[842]: Ignition 2.22.0 Oct 29 01:52:16.840549 ignition[842]: Stage: kargs Oct 29 01:52:16.840718 ignition[842]: no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:16.843509 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 29 01:52:16.840729 ignition[842]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:16.841238 ignition[842]: kargs: kargs passed Oct 29 01:52:16.841279 ignition[842]: Ignition finished successfully Oct 29 01:52:16.846524 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 29 01:52:16.881145 ignition[849]: Ignition 2.22.0 Oct 29 01:52:16.881908 ignition[849]: Stage: disks Oct 29 01:52:16.882421 ignition[849]: no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:16.882885 ignition[849]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:16.883980 ignition[849]: disks: disks passed Oct 29 01:52:16.884403 ignition[849]: Ignition finished successfully Oct 29 01:52:16.886359 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 29 01:52:16.887997 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 29 01:52:16.889337 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 29 01:52:16.891420 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 29 01:52:16.893503 systemd[1]: Reached target sysinit.target - System Initialization. Oct 29 01:52:16.895319 systemd[1]: Reached target basic.target - Basic System. Oct 29 01:52:16.898096 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 29 01:52:16.932086 systemd-fsck[858]: ROOT: clean, 15/1628000 files, 120826/1617920 blocks Oct 29 01:52:16.935717 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 29 01:52:16.938360 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 29 01:52:17.082619 kernel: EXT4-fs (vda9): mounted filesystem 7b83ec89-0aba-47c6-8115-8038ba0fe1ce r/w with ordered data mode. Quota mode: none. Oct 29 01:52:17.085060 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 29 01:52:17.086783 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 29 01:52:17.090192 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 29 01:52:17.092747 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 29 01:52:17.095282 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 29 01:52:17.103692 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent... Oct 29 01:52:17.104169 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 29 01:52:17.104199 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 29 01:52:17.109606 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 29 01:52:17.113579 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (866) Oct 29 01:52:17.116672 kernel: BTRFS info (device vda6): first mount of filesystem b1f50962-01a2-418c-81c4-4f4695f5a8b8 Oct 29 01:52:17.116705 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 29 01:52:17.121230 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 29 01:52:17.127900 kernel: BTRFS info (device vda6): turning on async discard Oct 29 01:52:17.127951 kernel: BTRFS info (device vda6): enabling free space tree Oct 29 01:52:17.131387 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 29 01:52:17.181616 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Oct 29 01:52:17.202669 initrd-setup-root[894]: cut: /sysroot/etc/passwd: No such file or directory Oct 29 01:52:17.209470 initrd-setup-root[901]: cut: /sysroot/etc/group: No such file or directory Oct 29 01:52:17.217874 initrd-setup-root[908]: cut: /sysroot/etc/shadow: No such file or directory Oct 29 01:52:17.227589 initrd-setup-root[915]: cut: /sysroot/etc/gshadow: No such file or directory Oct 29 01:52:17.319908 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 29 01:52:17.321422 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 29 01:52:17.322708 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 29 01:52:17.338609 kernel: BTRFS info (device vda6): last unmount of filesystem b1f50962-01a2-418c-81c4-4f4695f5a8b8 Oct 29 01:52:17.352811 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 29 01:52:17.375748 ignition[984]: INFO : Ignition 2.22.0 Oct 29 01:52:17.375748 ignition[984]: INFO : Stage: mount Oct 29 01:52:17.376828 ignition[984]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:17.376828 ignition[984]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:17.378901 ignition[984]: INFO : mount: mount passed Oct 29 01:52:17.378901 ignition[984]: INFO : Ignition finished successfully Oct 29 01:52:17.381050 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 29 01:52:17.469010 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 29 01:52:18.204622 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Oct 29 01:52:18.705953 systemd-networkd[825]: eth0: Gained IPv6LL Oct 29 01:52:20.210610 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Oct 29 01:52:20.218703 systemd-networkd[825]: eth0: Ignoring DHCPv6 address 2a02:1348:17d:1970:24:19ff:fef4:65c2/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:17d:1970:24:19ff:fef4:65c2/64 assigned by NDisc. Oct 29 01:52:20.218719 systemd-networkd[825]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Oct 29 01:52:24.224738 kernel: /dev/disk/by-label/config-2: Can't lookup blockdev Oct 29 01:52:24.233151 coreos-metadata[868]: Oct 29 01:52:24.233 WARN failed to locate config-drive, using the metadata service API instead Oct 29 01:52:24.257811 coreos-metadata[868]: Oct 29 01:52:24.257 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Oct 29 01:52:24.274433 coreos-metadata[868]: Oct 29 01:52:24.274 INFO Fetch successful Oct 29 01:52:24.275228 coreos-metadata[868]: Oct 29 01:52:24.275 INFO wrote hostname srv-y4k0s.gb1.brightbox.com to /sysroot/etc/hostname Oct 29 01:52:24.277476 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully. Oct 29 01:52:24.277634 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent. Oct 29 01:52:24.280686 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 29 01:52:24.314054 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 29 01:52:24.352602 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1000) Oct 29 01:52:24.356994 kernel: BTRFS info (device vda6): first mount of filesystem b1f50962-01a2-418c-81c4-4f4695f5a8b8 Oct 29 01:52:24.357064 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 29 01:52:24.361852 kernel: BTRFS info (device vda6): turning on async discard Oct 29 01:52:24.361908 kernel: BTRFS info (device vda6): enabling free space tree Oct 29 01:52:24.365888 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 29 01:52:24.411737 ignition[1018]: INFO : Ignition 2.22.0 Oct 29 01:52:24.411737 ignition[1018]: INFO : Stage: files Oct 29 01:52:24.413847 ignition[1018]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:24.413847 ignition[1018]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:24.413847 ignition[1018]: DEBUG : files: compiled without relabeling support, skipping Oct 29 01:52:24.413847 ignition[1018]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 29 01:52:24.413847 ignition[1018]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 29 01:52:24.419547 ignition[1018]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 29 01:52:24.419547 ignition[1018]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 29 01:52:24.419547 ignition[1018]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 29 01:52:24.418192 unknown[1018]: wrote ssh authorized keys file for user: core Oct 29 01:52:24.422775 ignition[1018]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 29 01:52:24.422775 ignition[1018]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 29 01:52:24.422775 ignition[1018]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Oct 29 01:52:24.422775 ignition[1018]: 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" Oct 29 01:52:24.425858 ignition[1018]: 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" Oct 29 01:52:24.425858 ignition[1018]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Oct 29 01:52:24.425858 ignition[1018]: INFO : files: op(6): [started] processing unit "coreos-metadata-sshkeys@.service" Oct 29 01:52:24.427720 ignition[1018]: 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" Oct 29 01:52:24.427720 ignition[1018]: 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" Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(6): [finished] processing unit "coreos-metadata-sshkeys@.service" Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(8): [started] processing unit "etcd-member.service" Oct 29 01:52:24.427720 ignition[1018]: 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" Oct 29 01:52:24.427720 ignition[1018]: 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" Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(8): [finished] processing unit "etcd-member.service" Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(a): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(a): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(b): [started] setting preset to enabled for "etcd-member.service" Oct 29 01:52:24.427720 ignition[1018]: INFO : files: op(b): [finished] setting preset to enabled for "etcd-member.service" Oct 29 01:52:24.434511 ignition[1018]: INFO : files: createResultFile: createFiles: op(c): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 29 01:52:24.434511 ignition[1018]: INFO : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 29 01:52:24.434511 ignition[1018]: INFO : files: files passed Oct 29 01:52:24.436058 ignition[1018]: INFO : Ignition finished successfully Oct 29 01:52:24.436636 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 29 01:52:24.439774 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 29 01:52:24.440895 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 29 01:52:24.451672 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 29 01:52:24.452637 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 29 01:52:24.460193 initrd-setup-root-after-ignition[1047]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 29 01:52:24.461140 initrd-setup-root-after-ignition[1047]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 29 01:52:24.461786 initrd-setup-root-after-ignition[1051]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 29 01:52:24.463613 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 29 01:52:24.464496 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 29 01:52:24.466053 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 29 01:52:24.525008 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 01:52:24.525284 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 29 01:52:24.528057 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 29 01:52:24.529641 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 29 01:52:24.531206 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 29 01:52:24.533456 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 29 01:52:24.587352 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 29 01:52:24.592180 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 29 01:52:24.621602 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 29 01:52:24.623363 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 01:52:24.624366 systemd[1]: Stopped target timers.target - Timer Units. Oct 29 01:52:24.624820 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 01:52:24.624944 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 29 01:52:24.626399 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 29 01:52:24.627033 systemd[1]: Stopped target basic.target - Basic System. Oct 29 01:52:24.628227 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 29 01:52:24.629233 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 29 01:52:24.630283 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 29 01:52:24.631426 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 29 01:52:24.632632 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 29 01:52:24.633690 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 29 01:52:24.634572 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 29 01:52:24.635342 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 29 01:52:24.636151 systemd[1]: Stopped target swap.target - Swaps. Oct 29 01:52:24.636829 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 01:52:24.636951 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 29 01:52:24.637921 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 29 01:52:24.638812 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 01:52:24.639586 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 29 01:52:24.639786 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 01:52:24.640430 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 01:52:24.640580 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 29 01:52:24.641508 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 29 01:52:24.641681 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 29 01:52:24.642609 systemd[1]: ignition-files.service: Deactivated successfully. Oct 29 01:52:24.642706 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 29 01:52:24.645666 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 29 01:52:24.648374 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 01:52:24.648539 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 01:52:24.651069 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 29 01:52:24.652697 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 01:52:24.652820 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 01:52:24.653313 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 01:52:24.653409 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 29 01:52:24.658169 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 01:52:24.658256 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 29 01:52:24.672442 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 29 01:52:24.676886 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 29 01:52:24.677475 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 29 01:52:24.681548 ignition[1071]: INFO : Ignition 2.22.0 Oct 29 01:52:24.681548 ignition[1071]: INFO : Stage: umount Oct 29 01:52:24.682533 ignition[1071]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 29 01:52:24.682533 ignition[1071]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Oct 29 01:52:24.682533 ignition[1071]: INFO : umount: umount passed Oct 29 01:52:24.684893 ignition[1071]: INFO : Ignition finished successfully Oct 29 01:52:24.684395 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 29 01:52:24.684762 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 29 01:52:24.685454 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 29 01:52:24.685502 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 29 01:52:24.685975 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 29 01:52:24.686023 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 29 01:52:24.686726 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 29 01:52:24.686764 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 29 01:52:24.687430 systemd[1]: Stopped target network.target - Network. Oct 29 01:52:24.688138 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 29 01:52:24.688182 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 29 01:52:24.688879 systemd[1]: Stopped target paths.target - Path Units. Oct 29 01:52:24.689528 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 01:52:24.693593 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 01:52:24.694051 systemd[1]: Stopped target slices.target - Slice Units. Oct 29 01:52:24.694912 systemd[1]: Stopped target sockets.target - Socket Units. Oct 29 01:52:24.695684 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 01:52:24.695723 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 29 01:52:24.696370 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 01:52:24.696402 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 29 01:52:24.697053 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 29 01:52:24.697100 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 29 01:52:24.697772 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 29 01:52:24.697818 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 29 01:52:24.698450 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 29 01:52:24.698491 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 29 01:52:24.699548 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 29 01:52:24.700046 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 29 01:52:24.701651 systemd-networkd[825]: eth0: DHCPv6 lease lost Oct 29 01:52:24.702991 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 01:52:24.703116 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 29 01:52:24.708744 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Oct 29 01:52:24.708986 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 01:52:24.710174 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 29 01:52:24.712037 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Oct 29 01:52:24.713917 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 29 01:52:24.714394 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 01:52:24.714439 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 29 01:52:24.716206 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 29 01:52:24.717672 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 29 01:52:24.717727 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 29 01:52:24.719224 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 01:52:24.719665 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 29 01:52:24.721703 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 29 01:52:24.722210 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 29 01:52:24.722616 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 29 01:52:24.722651 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 01:52:24.724704 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 01:52:24.726114 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Oct 29 01:52:24.726174 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Oct 29 01:52:24.735127 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 01:52:24.736855 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 01:52:24.737591 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 01:52:24.737629 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 29 01:52:24.738134 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 29 01:52:24.738164 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 01:52:24.740032 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 01:52:24.740155 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 29 01:52:24.742101 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 01:52:24.742224 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 29 01:52:24.743940 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 01:52:24.744073 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 29 01:52:24.747370 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 29 01:52:24.749736 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 29 01:52:24.749849 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Oct 29 01:52:24.753960 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 01:52:24.754017 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 01:52:24.755592 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 01:52:24.755636 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 01:52:24.757995 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 29 01:52:24.758104 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 29 01:52:24.764955 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 01:52:24.765066 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 29 01:52:24.766179 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 29 01:52:24.767535 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 29 01:52:24.783686 systemd[1]: Switching root. Oct 29 01:52:24.828823 systemd-journald[208]: Journal stopped Oct 29 01:52:25.870369 systemd-journald[208]: Received SIGTERM from PID 1 (systemd). Oct 29 01:52:25.870444 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 01:52:25.870462 kernel: SELinux: policy capability open_perms=1 Oct 29 01:52:25.870480 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 01:52:25.870492 kernel: SELinux: policy capability always_check_network=0 Oct 29 01:52:25.870506 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 01:52:25.870518 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 01:52:25.870533 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 01:52:25.870545 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 29 01:52:25.870566 kernel: SELinux: policy capability userspace_initial_context=0 Oct 29 01:52:25.870582 kernel: audit: type=1403 audit(1761702744.945:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 29 01:52:25.870600 systemd[1]: Successfully loaded SELinux policy in 72.358ms. Oct 29 01:52:25.870621 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 7.915ms. Oct 29 01:52:25.870634 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 29 01:52:25.870647 systemd[1]: Detected virtualization kvm. Oct 29 01:52:25.870658 systemd[1]: Detected architecture x86-64. Oct 29 01:52:25.870670 systemd[1]: Detected first boot. Oct 29 01:52:25.870682 systemd[1]: Hostname set to . Oct 29 01:52:25.870698 systemd[1]: Initializing machine ID from VM UUID. Oct 29 01:52:25.870710 zram_generator::config[1116]: No configuration found. Oct 29 01:52:25.870725 kernel: Guest personality initialized and is inactive Oct 29 01:52:25.870741 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Oct 29 01:52:25.870752 kernel: Initialized host personality Oct 29 01:52:25.870763 kernel: NET: Registered PF_VSOCK protocol family Oct 29 01:52:25.870774 systemd[1]: Populated /etc with preset unit settings. Oct 29 01:52:25.870787 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Oct 29 01:52:25.870800 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 01:52:25.870812 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 29 01:52:25.870826 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 01:52:25.870838 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 29 01:52:25.870850 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 29 01:52:25.870866 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 29 01:52:25.870879 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 29 01:52:25.870890 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 29 01:52:25.870902 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 29 01:52:25.870915 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 29 01:52:25.870937 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 29 01:52:25.870950 systemd[1]: Created slice user.slice - User and Session Slice. Oct 29 01:52:25.870968 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 01:52:25.870983 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 01:52:25.870999 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 29 01:52:25.871014 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 29 01:52:25.871027 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 29 01:52:25.871039 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 29 01:52:25.871051 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 29 01:52:25.871064 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 01:52:25.871080 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 29 01:52:25.871092 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 29 01:52:25.871107 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 29 01:52:25.871120 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 29 01:52:25.871132 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 29 01:52:25.871144 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 01:52:25.871156 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 29 01:52:25.871170 systemd[1]: Reached target slices.target - Slice Units. Oct 29 01:52:25.871183 systemd[1]: Reached target swap.target - Swaps. Oct 29 01:52:25.871194 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 29 01:52:25.871206 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 29 01:52:25.871219 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 29 01:52:25.871233 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 29 01:52:25.871245 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 29 01:52:25.871257 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 01:52:25.871269 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 29 01:52:25.871282 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 29 01:52:25.871293 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 29 01:52:25.871306 systemd[1]: Mounting media.mount - External Media Directory... Oct 29 01:52:25.871318 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:25.871330 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 29 01:52:25.871345 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 29 01:52:25.871357 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 29 01:52:25.871369 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). Oct 29 01:52:25.871381 systemd[1]: Reached target machines.target - Containers. Oct 29 01:52:25.871393 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 29 01:52:25.871406 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 01:52:25.871418 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 29 01:52:25.871430 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 29 01:52:25.871445 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 29 01:52:25.871457 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 29 01:52:25.871469 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 29 01:52:25.871480 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 29 01:52:25.871492 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 29 01:52:25.871504 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 29 01:52:25.871517 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 01:52:25.871529 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 29 01:52:25.871543 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 29 01:52:25.871555 systemd[1]: Stopped systemd-fsck-usr.service. Oct 29 01:52:25.873612 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). Oct 29 01:52:25.873630 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 29 01:52:25.873645 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 29 01:52:25.873659 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 29 01:52:25.873677 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 29 01:52:25.873692 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 29 01:52:25.873706 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 29 01:52:25.873723 systemd[1]: verity-setup.service: Deactivated successfully. Oct 29 01:52:25.873737 systemd[1]: Stopped verity-setup.service. Oct 29 01:52:25.873755 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:25.873772 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 29 01:52:25.873786 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 29 01:52:25.873799 systemd[1]: Mounted media.mount - External Media Directory. Oct 29 01:52:25.873813 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 29 01:52:25.873827 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 29 01:52:25.873841 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 29 01:52:25.873864 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 01:52:25.873877 kernel: loop: module loaded Oct 29 01:52:25.873891 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 01:52:25.873904 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 29 01:52:25.873918 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 29 01:52:25.873940 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 29 01:52:25.873954 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 29 01:52:25.873968 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 29 01:52:25.873982 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 29 01:52:25.873998 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 29 01:52:25.874011 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 29 01:52:25.874025 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 29 01:52:25.874039 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 29 01:52:25.874053 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 29 01:52:25.874066 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 29 01:52:25.874080 kernel: ACPI: bus type drm_connector registered Oct 29 01:52:25.874092 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 29 01:52:25.874113 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 01:52:25.874127 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 29 01:52:25.874148 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 29 01:52:25.874161 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 29 01:52:25.874175 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 29 01:52:25.874217 systemd-journald[1202]: Collecting audit messages is disabled. Oct 29 01:52:25.874245 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 29 01:52:25.874259 systemd-journald[1202]: Journal started Oct 29 01:52:25.874289 systemd-journald[1202]: Runtime Journal (/run/log/journal/e291cdcb792147ae8e08fb11214206c9) is 4.7M, max 37.9M, 33.1M free. Oct 29 01:52:25.557403 systemd[1]: Queued start job for default target multi-user.target. Oct 29 01:52:25.586439 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 29 01:52:25.587252 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 01:52:25.876722 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 29 01:52:25.879608 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 29 01:52:25.883621 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 01:52:25.901293 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 29 01:52:25.901358 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 29 01:52:25.901377 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 29 01:52:25.920196 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 29 01:52:25.920272 systemd[1]: Started systemd-journald.service - Journal Service. Oct 29 01:52:25.935509 kernel: fuse: init (API version 7.41) Oct 29 01:52:25.931661 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 29 01:52:25.933176 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 01:52:25.934623 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 29 01:52:25.945741 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 29 01:52:25.957749 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 29 01:52:25.959347 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 29 01:52:25.982006 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 29 01:52:25.987989 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 29 01:52:26.005576 kernel: loop0: detected capacity change from 0 to 8 Oct 29 01:52:26.006815 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 29 01:52:26.007660 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 29 01:52:26.008243 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 29 01:52:26.012765 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 29 01:52:26.027349 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 29 01:52:26.036597 systemd-journald[1202]: Time spent on flushing to /var/log/journal/e291cdcb792147ae8e08fb11214206c9 is 80.832ms for 1169 entries. Oct 29 01:52:26.036597 systemd-journald[1202]: System Journal (/var/log/journal/e291cdcb792147ae8e08fb11214206c9) is 8M, max 584.8M, 576.8M free. Oct 29 01:52:26.135246 systemd-journald[1202]: Received client request to flush runtime journal. Oct 29 01:52:26.135294 kernel: loop1: detected capacity change from 0 to 128016 Oct 29 01:52:26.135311 kernel: loop2: detected capacity change from 0 to 110984 Oct 29 01:52:26.082639 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 29 01:52:26.093449 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 29 01:52:26.139887 kernel: loop3: detected capacity change from 0 to 8 Oct 29 01:52:26.099365 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 29 01:52:26.128695 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 01:52:26.140653 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 29 01:52:26.150590 kernel: loop4: detected capacity change from 0 to 128016 Oct 29 01:52:26.190597 kernel: loop5: detected capacity change from 0 to 110984 Oct 29 01:52:26.188800 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. Oct 29 01:52:26.188822 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. Oct 29 01:52:26.197222 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 01:52:26.213187 (sd-merge)[1274]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-openstack'. Oct 29 01:52:26.213685 (sd-merge)[1274]: Merged extensions into '/usr'. Oct 29 01:52:26.225609 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 29 01:52:26.230784 systemd[1]: Starting ensure-sysext.service... Oct 29 01:52:26.233694 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 29 01:52:26.261655 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 29 01:52:26.261686 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 29 01:52:26.262035 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 29 01:52:26.262312 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 29 01:52:26.263249 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 01:52:26.263315 systemd[1]: Reload requested from client PID 1279 ('systemctl') (unit ensure-sysext.service)... Oct 29 01:52:26.263331 systemd[1]: Reloading... Oct 29 01:52:26.263521 systemd-tmpfiles[1280]: ACLs are not supported, ignoring. Oct 29 01:52:26.263597 systemd-tmpfiles[1280]: ACLs are not supported, ignoring. Oct 29 01:52:26.267174 systemd-tmpfiles[1280]: Detected autofs mount point /boot during canonicalization of boot. Oct 29 01:52:26.267181 systemd-tmpfiles[1280]: Skipping /boot Oct 29 01:52:26.275357 systemd-tmpfiles[1280]: Detected autofs mount point /boot during canonicalization of boot. Oct 29 01:52:26.275372 systemd-tmpfiles[1280]: Skipping /boot Oct 29 01:52:26.418312 zram_generator::config[1308]: No configuration found. Oct 29 01:52:26.521387 ldconfig[1228]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 29 01:52:26.662350 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 29 01:52:26.662718 systemd[1]: Reloading finished in 398 ms. Oct 29 01:52:26.674968 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 29 01:52:26.691920 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 01:52:26.709992 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 29 01:52:26.713687 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 29 01:52:26.716745 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 29 01:52:26.720263 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 29 01:52:26.722723 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 29 01:52:26.730049 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:26.730249 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 01:52:26.734908 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 29 01:52:26.738930 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 29 01:52:26.754910 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 29 01:52:26.755737 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 01:52:26.755879 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). Oct 29 01:52:26.755995 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:26.763887 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 29 01:52:26.767033 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:26.767235 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 01:52:26.767398 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 01:52:26.767485 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). Oct 29 01:52:26.768056 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:26.773155 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:26.774154 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 01:52:26.776941 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 29 01:52:26.777474 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 01:52:26.777603 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). Oct 29 01:52:26.777750 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 29 01:52:26.782725 systemd[1]: Finished ensure-sysext.service. Oct 29 01:52:26.795665 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 29 01:52:26.799950 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 29 01:52:26.814872 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 29 01:52:26.815939 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 29 01:52:26.817520 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 01:52:26.818396 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 29 01:52:26.820429 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 29 01:52:26.829256 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 29 01:52:26.830610 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 29 01:52:26.835621 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 29 01:52:26.836519 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). Oct 29 01:52:26.848734 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 29 01:52:26.848941 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 29 01:52:26.850183 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 29 01:52:26.860546 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 29 01:52:26.889000 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 29 01:52:26.907841 augenrules[1410]: No rules Oct 29 01:52:26.911819 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 01:52:26.914295 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 29 01:52:26.917738 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 29 01:52:26.921115 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 01:52:26.925739 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 29 01:52:26.950899 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 29 01:52:26.986998 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 29 01:52:26.987520 systemd[1]: Reached target time-set.target - System Time Set. Oct 29 01:52:26.991331 systemd-resolved[1369]: Positive Trust Anchors: Oct 29 01:52:26.991625 systemd-resolved[1369]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 01:52:26.991719 systemd-resolved[1369]: 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 Oct 29 01:52:26.992528 systemd-udevd[1417]: Using default interface naming scheme 'v255'. Oct 29 01:52:26.997389 systemd-resolved[1369]: Using system hostname 'srv-y4k0s.gb1.brightbox.com'. Oct 29 01:52:26.999050 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 29 01:52:27.000143 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 29 01:52:27.015948 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 01:52:27.016665 systemd[1]: Reached target sysinit.target - System Initialization. Oct 29 01:52:27.017304 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 29 01:52:27.019098 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 01:52:27.020418 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Oct 29 01:52:27.021207 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 29 01:52:27.021906 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 29 01:52:27.023627 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 29 01:52:27.024111 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 29 01:52:27.024144 systemd[1]: Reached target paths.target - Path Units. Oct 29 01:52:27.024504 systemd[1]: Reached target timers.target - Timer Units. Oct 29 01:52:27.025867 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 29 01:52:27.028800 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 29 01:52:27.035925 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 29 01:52:27.037648 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 29 01:52:27.039647 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 29 01:52:27.048294 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 29 01:52:27.049989 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 29 01:52:27.055932 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 29 01:52:27.058897 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 29 01:52:27.065756 systemd[1]: Reached target sockets.target - Socket Units. Oct 29 01:52:27.068004 systemd[1]: Reached target basic.target - Basic System. Oct 29 01:52:27.069472 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 29 01:52:27.069503 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 29 01:52:27.074782 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 29 01:52:27.080711 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 29 01:52:27.085759 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 29 01:52:27.092859 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 29 01:52:27.102746 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 29 01:52:27.108798 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 29 01:52:27.109248 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). Oct 29 01:52:27.118727 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Oct 29 01:52:27.127786 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 29 01:52:27.130102 oslogin_cache_refresh[1453]: Refreshing passwd entry cache Oct 29 01:52:27.131592 google_oslogin_nss_cache[1453]: oslogin_cache_refresh[1453]: Refreshing passwd entry cache Oct 29 01:52:27.136601 google_oslogin_nss_cache[1453]: oslogin_cache_refresh[1453]: Failure getting users, quitting Oct 29 01:52:27.136601 google_oslogin_nss_cache[1453]: oslogin_cache_refresh[1453]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 29 01:52:27.136601 google_oslogin_nss_cache[1453]: oslogin_cache_refresh[1453]: Refreshing group entry cache Oct 29 01:52:27.136601 google_oslogin_nss_cache[1453]: oslogin_cache_refresh[1453]: Failure getting groups, quitting Oct 29 01:52:27.136601 google_oslogin_nss_cache[1453]: oslogin_cache_refresh[1453]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 29 01:52:27.133758 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 29 01:52:27.132493 oslogin_cache_refresh[1453]: Failure getting users, quitting Oct 29 01:52:27.132508 oslogin_cache_refresh[1453]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 29 01:52:27.132545 oslogin_cache_refresh[1453]: Refreshing group entry cache Oct 29 01:52:27.133019 oslogin_cache_refresh[1453]: Failure getting groups, quitting Oct 29 01:52:27.133026 oslogin_cache_refresh[1453]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 29 01:52:27.143797 jq[1450]: false Oct 29 01:52:27.144496 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 29 01:52:27.150077 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 29 01:52:27.151815 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 29 01:52:27.153798 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 29 01:52:27.160176 systemd[1]: Starting update-engine.service - Update Engine... Oct 29 01:52:27.170941 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 29 01:52:27.174738 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 29 01:52:27.175487 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 29 01:52:27.175691 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 29 01:52:27.175961 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Oct 29 01:52:27.176136 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Oct 29 01:52:27.198941 jq[1467]: true Oct 29 01:52:27.204632 update_engine[1466]: I20251029 01:52:27.199903 1466 main.cc:92] Flatcar Update Engine starting Oct 29 01:52:27.217795 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 01:52:27.218037 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 29 01:52:27.223730 jq[1476]: true Oct 29 01:52:27.259157 dbus-daemon[1448]: [system] SELinux support is enabled Oct 29 01:52:27.262983 coreos-metadata[1446]: Oct 29 01:52:27.259 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1 Oct 29 01:52:27.259989 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 29 01:52:27.264941 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). Oct 29 01:52:27.265289 coreos-metadata[1446]: Oct 29 01:52:27.264 INFO Failed to fetch: error sending request for url (http://169.254.169.254/latest/meta-data/public-keys) Oct 29 01:52:27.267359 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 29 01:52:27.268658 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). Oct 29 01:52:27.268677 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 29 01:52:27.270880 extend-filesystems[1452]: Found /dev/vda6 Oct 29 01:52:27.273775 systemd[1]: Started update-engine.service - Update Engine. Oct 29 01:52:27.278100 update_engine[1466]: I20251029 01:52:27.277915 1466 update_check_scheduler.cc:74] Next update check in 8m8s Oct 29 01:52:27.281700 extend-filesystems[1452]: Found /dev/vda9 Oct 29 01:52:27.282894 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 29 01:52:27.286692 extend-filesystems[1452]: Checking size of /dev/vda9 Oct 29 01:52:27.294805 coreos-metadata[1447]: Oct 29 01:52:27.294 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1 Oct 29 01:52:27.294805 coreos-metadata[1447]: Oct 29 01:52:27.294 INFO Failed to fetch: error sending request for url (http://169.254.169.254/openstack/2012-08-10/meta_data.json) Oct 29 01:52:27.296468 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 01:52:27.297678 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 29 01:52:27.306914 extend-filesystems[1452]: Resized partition /dev/vda9 Oct 29 01:52:27.307986 extend-filesystems[1500]: resize2fs 1.47.3 (8-Jul-2025) Oct 29 01:52:27.346656 bash[1509]: Updated "/home/core/.ssh/authorized_keys" Oct 29 01:52:27.348024 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 29 01:52:27.351602 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 15121403 blocks Oct 29 01:52:27.354834 systemd[1]: Starting sshkeys.service... Oct 29 01:52:27.370674 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 29 01:52:27.397976 locksmithd[1487]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 29 01:52:27.428906 kernel: EXT4-fs (vda9): resized filesystem to 15121403 Oct 29 01:52:27.433008 extend-filesystems[1500]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 29 01:52:27.433008 extend-filesystems[1500]: old_desc_blocks = 1, new_desc_blocks = 8 Oct 29 01:52:27.433008 extend-filesystems[1500]: The filesystem on /dev/vda9 is now 15121403 (4k) blocks long. Oct 29 01:52:27.439656 extend-filesystems[1452]: Resized filesystem in /dev/vda9 Oct 29 01:52:27.433774 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 01:52:27.434677 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 29 01:52:27.447090 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 29 01:52:27.452646 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 29 01:52:27.524883 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 29 01:52:27.528340 systemd-networkd[1445]: lo: Link UP Oct 29 01:52:27.528347 systemd-networkd[1445]: lo: Gained carrier Oct 29 01:52:27.529284 systemd-networkd[1445]: Enumeration completed Oct 29 01:52:27.529405 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 29 01:52:27.530201 systemd[1]: Reached target network.target - Network. Oct 29 01:52:27.534976 systemd[1]: Starting containerd.service - containerd container runtime... Oct 29 01:52:27.539074 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 29 01:52:27.548800 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 29 01:52:27.565451 systemd-networkd[1445]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 29 01:52:27.565459 systemd-networkd[1445]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 29 01:52:27.567302 systemd-networkd[1445]: eth0: Link UP Oct 29 01:52:27.568080 systemd-networkd[1445]: eth0: Gained carrier Oct 29 01:52:27.568099 systemd-networkd[1445]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 29 01:52:27.581654 systemd-networkd[1445]: eth0: DHCPv4 address 10.244.101.194/30, gateway 10.244.101.193 acquired from 10.244.101.193 Oct 29 01:52:27.582378 dbus-daemon[1448]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.6' (uid=244 pid=1445 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 29 01:52:27.582493 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:27.590776 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 29 01:52:27.608015 kernel: mousedev: PS/2 mouse device common for all mice Oct 29 01:52:27.613148 (ntainerd)[1533]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 29 01:52:27.640711 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 29 01:52:27.671617 systemd-logind[1465]: New seat seat0. Oct 29 01:52:27.678591 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Oct 29 01:52:27.686590 kernel: ACPI: button: Power Button [PWRF] Oct 29 01:52:27.713349 sshd_keygen[1482]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 29 01:52:27.782451 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 29 01:52:27.804843 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 29 01:52:27.805471 systemd[1]: Started systemd-logind.service - User Login Management. Oct 29 01:52:27.816589 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 29 01:52:27.822589 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Oct 29 01:52:27.854557 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 01:52:27.854842 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 29 01:52:27.860019 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 29 01:52:27.884978 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 29 01:52:27.885237 dbus-daemon[1448]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 29 01:52:27.899899 dbus-daemon[1448]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=1532 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 29 01:52:27.908447 systemd[1]: Starting polkit.service - Authorization Manager... Oct 29 01:52:27.925984 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 29 01:52:27.930882 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 29 01:52:27.934065 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 29 01:52:27.935384 systemd[1]: Reached target getty.target - Login Prompts. Oct 29 01:52:28.032698 containerd[1533]: time="2025-10-29T01:52:28Z" 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 Oct 29 01:52:28.032698 containerd[1533]: time="2025-10-29T01:52:28.026134429Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 29 01:52:28.072892 containerd[1533]: time="2025-10-29T01:52:28.072828899Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="80.662µs" Oct 29 01:52:28.072892 containerd[1533]: time="2025-10-29T01:52:28.072882091Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 29 01:52:28.073024 containerd[1533]: time="2025-10-29T01:52:28.072908983Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 29 01:52:28.073156 containerd[1533]: time="2025-10-29T01:52:28.073139188Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 29 01:52:28.073187 containerd[1533]: time="2025-10-29T01:52:28.073161039Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 29 01:52:28.073211 containerd[1533]: time="2025-10-29T01:52:28.073190716Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073289 containerd[1533]: time="2025-10-29T01:52:28.073269509Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073315 containerd[1533]: time="2025-10-29T01:52:28.073289392Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073524 containerd[1533]: time="2025-10-29T01:52:28.073502820Z" 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 Oct 29 01:52:28.073557 containerd[1533]: time="2025-10-29T01:52:28.073524503Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073557 containerd[1533]: time="2025-10-29T01:52:28.073539050Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073557 containerd[1533]: time="2025-10-29T01:52:28.073548865Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073672 containerd[1533]: time="2025-10-29T01:52:28.073646260Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073924 containerd[1533]: time="2025-10-29T01:52:28.073905583Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 29 01:52:28.073956 containerd[1533]: time="2025-10-29T01:52:28.073943153Z" 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 Oct 29 01:52:28.073981 containerd[1533]: time="2025-10-29T01:52:28.073955436Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 29 01:52:28.074004 containerd[1533]: time="2025-10-29T01:52:28.073993561Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 29 01:52:28.074266 containerd[1533]: time="2025-10-29T01:52:28.074243117Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 29 01:52:28.074328 containerd[1533]: time="2025-10-29T01:52:28.074313885Z" level=info msg="metadata content store policy set" policy=shared Oct 29 01:52:28.080547 containerd[1533]: time="2025-10-29T01:52:28.080469029Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 29 01:52:28.080639 containerd[1533]: time="2025-10-29T01:52:28.080614877Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 29 01:52:28.080703 containerd[1533]: time="2025-10-29T01:52:28.080642473Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 29 01:52:28.080743 containerd[1533]: time="2025-10-29T01:52:28.080706962Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 29 01:52:28.080743 containerd[1533]: time="2025-10-29T01:52:28.080737554Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 29 01:52:28.080794 containerd[1533]: time="2025-10-29T01:52:28.080750314Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 29 01:52:28.080794 containerd[1533]: time="2025-10-29T01:52:28.080784198Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 29 01:52:28.080862 containerd[1533]: time="2025-10-29T01:52:28.080801284Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 29 01:52:28.080862 containerd[1533]: time="2025-10-29T01:52:28.080813989Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 29 01:52:28.080862 containerd[1533]: time="2025-10-29T01:52:28.080825502Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 29 01:52:28.080862 containerd[1533]: time="2025-10-29T01:52:28.080835848Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 29 01:52:28.080862 containerd[1533]: time="2025-10-29T01:52:28.080854886Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 29 01:52:28.081029 containerd[1533]: time="2025-10-29T01:52:28.081000551Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 29 01:52:28.081054 containerd[1533]: time="2025-10-29T01:52:28.081044290Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 29 01:52:28.081078 containerd[1533]: time="2025-10-29T01:52:28.081061501Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 29 01:52:28.081105 containerd[1533]: time="2025-10-29T01:52:28.081078709Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 29 01:52:28.081133 containerd[1533]: time="2025-10-29T01:52:28.081101652Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 29 01:52:28.081133 containerd[1533]: time="2025-10-29T01:52:28.081116341Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 29 01:52:28.081181 containerd[1533]: time="2025-10-29T01:52:28.081130726Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 29 01:52:28.081181 containerd[1533]: time="2025-10-29T01:52:28.081143761Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 29 01:52:28.081181 containerd[1533]: time="2025-10-29T01:52:28.081156762Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 29 01:52:28.081181 containerd[1533]: time="2025-10-29T01:52:28.081168665Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 29 01:52:28.081181 containerd[1533]: time="2025-10-29T01:52:28.081180012Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 29 01:52:28.081295 containerd[1533]: time="2025-10-29T01:52:28.081280826Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 29 01:52:28.081320 containerd[1533]: time="2025-10-29T01:52:28.081300291Z" level=info msg="Start snapshots syncer" Oct 29 01:52:28.081675 containerd[1533]: time="2025-10-29T01:52:28.081649945Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 29 01:52:28.083179 containerd[1533]: time="2025-10-29T01:52:28.083126794Z" 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\"}" Oct 29 01:52:28.083392 containerd[1533]: time="2025-10-29T01:52:28.083197964Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 29 01:52:28.086948 containerd[1533]: time="2025-10-29T01:52:28.086833345Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 29 01:52:28.087079 containerd[1533]: time="2025-10-29T01:52:28.087060095Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 29 01:52:28.087114 containerd[1533]: time="2025-10-29T01:52:28.087102121Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 29 01:52:28.087140 containerd[1533]: time="2025-10-29T01:52:28.087119429Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 29 01:52:28.087140 containerd[1533]: time="2025-10-29T01:52:28.087135125Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 29 01:52:28.087199 containerd[1533]: time="2025-10-29T01:52:28.087155643Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 29 01:52:28.087199 containerd[1533]: time="2025-10-29T01:52:28.087173260Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 29 01:52:28.087199 containerd[1533]: time="2025-10-29T01:52:28.087187071Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 29 01:52:28.087264 containerd[1533]: time="2025-10-29T01:52:28.087227206Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 29 01:52:28.087264 containerd[1533]: time="2025-10-29T01:52:28.087242798Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 29 01:52:28.087264 containerd[1533]: time="2025-10-29T01:52:28.087255242Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 29 01:52:28.087349 containerd[1533]: time="2025-10-29T01:52:28.087333178Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 29 01:52:28.087374 containerd[1533]: time="2025-10-29T01:52:28.087358605Z" 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 Oct 29 01:52:28.087446 containerd[1533]: time="2025-10-29T01:52:28.087430368Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 01:52:28.087472 containerd[1533]: time="2025-10-29T01:52:28.087447648Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 01:52:28.087472 containerd[1533]: time="2025-10-29T01:52:28.087457727Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 29 01:52:28.087518 containerd[1533]: time="2025-10-29T01:52:28.087471823Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 29 01:52:28.087518 containerd[1533]: time="2025-10-29T01:52:28.087485050Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 29 01:52:28.087574 containerd[1533]: time="2025-10-29T01:52:28.087538874Z" level=info msg="runtime interface created" Oct 29 01:52:28.087574 containerd[1533]: time="2025-10-29T01:52:28.087548396Z" level=info msg="created NRI interface" Oct 29 01:52:28.087619 containerd[1533]: time="2025-10-29T01:52:28.087581759Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 29 01:52:28.087619 containerd[1533]: time="2025-10-29T01:52:28.087599653Z" level=info msg="Connect containerd service" Oct 29 01:52:28.087669 containerd[1533]: time="2025-10-29T01:52:28.087637019Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 29 01:52:28.100756 containerd[1533]: time="2025-10-29T01:52:28.093302002Z" 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" Oct 29 01:52:28.134412 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 01:52:28.158265 systemd-logind[1465]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 29 01:52:28.224370 polkitd[1565]: Started polkitd version 126 Oct 29 01:52:28.244234 polkitd[1565]: Loading rules from directory /etc/polkit-1/rules.d Oct 29 01:52:28.249026 polkitd[1565]: Loading rules from directory /run/polkit-1/rules.d Oct 29 01:52:28.253576 polkitd[1565]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 29 01:52:28.258006 polkitd[1565]: Loading rules from directory /usr/local/share/polkit-1/rules.d Oct 29 01:52:28.258042 polkitd[1565]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 29 01:52:28.258084 polkitd[1565]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 29 01:52:28.262128 polkitd[1565]: Finished loading, compiling and executing 2 rules Oct 29 01:52:28.262409 systemd[1]: Started polkit.service - Authorization Manager. Oct 29 01:52:28.265738 coreos-metadata[1446]: Oct 29 01:52:28.265 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #2 Oct 29 01:52:28.269539 dbus-daemon[1448]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 29 01:52:28.270548 polkitd[1565]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 29 01:52:28.272092 systemd-logind[1465]: Watching system buttons on /dev/input/event3 (Power Button) Oct 29 01:52:28.294902 coreos-metadata[1446]: Oct 29 01:52:28.294 INFO Fetch successful Oct 29 01:52:28.294902 coreos-metadata[1446]: Oct 29 01:52:28.294 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 29 01:52:28.297986 coreos-metadata[1447]: Oct 29 01:52:28.297 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #2 Oct 29 01:52:28.305848 coreos-metadata[1447]: Oct 29 01:52:28.305 INFO Fetch failed with 404: resource not found Oct 29 01:52:28.306087 coreos-metadata[1447]: Oct 29 01:52:28.306 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Oct 29 01:52:28.308826 coreos-metadata[1447]: Oct 29 01:52:28.308 INFO Fetch successful Oct 29 01:52:28.313775 coreos-metadata[1447]: Oct 29 01:52:28.313 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1 Oct 29 01:52:28.325584 coreos-metadata[1447]: Oct 29 01:52:28.325 INFO Fetch successful Oct 29 01:52:28.325584 coreos-metadata[1447]: Oct 29 01:52:28.325 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1 Oct 29 01:52:28.326593 containerd[1533]: time="2025-10-29T01:52:28.326397655Z" level=info msg="Start subscribing containerd event" Oct 29 01:52:28.326593 containerd[1533]: time="2025-10-29T01:52:28.326450822Z" level=info msg="Start recovering state" Oct 29 01:52:28.326593 containerd[1533]: time="2025-10-29T01:52:28.326542970Z" level=info msg="Start event monitor" Oct 29 01:52:28.326715 containerd[1533]: time="2025-10-29T01:52:28.326705141Z" level=info msg="Start cni network conf syncer for default" Oct 29 01:52:28.326801 containerd[1533]: time="2025-10-29T01:52:28.326790857Z" level=info msg="Start streaming server" Oct 29 01:52:28.326865 containerd[1533]: time="2025-10-29T01:52:28.326855929Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 29 01:52:28.326908 containerd[1533]: time="2025-10-29T01:52:28.326900201Z" level=info msg="runtime interface starting up..." Oct 29 01:52:28.326945 containerd[1533]: time="2025-10-29T01:52:28.326938125Z" level=info msg="starting plugins..." Oct 29 01:52:28.326992 containerd[1533]: time="2025-10-29T01:52:28.326984855Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 29 01:52:28.329764 containerd[1533]: time="2025-10-29T01:52:28.329729227Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 29 01:52:28.330577 containerd[1533]: time="2025-10-29T01:52:28.329876072Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 29 01:52:28.330577 containerd[1533]: time="2025-10-29T01:52:28.329961203Z" level=info msg="containerd successfully booted in 0.308731s" Oct 29 01:52:28.331168 systemd[1]: Started containerd.service - containerd container runtime. Oct 29 01:52:28.331808 coreos-metadata[1446]: Oct 29 01:52:28.331 INFO Fetch successful Oct 29 01:52:28.338442 unknown[1446]: wrote ssh authorized keys file for user: core Oct 29 01:52:28.342606 systemd-hostnamed[1532]: Hostname set to (static) Oct 29 01:52:28.346403 coreos-metadata[1447]: Oct 29 01:52:28.346 INFO Fetch successful Oct 29 01:52:28.347076 coreos-metadata[1447]: Oct 29 01:52:28.347 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1 Oct 29 01:52:28.367674 coreos-metadata[1447]: Oct 29 01:52:28.367 INFO Fetch successful Oct 29 01:52:28.367908 coreos-metadata[1447]: Oct 29 01:52:28.367 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1 Oct 29 01:52:28.389011 coreos-metadata[1447]: Oct 29 01:52:28.388 INFO Fetch successful Oct 29 01:52:28.391929 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 29 01:52:28.394070 update-ssh-keys[1600]: Updated "/home/core/.ssh/authorized_keys" Oct 29 01:52:28.407119 systemd[1]: Started sshd@0-10.244.101.194:22-139.178.89.65:60632.service - OpenSSH per-connection server daemon (139.178.89.65:60632). Oct 29 01:52:28.430268 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 29 01:52:28.456228 systemd[1]: Finished sshkeys.service. Oct 29 01:52:28.498863 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 01:52:28.502509 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 29 01:52:28.503659 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 29 01:52:28.945961 systemd-networkd[1445]: eth0: Gained IPv6LL Oct 29 01:52:28.946695 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:28.951514 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 29 01:52:28.953927 systemd[1]: Reached target network-online.target - Network is Online. Oct 29 01:52:28.957091 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Oct 29 01:52:28.961889 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 29 01:52:28.969911 (-wrapper)[1614]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Oct 29 01:52:28.996188 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 29 01:52:29.127956 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 29 01:52:29.148209 (dockerd)[1633]: 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 Oct 29 01:52:29.367389 sshd[1602]: Accepted publickey for core from 139.178.89.65 port 60632 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:29.369246 sshd-session[1602]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:29.381517 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 29 01:52:29.383881 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 29 01:52:29.399439 systemd-logind[1465]: New session 1 of user core. Oct 29 01:52:29.412220 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 29 01:52:29.416806 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 29 01:52:29.432736 (systemd)[1640]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 29 01:52:29.438890 systemd-logind[1465]: New session c1 of user core. Oct 29 01:52:29.499208 dockerd[1633]: time="2025-10-29T01:52:29.499151967Z" level=info msg="Starting up" Oct 29 01:52:29.500983 dockerd[1633]: time="2025-10-29T01:52:29.500899071Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 29 01:52:29.514467 dockerd[1633]: time="2025-10-29T01:52:29.514336933Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 29 01:52:29.528406 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport262901115-merged.mount: Deactivated successfully. Oct 29 01:52:29.554056 dockerd[1633]: time="2025-10-29T01:52:29.554008073Z" level=info msg="Loading containers: start." Oct 29 01:52:29.564587 kernel: Initializing XFRM netlink socket Oct 29 01:52:29.577616 systemd[1640]: Queued start job for default target default.target. Oct 29 01:52:29.584225 systemd[1640]: Created slice app.slice - User Application Slice. Oct 29 01:52:29.584262 systemd[1640]: Reached target paths.target - Paths. Oct 29 01:52:29.584307 systemd[1640]: Reached target timers.target - Timers. Oct 29 01:52:29.586674 systemd[1640]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 29 01:52:29.599550 systemd[1640]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 29 01:52:29.599701 systemd[1640]: Reached target sockets.target - Sockets. Oct 29 01:52:29.599741 systemd[1640]: Reached target basic.target - Basic System. Oct 29 01:52:29.600012 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 29 01:52:29.600194 systemd[1640]: Reached target default.target - Main User Target. Oct 29 01:52:29.600232 systemd[1640]: Startup finished in 153ms. Oct 29 01:52:29.607725 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 29 01:52:29.821518 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:29.823422 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:29.833172 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:29.833926 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:29.834690 systemd-networkd[1445]: eth0: Ignoring DHCPv6 address 2a02:1348:17d:1970:24:19ff:fef4:65c2/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:17d:1970:24:19ff:fef4:65c2/64 assigned by NDisc. Oct 29 01:52:29.834697 systemd-networkd[1445]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Oct 29 01:52:29.870700 systemd-networkd[1445]: docker0: Link UP Oct 29 01:52:29.871001 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:29.873609 dockerd[1633]: time="2025-10-29T01:52:29.873488180Z" level=info msg="Loading containers: done." Oct 29 01:52:29.893149 dockerd[1633]: time="2025-10-29T01:52:29.893084670Z" 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 Oct 29 01:52:29.893320 dockerd[1633]: time="2025-10-29T01:52:29.893200973Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 29 01:52:29.893358 dockerd[1633]: time="2025-10-29T01:52:29.893324205Z" level=info msg="Initializing buildkit" Oct 29 01:52:29.911891 dockerd[1633]: time="2025-10-29T01:52:29.911856557Z" level=info msg="Completed buildkit initialization" Oct 29 01:52:29.919996 dockerd[1633]: time="2025-10-29T01:52:29.919941954Z" level=info msg="Daemon has completed initialization" Oct 29 01:52:29.920140 dockerd[1633]: time="2025-10-29T01:52:29.920080782Z" level=info msg="API listen on /run/docker.sock" Oct 29 01:52:29.920325 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 29 01:52:29.923065 etcd-wrapper[1622]: Error response from daemon: No such container: etcd-member Oct 29 01:52:29.940805 etcd-wrapper[1843]: Error response from daemon: No such container: etcd-member Oct 29 01:52:29.975168 etcd-wrapper[1861]: Unable to find image 'quay.io/coreos/etcd:v3.5.22' locally Oct 29 01:52:30.408722 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2274494192-merged.mount: Deactivated successfully. Oct 29 01:52:30.676039 systemd[1]: Started sshd@1-10.244.101.194:22-139.178.89.65:60638.service - OpenSSH per-connection server daemon (139.178.89.65:60638). Oct 29 01:52:31.401507 etcd-wrapper[1861]: v3.5.22: Pulling from coreos/etcd Oct 29 01:52:31.506759 systemd-timesyncd[1378]: Network configuration changed, trying to establish connection. Oct 29 01:52:31.617330 sshd[1874]: Accepted publickey for core from 139.178.89.65 port 60638 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:31.620873 sshd-session[1874]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:31.631469 systemd-logind[1465]: New session 2 of user core. Oct 29 01:52:31.642848 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 29 01:52:31.832738 etcd-wrapper[1861]: f5083dc2076d: Pulling fs layer Oct 29 01:52:31.832738 etcd-wrapper[1861]: 2ae710cd8bfe: Pulling fs layer Oct 29 01:52:31.832738 etcd-wrapper[1861]: d462aa345367: Pulling fs layer Oct 29 01:52:31.832738 etcd-wrapper[1861]: 0f8b424aa0b9: Pulling fs layer Oct 29 01:52:31.832738 etcd-wrapper[1861]: d557676654e5: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: c8022d07192e: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: d858cbc252ad: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 1069fc2daed1: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: b40161cd83fc: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 5318d93a3a65: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 307c1adadb60: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 60a82e1b19c6: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 6f77055ebb6e: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 67f98bbc9874: Pulling fs layer Oct 29 01:52:31.835610 etcd-wrapper[1861]: 0f8b424aa0b9: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: d557676654e5: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: c8022d07192e: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: d858cbc252ad: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: 1069fc2daed1: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: b40161cd83fc: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: 5318d93a3a65: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: 307c1adadb60: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: 60a82e1b19c6: Waiting Oct 29 01:52:31.835610 etcd-wrapper[1861]: 6f77055ebb6e: Waiting Oct 29 01:52:31.837147 etcd-wrapper[1861]: 67f98bbc9874: Waiting Oct 29 01:52:32.246808 sshd[1877]: Connection closed by 139.178.89.65 port 60638 Oct 29 01:52:32.248159 sshd-session[1874]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:32.256768 systemd[1]: sshd@1-10.244.101.194:22-139.178.89.65:60638.service: Deactivated successfully. Oct 29 01:52:32.260285 systemd[1]: session-2.scope: Deactivated successfully. Oct 29 01:52:32.262354 systemd-logind[1465]: Session 2 logged out. Waiting for processes to exit. Oct 29 01:52:32.264573 systemd-logind[1465]: Removed session 2. Oct 29 01:52:32.355028 etcd-wrapper[1861]: 2ae710cd8bfe: Verifying Checksum Oct 29 01:52:32.355308 etcd-wrapper[1861]: 2ae710cd8bfe: Download complete Oct 29 01:52:32.387612 etcd-wrapper[1861]: d462aa345367: Verifying Checksum Oct 29 01:52:32.387612 etcd-wrapper[1861]: d462aa345367: Download complete Oct 29 01:52:32.405724 etcd-wrapper[1861]: f5083dc2076d: Verifying Checksum Oct 29 01:52:32.405724 etcd-wrapper[1861]: f5083dc2076d: Download complete Oct 29 01:52:32.411065 systemd[1]: Started sshd@2-10.244.101.194:22-139.178.89.65:60652.service - OpenSSH per-connection server daemon (139.178.89.65:60652). Oct 29 01:52:32.455098 etcd-wrapper[1861]: f5083dc2076d: Pull complete Oct 29 01:52:32.475949 systemd[1]: var-lib-docker-overlay2-844855761a4bfeb68b1eda7ad7a62e08d5fc1a783ddeda6b4107f340bdfacafe-merged.mount: Deactivated successfully. Oct 29 01:52:32.483367 etcd-wrapper[1861]: 2ae710cd8bfe: Pull complete Oct 29 01:52:32.726704 etcd-wrapper[1861]: 0f8b424aa0b9: Verifying Checksum Oct 29 01:52:32.726704 etcd-wrapper[1861]: 0f8b424aa0b9: Download complete Oct 29 01:52:32.750175 etcd-wrapper[1861]: d557676654e5: Verifying Checksum Oct 29 01:52:32.750175 etcd-wrapper[1861]: d557676654e5: Download complete Oct 29 01:52:32.898570 systemd[1]: var-lib-docker-overlay2-f9d46ecc18711554a850b5b09b5026a568bb6986d9d40f0fd5b73c4998bd562a-merged.mount: Deactivated successfully. Oct 29 01:52:32.929401 etcd-wrapper[1861]: d462aa345367: Pull complete Oct 29 01:52:32.933106 etcd-wrapper[1861]: c8022d07192e: Verifying Checksum Oct 29 01:52:32.933287 etcd-wrapper[1861]: c8022d07192e: Download complete Oct 29 01:52:32.949340 etcd-wrapper[1861]: 0f8b424aa0b9: Pull complete Oct 29 01:52:32.984088 etcd-wrapper[1861]: d557676654e5: Pull complete Oct 29 01:52:33.009759 etcd-wrapper[1861]: c8022d07192e: Pull complete Oct 29 01:52:33.023283 login[1568]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 29 01:52:33.031827 systemd-logind[1465]: New session 3 of user core. Oct 29 01:52:33.032228 login[1567]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 29 01:52:33.035923 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 29 01:52:33.044513 systemd-logind[1465]: New session 4 of user core. Oct 29 01:52:33.051766 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 29 01:52:33.107379 etcd-wrapper[1861]: d858cbc252ad: Download complete Oct 29 01:52:33.129752 etcd-wrapper[1861]: d858cbc252ad: Pull complete Oct 29 01:52:33.145689 etcd-wrapper[1861]: 1069fc2daed1: Download complete Oct 29 01:52:33.161063 etcd-wrapper[1861]: 1069fc2daed1: Pull complete Oct 29 01:52:33.327684 etcd-wrapper[1861]: b40161cd83fc: Verifying Checksum Oct 29 01:52:33.327684 etcd-wrapper[1861]: b40161cd83fc: Download complete Oct 29 01:52:33.333053 sshd[1886]: Accepted publickey for core from 139.178.89.65 port 60652 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:33.338752 sshd-session[1886]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:33.348202 systemd-logind[1465]: New session 5 of user core. Oct 29 01:52:33.356151 etcd-wrapper[1861]: b40161cd83fc: Pull complete Oct 29 01:52:33.355787 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 29 01:52:33.464732 systemd[1]: var-lib-docker-overlay2-aa8699765b1c74bc4ad34b4d3959f3e6665fae5d5f096f37544126f189d74a74-merged.mount: Deactivated successfully. Oct 29 01:52:33.484062 etcd-wrapper[1861]: 5318d93a3a65: Verifying Checksum Oct 29 01:52:33.484062 etcd-wrapper[1861]: 5318d93a3a65: Download complete Oct 29 01:52:33.493431 etcd-wrapper[1861]: 307c1adadb60: Verifying Checksum Oct 29 01:52:33.493431 etcd-wrapper[1861]: 307c1adadb60: Download complete Oct 29 01:52:33.506662 systemd[1]: var-lib-docker-overlay2-5e6d88e00ef4fdfba383261cd47c6011a55ca62c2538c067ca10e7786e3b0951-merged.mount: Deactivated successfully. Oct 29 01:52:33.516294 etcd-wrapper[1861]: 5318d93a3a65: Pull complete Oct 29 01:52:33.532798 systemd[1]: var-lib-docker-overlay2-c1fdee0a86b8aef5191b58077ba12d5aa083bbfe10819886c8496e8b2e692fca-merged.mount: Deactivated successfully. Oct 29 01:52:33.544062 etcd-wrapper[1861]: 307c1adadb60: Pull complete Oct 29 01:52:33.843859 etcd-wrapper[1861]: 60a82e1b19c6: Verifying Checksum Oct 29 01:52:33.843859 etcd-wrapper[1861]: 60a82e1b19c6: Download complete Oct 29 01:52:33.981125 sshd[1960]: Connection closed by 139.178.89.65 port 60652 Oct 29 01:52:33.982074 sshd-session[1886]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:33.988217 systemd[1]: sshd@2-10.244.101.194:22-139.178.89.65:60652.service: Deactivated successfully. Oct 29 01:52:33.992168 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 01:52:33.995044 systemd-logind[1465]: Session 5 logged out. Waiting for processes to exit. Oct 29 01:52:33.998693 systemd-logind[1465]: Removed session 5. Oct 29 01:52:34.092276 etcd-wrapper[1861]: 6f77055ebb6e: Verifying Checksum Oct 29 01:52:34.092276 etcd-wrapper[1861]: 6f77055ebb6e: Download complete Oct 29 01:52:34.216392 etcd-wrapper[1861]: 60a82e1b19c6: Pull complete Oct 29 01:52:34.352115 etcd-wrapper[1861]: 67f98bbc9874: Verifying Checksum Oct 29 01:52:34.352115 etcd-wrapper[1861]: 67f98bbc9874: Download complete Oct 29 01:52:34.399280 etcd-wrapper[1861]: 6f77055ebb6e: Pull complete Oct 29 01:52:34.552270 systemd[1]: var-lib-docker-overlay2-0a06492c917eb6b8b76e7aa569b60556c83c84d45da09dc2e80ee0a6e506b811-merged.mount: Deactivated successfully. Oct 29 01:52:34.561669 etcd-wrapper[1861]: 67f98bbc9874: Pull complete Oct 29 01:52:34.566186 etcd-wrapper[1861]: Digest: sha256:51efcfc4f3a863c072ebe745942f790878c2a268e713a6d140c4f2593271adc6 Oct 29 01:52:34.567395 etcd-wrapper[1861]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.22 Oct 29 01:52:34.590924 systemd[1]: var-lib-docker-overlay2-bec5ed682f010f1288664d8d7f369d8dd1e9726a1c7b98415e5959eb138c0a4b-merged.mount: Deactivated successfully. Oct 29 01:52:34.622801 containerd[1533]: time="2025-10-29T01:52:34.622738807Z" level=info msg="connecting to shim 2ec59fb0bcbad4dd4c2dec1b4d53f2d9cd1a43f3e119ba4386d2b54022a64506" address="unix:///run/containerd/s/ea034a0c3573ba1664f9f03df826d19cffc745cd040d003497c44e6f5a1e4632" namespace=moby protocol=ttrpc version=3 Oct 29 01:52:34.649754 systemd[1]: Started docker-2ec59fb0bcbad4dd4c2dec1b4d53f2d9cd1a43f3e119ba4386d2b54022a64506.scope - libcontainer container 2ec59fb0bcbad4dd4c2dec1b4d53f2d9cd1a43f3e119ba4386d2b54022a64506. Oct 29 01:52:34.725958 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.725459Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.725937Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"e291cdcb792147ae8e08fb11214206c9"} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.726007Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.726026Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.22"} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.726096Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.726122Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.726210Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 29 01:52:34.726413 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.726246Z","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.244.101.194:2379"]} Oct 29 01:52:34.726777 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.726399Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 29 01:52:34.726777 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.726433Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Oct 29 01:52:34.727256 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.727152Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Oct 29 01:52:34.727587 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.727447Z","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":"e291cdcb792147ae8e08fb11214206c9","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.244.101.194:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"e291cdcb792147ae8e08fb11214206c9=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"} Oct 29 01:52:34.729784 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.729639Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.766478ms"} Oct 29 01:52:34.731376 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.731216Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Oct 29 01:52:34.732062 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.731605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Oct 29 01:52:34.732062 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.731666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Oct 29 01:52:34.732062 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.731680Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Oct 29 01:52:34.732062 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.731690Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Oct 29 01:52:34.732062 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.731735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Oct 29 01:52:34.732910 etcd-wrapper[1861]: {"level":"warn","ts":"2025-10-29T01:52:34.732802Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Oct 29 01:52:34.734456 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.733695Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Oct 29 01:52:34.734456 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.733755Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Oct 29 01:52:34.734456 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.734109Z","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"} Oct 29 01:52:34.734897 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.734800Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.22","cluster-version":"to_be_decided"} Oct 29 01:52:34.735260 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735156Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 29 01:52:34.735933 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735263Z","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"} Oct 29 01:52:34.735933 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735363Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Oct 29 01:52:34.735933 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735392Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Oct 29 01:52:34.735933 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735422Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Oct 29 01:52:34.735933 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735590Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Oct 29 01:52:34.735933 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.735656Z","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} Oct 29 01:52:34.737195 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.737073Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Oct 29 01:52:34.737326 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.737157Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Oct 29 01:52:34.737326 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:34.737102Z","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.244.101.194:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Oct 29 01:52:35.333650 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.332941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Oct 29 01:52:35.333650 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.333020Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Oct 29 01:52:35.334218 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.333134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Oct 29 01:52:35.334218 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.333174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Oct 29 01:52:35.334218 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.333324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Oct 29 01:52:35.334218 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.333350Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Oct 29 01:52:35.334218 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.333403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Oct 29 01:52:35.336126 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.335198Z","caller":"etcdserver/server.go:2144","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:e291cdcb792147ae8e08fb11214206c9 ClientURLs:[http://10.244.101.194:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Oct 29 01:52:35.338068 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.335620Z","caller":"etcdserver/server.go:2697","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Oct 29 01:52:35.338068 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.335657Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Oct 29 01:52:35.338068 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.336671Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Oct 29 01:52:35.338068 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.336786Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Oct 29 01:52:35.338068 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.336830Z","caller":"etcdserver/server.go:2721","msg":"cluster version is updated","cluster-version":"3.5"} Oct 29 01:52:35.338068 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.337081Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Oct 29 01:52:35.339691 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.337731Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Oct 29 01:52:35.339691 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.337757Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 29 01:52:35.338821 systemd[1]: Started etcd-member.service - etcd (System Application Container). Oct 29 01:52:35.340360 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 29 01:52:35.340593 systemd[1]: Startup finished in 3.282s (kernel) + 11.294s (initrd) + 10.465s (userspace) = 25.041s. Oct 29 01:52:35.341717 etcd-wrapper[1861]: {"level":"info","ts":"2025-10-29T01:52:35.340843Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Oct 29 01:52:44.151668 systemd[1]: Started sshd@3-10.244.101.194:22-139.178.89.65:34552.service - OpenSSH per-connection server daemon (139.178.89.65:34552). Oct 29 01:52:45.075248 sshd[2043]: Accepted publickey for core from 139.178.89.65 port 34552 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:45.078008 sshd-session[2043]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:45.090236 systemd-logind[1465]: New session 6 of user core. Oct 29 01:52:45.099764 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 29 01:52:45.700743 sshd[2046]: Connection closed by 139.178.89.65 port 34552 Oct 29 01:52:45.701358 sshd-session[2043]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:45.705773 systemd[1]: sshd@3-10.244.101.194:22-139.178.89.65:34552.service: Deactivated successfully. Oct 29 01:52:45.708427 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 01:52:45.710154 systemd-logind[1465]: Session 6 logged out. Waiting for processes to exit. Oct 29 01:52:45.711220 systemd-logind[1465]: Removed session 6. Oct 29 01:52:45.862091 systemd[1]: Started sshd@4-10.244.101.194:22-139.178.89.65:34554.service - OpenSSH per-connection server daemon (139.178.89.65:34554). Oct 29 01:52:46.787113 sshd[2052]: Accepted publickey for core from 139.178.89.65 port 34554 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:46.789505 sshd-session[2052]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:46.799619 systemd-logind[1465]: New session 7 of user core. Oct 29 01:52:46.808751 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 29 01:52:47.406961 sshd[2055]: Connection closed by 139.178.89.65 port 34554 Oct 29 01:52:47.408186 sshd-session[2052]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:47.416042 systemd-logind[1465]: Session 7 logged out. Waiting for processes to exit. Oct 29 01:52:47.417175 systemd[1]: sshd@4-10.244.101.194:22-139.178.89.65:34554.service: Deactivated successfully. Oct 29 01:52:47.420061 systemd[1]: session-7.scope: Deactivated successfully. Oct 29 01:52:47.424271 systemd-logind[1465]: Removed session 7. Oct 29 01:52:47.574087 systemd[1]: Started sshd@5-10.244.101.194:22-139.178.89.65:37912.service - OpenSSH per-connection server daemon (139.178.89.65:37912). Oct 29 01:52:48.507060 sshd[2061]: Accepted publickey for core from 139.178.89.65 port 37912 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:48.509980 sshd-session[2061]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:48.522269 systemd-logind[1465]: New session 8 of user core. Oct 29 01:52:48.527734 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 29 01:52:49.137536 sshd[2064]: Connection closed by 139.178.89.65 port 37912 Oct 29 01:52:49.137118 sshd-session[2061]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:49.146227 systemd[1]: sshd@5-10.244.101.194:22-139.178.89.65:37912.service: Deactivated successfully. Oct 29 01:52:49.149132 systemd[1]: session-8.scope: Deactivated successfully. Oct 29 01:52:49.151200 systemd-logind[1465]: Session 8 logged out. Waiting for processes to exit. Oct 29 01:52:49.153079 systemd-logind[1465]: Removed session 8. Oct 29 01:52:49.302006 systemd[1]: Started sshd@6-10.244.101.194:22-139.178.89.65:37920.service - OpenSSH per-connection server daemon (139.178.89.65:37920). Oct 29 01:52:50.236281 sshd[2070]: Accepted publickey for core from 139.178.89.65 port 37920 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:50.240329 sshd-session[2070]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:50.247857 systemd-logind[1465]: New session 9 of user core. Oct 29 01:52:50.252751 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 29 01:52:50.876876 sshd[2073]: Connection closed by 139.178.89.65 port 37920 Oct 29 01:52:50.878157 sshd-session[2070]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:50.886045 systemd[1]: sshd@6-10.244.101.194:22-139.178.89.65:37920.service: Deactivated successfully. Oct 29 01:52:50.889068 systemd[1]: session-9.scope: Deactivated successfully. Oct 29 01:52:50.890414 systemd-logind[1465]: Session 9 logged out. Waiting for processes to exit. Oct 29 01:52:50.892455 systemd-logind[1465]: Removed session 9. Oct 29 01:52:51.040324 systemd[1]: Started sshd@7-10.244.101.194:22-139.178.89.65:37926.service - OpenSSH per-connection server daemon (139.178.89.65:37926). Oct 29 01:52:52.016416 sshd[2081]: Accepted publickey for core from 139.178.89.65 port 37926 ssh2: RSA SHA256:sgCGT7mzKyAzDNTSlib3uMut8JKbh4aZejpu3o6+5zg Oct 29 01:52:52.019385 sshd-session[2081]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 01:52:52.031264 systemd-logind[1465]: New session 10 of user core. Oct 29 01:52:52.048942 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 29 01:52:52.748386 sshd[2084]: Connection closed by 139.178.89.65 port 37926 Oct 29 01:52:52.748766 sshd-session[2081]: pam_unix(sshd:session): session closed for user core Oct 29 01:52:52.756240 systemd[1]: sshd@7-10.244.101.194:22-139.178.89.65:37926.service: Deactivated successfully. Oct 29 01:52:52.758442 systemd[1]: session-10.scope: Deactivated successfully. Oct 29 01:52:52.759637 systemd-logind[1465]: Session 10 logged out. Waiting for processes to exit. Oct 29 01:52:52.761254 systemd-logind[1465]: Removed session 10. Oct 29 01:52:59.877631 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 29 01:53:01.871884 systemd-timesyncd[1378]: Contacted time server [2a02:6b67:d551:8f04::]:123 (2.flatcar.pool.ntp.org). Oct 29 01:53:01.872048 systemd-timesyncd[1378]: Initial clock synchronization to Wed 2025-10-29 01:53:01.782271 UTC. Oct 29 01:53:12.312654 update_engine[1466]: I20251029 01:53:12.311334 1466 update_attempter.cc:509] Updating boot flags... Oct 29 01:55:37.745634 systemd[1]: Started sshd@8-10.244.101.194:22-185.156.73.233:37148.service - OpenSSH per-connection server daemon (185.156.73.233:37148). Oct 29 01:55:38.879054 sshd[2118]: Connection closed by authenticating user root 185.156.73.233 port 37148 [preauth] Oct 29 01:55:38.882084 systemd[1]: sshd@8-10.244.101.194:22-185.156.73.233:37148.service: Deactivated successfully.