Sep 5 10:21:12.879022 kernel: Linux version 6.12.44-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 Fri Sep 5 07:50:50 -00 2025 Sep 5 10:21:12.879043 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=6565e4838e9026a77c427757b65255e9d0c230437ba8dd02b51abe96f219f6d3 Sep 5 10:21:12.879054 kernel: BIOS-provided physical RAM map: Sep 5 10:21:12.879061 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Sep 5 10:21:12.879068 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Sep 5 10:21:12.879074 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Sep 5 10:21:12.879082 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Sep 5 10:21:12.879089 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Sep 5 10:21:12.879098 kernel: BIOS-e820: [mem 0x000000000080c000-0x0000000000810fff] usable Sep 5 10:21:12.879107 kernel: BIOS-e820: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Sep 5 10:21:12.879113 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009bd3efff] usable Sep 5 10:21:12.879119 kernel: BIOS-e820: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Sep 5 10:21:12.879126 kernel: BIOS-e820: [mem 0x000000009be00000-0x000000009c8ecfff] usable Sep 5 10:21:12.879132 kernel: BIOS-e820: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Sep 5 10:21:12.879140 kernel: BIOS-e820: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Sep 5 10:21:12.879149 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Sep 5 10:21:12.879156 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009ce90fff] usable Sep 5 10:21:12.879163 kernel: BIOS-e820: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Sep 5 10:21:12.879170 kernel: BIOS-e820: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Sep 5 10:21:12.879176 kernel: BIOS-e820: [mem 0x000000009ce97000-0x000000009cedbfff] usable Sep 5 10:21:12.879183 kernel: BIOS-e820: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Sep 5 10:21:12.879190 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Sep 5 10:21:12.879197 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Sep 5 10:21:12.879203 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 5 10:21:12.879210 kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Sep 5 10:21:12.879219 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Sep 5 10:21:12.879225 kernel: NX (Execute Disable) protection: active Sep 5 10:21:12.879232 kernel: APIC: Static calls initialized Sep 5 10:21:12.879239 kernel: e820: update [mem 0x9b320018-0x9b329c57] usable ==> usable Sep 5 10:21:12.879246 kernel: e820: update [mem 0x9b2e3018-0x9b31fe57] usable ==> usable Sep 5 10:21:12.879253 kernel: extended physical RAM map: Sep 5 10:21:12.879259 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable Sep 5 10:21:12.879272 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable Sep 5 10:21:12.879279 kernel: reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Sep 5 10:21:12.879286 kernel: reserve setup_data: [mem 0x0000000000808000-0x000000000080afff] usable Sep 5 10:21:12.879293 kernel: reserve setup_data: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Sep 5 10:21:12.879302 kernel: reserve setup_data: [mem 0x000000000080c000-0x0000000000810fff] usable Sep 5 10:21:12.879309 kernel: reserve setup_data: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Sep 5 10:21:12.879320 kernel: reserve setup_data: [mem 0x0000000000900000-0x000000009b2e3017] usable Sep 5 10:21:12.879345 kernel: reserve setup_data: [mem 0x000000009b2e3018-0x000000009b31fe57] usable Sep 5 10:21:12.879356 kernel: reserve setup_data: [mem 0x000000009b31fe58-0x000000009b320017] usable Sep 5 10:21:12.879372 kernel: reserve setup_data: [mem 0x000000009b320018-0x000000009b329c57] usable Sep 5 10:21:12.879381 kernel: reserve setup_data: [mem 0x000000009b329c58-0x000000009bd3efff] usable Sep 5 10:21:12.879390 kernel: reserve setup_data: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Sep 5 10:21:12.879397 kernel: reserve setup_data: [mem 0x000000009be00000-0x000000009c8ecfff] usable Sep 5 10:21:12.879404 kernel: reserve setup_data: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Sep 5 10:21:12.879411 kernel: reserve setup_data: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Sep 5 10:21:12.879418 kernel: reserve setup_data: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Sep 5 10:21:12.879426 kernel: reserve setup_data: [mem 0x000000009cbff000-0x000000009ce90fff] usable Sep 5 10:21:12.879433 kernel: reserve setup_data: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Sep 5 10:21:12.879440 kernel: reserve setup_data: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Sep 5 10:21:12.879447 kernel: reserve setup_data: [mem 0x000000009ce97000-0x000000009cedbfff] usable Sep 5 10:21:12.879456 kernel: reserve setup_data: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Sep 5 10:21:12.879463 kernel: reserve setup_data: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Sep 5 10:21:12.879470 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Sep 5 10:21:12.879477 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 5 10:21:12.879485 kernel: reserve setup_data: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Sep 5 10:21:12.879492 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Sep 5 10:21:12.879502 kernel: efi: EFI v2.7 by EDK II Sep 5 10:21:12.879520 kernel: efi: SMBIOS=0x9c988000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b9e4198 RNG=0x9cb73018 Sep 5 10:21:12.879528 kernel: random: crng init done Sep 5 10:21:12.879535 kernel: efi: Remove mem151: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map Sep 5 10:21:12.879543 kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved Sep 5 10:21:12.879552 kernel: secureboot: Secure boot disabled Sep 5 10:21:12.879567 kernel: SMBIOS 2.8 present. Sep 5 10:21:12.879575 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Sep 5 10:21:12.879590 kernel: DMI: Memory slots populated: 1/1 Sep 5 10:21:12.879598 kernel: Hypervisor detected: KVM Sep 5 10:21:12.879613 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 5 10:21:12.879620 kernel: kvm-clock: using sched offset of 4151960801 cycles Sep 5 10:21:12.879643 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 5 10:21:12.879651 kernel: tsc: Detected 2794.748 MHz processor Sep 5 10:21:12.879659 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 5 10:21:12.879666 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 5 10:21:12.879677 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 Sep 5 10:21:12.879685 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Sep 5 10:21:12.879692 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 5 10:21:12.879700 kernel: Using GB pages for direct mapping Sep 5 10:21:12.879707 kernel: ACPI: Early table checksum verification disabled Sep 5 10:21:12.879723 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Sep 5 10:21:12.879731 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Sep 5 10:21:12.879741 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 10:21:12.879785 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 10:21:12.879806 kernel: ACPI: FACS 0x000000009CBDD000 000040 Sep 5 10:21:12.879817 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 10:21:12.879825 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 10:21:12.879832 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 10:21:12.879842 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 10:21:12.879849 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Sep 5 10:21:12.879857 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Sep 5 10:21:12.879864 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Sep 5 10:21:12.879871 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Sep 5 10:21:12.879881 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Sep 5 10:21:12.879888 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Sep 5 10:21:12.879896 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Sep 5 10:21:12.879903 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Sep 5 10:21:12.879910 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Sep 5 10:21:12.879917 kernel: No NUMA configuration found Sep 5 10:21:12.879924 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cedbfff] Sep 5 10:21:12.879931 kernel: NODE_DATA(0) allocated [mem 0x9ce36dc0-0x9ce3dfff] Sep 5 10:21:12.879939 kernel: Zone ranges: Sep 5 10:21:12.879948 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 5 10:21:12.879955 kernel: DMA32 [mem 0x0000000001000000-0x000000009cedbfff] Sep 5 10:21:12.879962 kernel: Normal empty Sep 5 10:21:12.879969 kernel: Device empty Sep 5 10:21:12.879977 kernel: Movable zone start for each node Sep 5 10:21:12.879984 kernel: Early memory node ranges Sep 5 10:21:12.879991 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Sep 5 10:21:12.879998 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Sep 5 10:21:12.880005 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Sep 5 10:21:12.880015 kernel: node 0: [mem 0x000000000080c000-0x0000000000810fff] Sep 5 10:21:12.880022 kernel: node 0: [mem 0x0000000000900000-0x000000009bd3efff] Sep 5 10:21:12.880029 kernel: node 0: [mem 0x000000009be00000-0x000000009c8ecfff] Sep 5 10:21:12.880036 kernel: node 0: [mem 0x000000009cbff000-0x000000009ce90fff] Sep 5 10:21:12.880043 kernel: node 0: [mem 0x000000009ce97000-0x000000009cedbfff] Sep 5 10:21:12.880051 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cedbfff] Sep 5 10:21:12.880058 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 5 10:21:12.880069 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Sep 5 10:21:12.880088 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Sep 5 10:21:12.880095 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 5 10:21:12.880103 kernel: On node 0, zone DMA: 239 pages in unavailable ranges Sep 5 10:21:12.880111 kernel: On node 0, zone DMA32: 193 pages in unavailable ranges Sep 5 10:21:12.880120 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Sep 5 10:21:12.880129 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Sep 5 10:21:12.880136 kernel: On node 0, zone DMA32: 12580 pages in unavailable ranges Sep 5 10:21:12.880144 kernel: ACPI: PM-Timer IO Port: 0x608 Sep 5 10:21:12.880151 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 5 10:21:12.880161 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 5 10:21:12.880168 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 5 10:21:12.880176 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 5 10:21:12.880183 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 5 10:21:12.880191 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 5 10:21:12.880198 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 5 10:21:12.880206 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 5 10:21:12.880213 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 5 10:21:12.880221 kernel: TSC deadline timer available Sep 5 10:21:12.880231 kernel: CPU topo: Max. logical packages: 1 Sep 5 10:21:12.880238 kernel: CPU topo: Max. logical dies: 1 Sep 5 10:21:12.880246 kernel: CPU topo: Max. dies per package: 1 Sep 5 10:21:12.880253 kernel: CPU topo: Max. threads per core: 1 Sep 5 10:21:12.880260 kernel: CPU topo: Num. cores per package: 4 Sep 5 10:21:12.880268 kernel: CPU topo: Num. threads per package: 4 Sep 5 10:21:12.880275 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Sep 5 10:21:12.880283 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Sep 5 10:21:12.880290 kernel: kvm-guest: KVM setup pv remote TLB flush Sep 5 10:21:12.880298 kernel: kvm-guest: setup PV sched yield Sep 5 10:21:12.880307 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Sep 5 10:21:12.880315 kernel: Booting paravirtualized kernel on KVM Sep 5 10:21:12.880322 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 5 10:21:12.880354 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Sep 5 10:21:12.880362 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Sep 5 10:21:12.880377 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Sep 5 10:21:12.880384 kernel: pcpu-alloc: [0] 0 1 2 3 Sep 5 10:21:12.880392 kernel: kvm-guest: PV spinlocks enabled Sep 5 10:21:12.880400 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 5 10:21:12.880411 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=6565e4838e9026a77c427757b65255e9d0c230437ba8dd02b51abe96f219f6d3 Sep 5 10:21:12.880420 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 5 10:21:12.880427 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 5 10:21:12.880435 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 5 10:21:12.880443 kernel: Fallback order for Node 0: 0 Sep 5 10:21:12.880450 kernel: Built 1 zonelists, mobility grouping on. Total pages: 641450 Sep 5 10:21:12.880458 kernel: Policy zone: DMA32 Sep 5 10:21:12.880465 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 5 10:21:12.880475 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 5 10:21:12.880483 kernel: ftrace: allocating 40102 entries in 157 pages Sep 5 10:21:12.880491 kernel: ftrace: allocated 157 pages with 5 groups Sep 5 10:21:12.880498 kernel: Dynamic Preempt: voluntary Sep 5 10:21:12.880506 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 5 10:21:12.880514 kernel: rcu: RCU event tracing is enabled. Sep 5 10:21:12.880522 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 5 10:21:12.880529 kernel: Trampoline variant of Tasks RCU enabled. Sep 5 10:21:12.880537 kernel: Rude variant of Tasks RCU enabled. Sep 5 10:21:12.880547 kernel: Tracing variant of Tasks RCU enabled. Sep 5 10:21:12.880554 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 5 10:21:12.880565 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 5 10:21:12.880572 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 10:21:12.880580 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 10:21:12.880588 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 10:21:12.880596 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Sep 5 10:21:12.880603 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 5 10:21:12.880611 kernel: Console: colour dummy device 80x25 Sep 5 10:21:12.880620 kernel: printk: legacy console [ttyS0] enabled Sep 5 10:21:12.880628 kernel: ACPI: Core revision 20240827 Sep 5 10:21:12.880636 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 5 10:21:12.880643 kernel: APIC: Switch to symmetric I/O mode setup Sep 5 10:21:12.880650 kernel: x2apic enabled Sep 5 10:21:12.880658 kernel: APIC: Switched APIC routing to: physical x2apic Sep 5 10:21:12.880665 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Sep 5 10:21:12.880673 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Sep 5 10:21:12.880681 kernel: kvm-guest: setup PV IPIs Sep 5 10:21:12.880690 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 5 10:21:12.880698 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Sep 5 10:21:12.880705 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Sep 5 10:21:12.880713 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 5 10:21:12.880720 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Sep 5 10:21:12.880728 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Sep 5 10:21:12.880737 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 5 10:21:12.880747 kernel: Spectre V2 : Mitigation: Retpolines Sep 5 10:21:12.880757 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 5 10:21:12.880769 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Sep 5 10:21:12.880777 kernel: active return thunk: retbleed_return_thunk Sep 5 10:21:12.880784 kernel: RETBleed: Mitigation: untrained return thunk Sep 5 10:21:12.880792 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Sep 5 10:21:12.880800 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Sep 5 10:21:12.880807 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Sep 5 10:21:12.880816 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Sep 5 10:21:12.880823 kernel: active return thunk: srso_return_thunk Sep 5 10:21:12.880833 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Sep 5 10:21:12.880841 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 5 10:21:12.880848 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 5 10:21:12.880856 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 5 10:21:12.880863 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 5 10:21:12.880871 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Sep 5 10:21:12.880878 kernel: Freeing SMP alternatives memory: 32K Sep 5 10:21:12.880886 kernel: pid_max: default: 32768 minimum: 301 Sep 5 10:21:12.880898 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 5 10:21:12.880911 kernel: landlock: Up and running. Sep 5 10:21:12.880919 kernel: SELinux: Initializing. Sep 5 10:21:12.880926 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 10:21:12.880934 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 10:21:12.880942 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Sep 5 10:21:12.880949 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Sep 5 10:21:12.880959 kernel: ... version: 0 Sep 5 10:21:12.880967 kernel: ... bit width: 48 Sep 5 10:21:12.880974 kernel: ... generic registers: 6 Sep 5 10:21:12.880984 kernel: ... value mask: 0000ffffffffffff Sep 5 10:21:12.880991 kernel: ... max period: 00007fffffffffff Sep 5 10:21:12.880999 kernel: ... fixed-purpose events: 0 Sep 5 10:21:12.881006 kernel: ... event mask: 000000000000003f Sep 5 10:21:12.881014 kernel: signal: max sigframe size: 1776 Sep 5 10:21:12.881021 kernel: rcu: Hierarchical SRCU implementation. Sep 5 10:21:12.881029 kernel: rcu: Max phase no-delay instances is 400. Sep 5 10:21:12.881039 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 5 10:21:12.881047 kernel: smp: Bringing up secondary CPUs ... Sep 5 10:21:12.881056 kernel: smpboot: x86: Booting SMP configuration: Sep 5 10:21:12.881063 kernel: .... node #0, CPUs: #1 #2 #3 Sep 5 10:21:12.881071 kernel: smp: Brought up 1 node, 4 CPUs Sep 5 10:21:12.881079 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Sep 5 10:21:12.881087 kernel: Memory: 2422676K/2565800K available (14336K kernel code, 2428K rwdata, 9988K rodata, 54160K init, 2808K bss, 137196K reserved, 0K cma-reserved) Sep 5 10:21:12.881094 kernel: devtmpfs: initialized Sep 5 10:21:12.881102 kernel: x86/mm: Memory block size: 128MB Sep 5 10:21:12.881109 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Sep 5 10:21:12.881117 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Sep 5 10:21:12.881127 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00811000-0x008fffff] (978944 bytes) Sep 5 10:21:12.881135 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Sep 5 10:21:12.881142 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9ce95000-0x9ce96fff] (8192 bytes) Sep 5 10:21:12.881150 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Sep 5 10:21:12.881162 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 5 10:21:12.881170 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 5 10:21:12.881178 kernel: pinctrl core: initialized pinctrl subsystem Sep 5 10:21:12.881185 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 5 10:21:12.881193 kernel: audit: initializing netlink subsys (disabled) Sep 5 10:21:12.881203 kernel: audit: type=2000 audit(1757067670.715:1): state=initialized audit_enabled=0 res=1 Sep 5 10:21:12.881210 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 5 10:21:12.881218 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 5 10:21:12.881225 kernel: cpuidle: using governor menu Sep 5 10:21:12.881233 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 5 10:21:12.881240 kernel: dca service started, version 1.12.1 Sep 5 10:21:12.881248 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Sep 5 10:21:12.881256 kernel: PCI: Using configuration type 1 for base access Sep 5 10:21:12.881263 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 5 10:21:12.881273 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 5 10:21:12.881280 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 5 10:21:12.881288 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 5 10:21:12.881296 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 5 10:21:12.881307 kernel: ACPI: Added _OSI(Module Device) Sep 5 10:21:12.881322 kernel: ACPI: Added _OSI(Processor Device) Sep 5 10:21:12.881375 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 5 10:21:12.881390 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 5 10:21:12.881398 kernel: ACPI: Interpreter enabled Sep 5 10:21:12.881408 kernel: ACPI: PM: (supports S0 S3 S5) Sep 5 10:21:12.881415 kernel: ACPI: Using IOAPIC for interrupt routing Sep 5 10:21:12.881423 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 5 10:21:12.881431 kernel: PCI: Using E820 reservations for host bridge windows Sep 5 10:21:12.881439 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Sep 5 10:21:12.881446 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 5 10:21:12.882541 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 5 10:21:12.882779 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Sep 5 10:21:12.882962 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Sep 5 10:21:12.882982 kernel: PCI host bridge to bus 0000:00 Sep 5 10:21:12.883155 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 5 10:21:12.883308 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 5 10:21:12.883491 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 5 10:21:12.883644 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Sep 5 10:21:12.883791 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Sep 5 10:21:12.883943 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Sep 5 10:21:12.884089 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 5 10:21:12.884286 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Sep 5 10:21:12.884552 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Sep 5 10:21:12.884720 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Sep 5 10:21:12.884882 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Sep 5 10:21:12.885053 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Sep 5 10:21:12.885215 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 5 10:21:12.885482 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 5 10:21:12.885678 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Sep 5 10:21:12.885887 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Sep 5 10:21:12.886079 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Sep 5 10:21:12.886259 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Sep 5 10:21:12.886461 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Sep 5 10:21:12.886632 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Sep 5 10:21:12.886800 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Sep 5 10:21:12.886991 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Sep 5 10:21:12.887167 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Sep 5 10:21:12.887353 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Sep 5 10:21:12.887549 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Sep 5 10:21:12.887850 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Sep 5 10:21:12.888024 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Sep 5 10:21:12.888184 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Sep 5 10:21:12.888390 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Sep 5 10:21:12.888562 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Sep 5 10:21:12.888728 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Sep 5 10:21:12.888912 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Sep 5 10:21:12.889085 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Sep 5 10:21:12.889104 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Sep 5 10:21:12.889120 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 5 10:21:12.889132 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 5 10:21:12.889149 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Sep 5 10:21:12.889162 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Sep 5 10:21:12.889175 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Sep 5 10:21:12.889206 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Sep 5 10:21:12.889228 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Sep 5 10:21:12.889246 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Sep 5 10:21:12.889266 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Sep 5 10:21:12.889282 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Sep 5 10:21:12.889294 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Sep 5 10:21:12.889306 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Sep 5 10:21:12.889319 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Sep 5 10:21:12.889348 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Sep 5 10:21:12.889372 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Sep 5 10:21:12.889385 kernel: iommu: Default domain type: Translated Sep 5 10:21:12.889397 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 5 10:21:12.889410 kernel: efivars: Registered efivars operations Sep 5 10:21:12.889422 kernel: PCI: Using ACPI for IRQ routing Sep 5 10:21:12.889435 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 5 10:21:12.889448 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Sep 5 10:21:12.889460 kernel: e820: reserve RAM buffer [mem 0x00811000-0x008fffff] Sep 5 10:21:12.889472 kernel: e820: reserve RAM buffer [mem 0x9b2e3018-0x9bffffff] Sep 5 10:21:12.889487 kernel: e820: reserve RAM buffer [mem 0x9b320018-0x9bffffff] Sep 5 10:21:12.889499 kernel: e820: reserve RAM buffer [mem 0x9bd3f000-0x9bffffff] Sep 5 10:21:12.889512 kernel: e820: reserve RAM buffer [mem 0x9c8ed000-0x9fffffff] Sep 5 10:21:12.889524 kernel: e820: reserve RAM buffer [mem 0x9ce91000-0x9fffffff] Sep 5 10:21:12.889536 kernel: e820: reserve RAM buffer [mem 0x9cedc000-0x9fffffff] Sep 5 10:21:12.889707 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Sep 5 10:21:12.889869 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Sep 5 10:21:12.890033 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 5 10:21:12.890055 kernel: vgaarb: loaded Sep 5 10:21:12.890068 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 5 10:21:12.890081 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 5 10:21:12.890093 kernel: clocksource: Switched to clocksource kvm-clock Sep 5 10:21:12.890106 kernel: VFS: Disk quotas dquot_6.6.0 Sep 5 10:21:12.890119 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 5 10:21:12.890132 kernel: pnp: PnP ACPI init Sep 5 10:21:12.890353 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Sep 5 10:21:12.890390 kernel: pnp: PnP ACPI: found 6 devices Sep 5 10:21:12.890403 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 5 10:21:12.890416 kernel: NET: Registered PF_INET protocol family Sep 5 10:21:12.890429 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 5 10:21:12.890442 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 5 10:21:12.890455 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 5 10:21:12.890468 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 5 10:21:12.890481 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 5 10:21:12.890494 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 5 10:21:12.890509 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 10:21:12.890522 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 10:21:12.890535 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 5 10:21:12.890547 kernel: NET: Registered PF_XDP protocol family Sep 5 10:21:12.890716 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Sep 5 10:21:12.890890 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Sep 5 10:21:12.891044 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 5 10:21:12.891198 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 5 10:21:12.891386 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 5 10:21:12.891542 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Sep 5 10:21:12.891702 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Sep 5 10:21:12.891854 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Sep 5 10:21:12.891870 kernel: PCI: CLS 0 bytes, default 64 Sep 5 10:21:12.891888 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Sep 5 10:21:12.891901 kernel: Initialise system trusted keyrings Sep 5 10:21:12.891917 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 5 10:21:12.891930 kernel: Key type asymmetric registered Sep 5 10:21:12.891942 kernel: Asymmetric key parser 'x509' registered Sep 5 10:21:12.891955 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 5 10:21:12.891968 kernel: io scheduler mq-deadline registered Sep 5 10:21:12.891981 kernel: io scheduler kyber registered Sep 5 10:21:12.891994 kernel: io scheduler bfq registered Sep 5 10:21:12.892010 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 5 10:21:12.892024 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Sep 5 10:21:12.892037 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Sep 5 10:21:12.892050 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Sep 5 10:21:12.892063 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 5 10:21:12.892076 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 5 10:21:12.892089 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 5 10:21:12.892102 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 5 10:21:12.892115 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 5 10:21:12.892285 kernel: rtc_cmos 00:04: RTC can wake from S4 Sep 5 10:21:12.892304 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Sep 5 10:21:12.892490 kernel: rtc_cmos 00:04: registered as rtc0 Sep 5 10:21:12.892757 kernel: rtc_cmos 00:04: setting system clock to 2025-09-05T10:21:12 UTC (1757067672) Sep 5 10:21:12.892909 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Sep 5 10:21:12.892926 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Sep 5 10:21:12.892939 kernel: efifb: probing for efifb Sep 5 10:21:12.892952 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Sep 5 10:21:12.892969 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Sep 5 10:21:12.892982 kernel: efifb: scrolling: redraw Sep 5 10:21:12.892995 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 5 10:21:12.893007 kernel: Console: switching to colour frame buffer device 160x50 Sep 5 10:21:12.893020 kernel: fb0: EFI VGA frame buffer device Sep 5 10:21:12.893033 kernel: pstore: Using crash dump compression: deflate Sep 5 10:21:12.893047 kernel: pstore: Registered efi_pstore as persistent store backend Sep 5 10:21:12.893059 kernel: NET: Registered PF_INET6 protocol family Sep 5 10:21:12.893072 kernel: Segment Routing with IPv6 Sep 5 10:21:12.893087 kernel: In-situ OAM (IOAM) with IPv6 Sep 5 10:21:12.893100 kernel: NET: Registered PF_PACKET protocol family Sep 5 10:21:12.893113 kernel: Key type dns_resolver registered Sep 5 10:21:12.893125 kernel: IPI shorthand broadcast: enabled Sep 5 10:21:12.893138 kernel: sched_clock: Marking stable (3168002647, 159168619)->(3348055195, -20883929) Sep 5 10:21:12.893151 kernel: registered taskstats version 1 Sep 5 10:21:12.893164 kernel: Loading compiled-in X.509 certificates Sep 5 10:21:12.893177 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.44-flatcar: 92710299622b8e79934eee79d00e6a17084ae754' Sep 5 10:21:12.893190 kernel: Demotion targets for Node 0: null Sep 5 10:21:12.893206 kernel: Key type .fscrypt registered Sep 5 10:21:12.893218 kernel: Key type fscrypt-provisioning registered Sep 5 10:21:12.893231 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 5 10:21:12.893244 kernel: ima: Allocated hash algorithm: sha1 Sep 5 10:21:12.893256 kernel: ima: No architecture policies found Sep 5 10:21:12.893269 kernel: clk: Disabling unused clocks Sep 5 10:21:12.893285 kernel: Warning: unable to open an initial console. Sep 5 10:21:12.893299 kernel: Freeing unused kernel image (initmem) memory: 54160K Sep 5 10:21:12.893311 kernel: Write protecting the kernel read-only data: 24576k Sep 5 10:21:12.893327 kernel: Freeing unused kernel image (rodata/data gap) memory: 252K Sep 5 10:21:12.893356 kernel: Run /init as init process Sep 5 10:21:12.893389 kernel: with arguments: Sep 5 10:21:12.893421 kernel: /init Sep 5 10:21:12.893434 kernel: with environment: Sep 5 10:21:12.893447 kernel: HOME=/ Sep 5 10:21:12.893460 kernel: TERM=linux Sep 5 10:21:12.893472 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 5 10:21:12.893486 systemd[1]: Successfully made /usr/ read-only. Sep 5 10:21:12.893510 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) Sep 5 10:21:12.893526 systemd[1]: Detected virtualization kvm. Sep 5 10:21:12.893542 systemd[1]: Detected architecture x86-64. Sep 5 10:21:12.893559 systemd[1]: Running in initrd. Sep 5 10:21:12.893575 systemd[1]: No hostname configured, using default hostname. Sep 5 10:21:12.893593 systemd[1]: Hostname set to . Sep 5 10:21:12.893609 systemd[1]: Initializing machine ID from VM UUID. Sep 5 10:21:12.893629 systemd[1]: Queued start job for default target initrd.target. Sep 5 10:21:12.893647 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 10:21:12.893664 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 10:21:12.893681 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 5 10:21:12.893699 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 10:21:12.893715 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 5 10:21:12.893734 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 5 10:21:12.893755 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 5 10:21:12.893769 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 5 10:21:12.893783 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 10:21:12.893796 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 10:21:12.893810 systemd[1]: Reached target paths.target - Path Units. Sep 5 10:21:12.893824 systemd[1]: Reached target slices.target - Slice Units. Sep 5 10:21:12.893838 systemd[1]: Reached target swap.target - Swaps. Sep 5 10:21:12.893852 systemd[1]: Reached target timers.target - Timer Units. Sep 5 10:21:12.893868 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 10:21:12.893881 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 10:21:12.893895 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 5 10:21:12.893908 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 5 10:21:12.893921 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 10:21:12.893935 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 10:21:12.893949 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 10:21:12.893963 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 10:21:12.893976 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 5 10:21:12.893992 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 10:21:12.894006 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 5 10:21:12.894020 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). Sep 5 10:21:12.894034 systemd[1]: Starting systemd-fsck-usr.service... Sep 5 10:21:12.894047 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 10:21:12.894061 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 10:21:12.894074 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 10:21:12.894088 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 5 10:21:12.894105 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 10:21:12.894119 systemd[1]: Finished systemd-fsck-usr.service. Sep 5 10:21:12.894133 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 5 10:21:12.894188 systemd-journald[220]: Collecting audit messages is disabled. Sep 5 10:21:12.894226 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:12.894240 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 5 10:21:12.894254 systemd-journald[220]: Journal started Sep 5 10:21:12.894287 systemd-journald[220]: Runtime Journal (/run/log/journal/e3169e4e1f3d4ee9b55c892648ee92c9) is 6M, max 48.5M, 42.4M free. Sep 5 10:21:12.899507 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 10:21:12.883068 systemd-modules-load[221]: Inserted module 'overlay' Sep 5 10:21:12.904436 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 10:21:12.907815 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 10:21:12.913541 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 5 10:21:12.911907 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 10:21:12.917377 kernel: Bridge firewalling registered Sep 5 10:21:12.917360 systemd-modules-load[221]: Inserted module 'br_netfilter' Sep 5 10:21:12.923587 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 10:21:12.926506 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 10:21:12.931469 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 10:21:12.936630 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 5 10:21:12.940282 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 10:21:12.947110 systemd-tmpfiles[241]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 5 10:21:12.949179 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 10:21:12.954883 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 10:21:12.959952 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 10:21:12.968657 dracut-cmdline[255]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=6565e4838e9026a77c427757b65255e9d0c230437ba8dd02b51abe96f219f6d3 Sep 5 10:21:13.030265 systemd-resolved[269]: Positive Trust Anchors: Sep 5 10:21:13.030290 systemd-resolved[269]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 10:21:13.030459 systemd-resolved[269]: 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 Sep 5 10:21:13.034371 systemd-resolved[269]: Defaulting to hostname 'linux'. Sep 5 10:21:13.035796 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 10:21:13.041773 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 10:21:13.103391 kernel: SCSI subsystem initialized Sep 5 10:21:13.112370 kernel: Loading iSCSI transport class v2.0-870. Sep 5 10:21:13.123384 kernel: iscsi: registered transport (tcp) Sep 5 10:21:13.146421 kernel: iscsi: registered transport (qla4xxx) Sep 5 10:21:13.146513 kernel: QLogic iSCSI HBA Driver Sep 5 10:21:13.169015 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 10:21:13.198693 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 10:21:13.202943 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 10:21:13.268543 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 5 10:21:13.271304 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 5 10:21:13.335394 kernel: raid6: avx2x4 gen() 29980 MB/s Sep 5 10:21:13.352387 kernel: raid6: avx2x2 gen() 29846 MB/s Sep 5 10:21:13.369454 kernel: raid6: avx2x1 gen() 24632 MB/s Sep 5 10:21:13.369529 kernel: raid6: using algorithm avx2x4 gen() 29980 MB/s Sep 5 10:21:13.387486 kernel: raid6: .... xor() 6424 MB/s, rmw enabled Sep 5 10:21:13.387592 kernel: raid6: using avx2x2 recovery algorithm Sep 5 10:21:13.408389 kernel: xor: automatically using best checksumming function avx Sep 5 10:21:13.579396 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 5 10:21:13.588811 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 5 10:21:13.591734 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 10:21:13.626813 systemd-udevd[472]: Using default interface naming scheme 'v255'. Sep 5 10:21:13.632611 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 10:21:13.633870 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 5 10:21:13.658412 dracut-pre-trigger[474]: rd.md=0: removing MD RAID activation Sep 5 10:21:13.694305 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 10:21:13.697262 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 10:21:13.790080 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 10:21:13.793001 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 5 10:21:13.841794 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Sep 5 10:21:13.845199 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 5 10:21:13.856370 kernel: libata version 3.00 loaded. Sep 5 10:21:13.859631 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 10:21:13.863425 kernel: cryptd: max_cpu_qlen set to 1000 Sep 5 10:21:13.870373 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Sep 5 10:21:13.876654 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 10:21:13.876825 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:13.881830 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 10:21:13.887405 kernel: AES CTR mode by8 optimization enabled Sep 5 10:21:13.887439 kernel: ahci 0000:00:1f.2: version 3.0 Sep 5 10:21:13.883902 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 10:21:13.889812 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Sep 5 10:21:13.887883 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 5 10:21:13.894767 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Sep 5 10:21:13.895073 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Sep 5 10:21:13.895259 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Sep 5 10:21:13.914371 kernel: scsi host0: ahci Sep 5 10:21:13.918437 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 10:21:13.918599 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:13.922386 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 5 10:21:13.927118 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 10:21:13.932388 kernel: scsi host1: ahci Sep 5 10:21:13.934366 kernel: scsi host2: ahci Sep 5 10:21:13.936372 kernel: scsi host3: ahci Sep 5 10:21:13.939556 kernel: scsi host4: ahci Sep 5 10:21:13.944369 kernel: scsi host5: ahci Sep 5 10:21:13.944618 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 1 Sep 5 10:21:13.944642 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 1 Sep 5 10:21:13.944776 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 1 Sep 5 10:21:13.944790 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 1 Sep 5 10:21:13.947033 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 1 Sep 5 10:21:13.947063 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 1 Sep 5 10:21:13.949879 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 5 10:21:13.971698 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 5 10:21:13.978830 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 5 10:21:13.978911 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 5 10:21:13.979975 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 5 10:21:14.007408 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 10:21:14.020368 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 10:21:14.021933 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:14.028361 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 10:21:14.255970 kernel: ata6: SATA link down (SStatus 0 SControl 300) Sep 5 10:21:14.256052 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 5 10:21:14.256066 kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 5 10:21:14.257365 kernel: ata1: SATA link down (SStatus 0 SControl 300) Sep 5 10:21:14.258365 kernel: ata2: SATA link down (SStatus 0 SControl 300) Sep 5 10:21:14.259372 kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 5 10:21:14.260377 kernel: ata3.00: LPM support broken, forcing max_power Sep 5 10:21:14.260412 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 5 10:21:14.260766 kernel: ata3.00: applying bridge limits Sep 5 10:21:14.262456 kernel: ata3.00: LPM support broken, forcing max_power Sep 5 10:21:14.262477 kernel: ata3.00: configured for UDMA/100 Sep 5 10:21:14.263367 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 5 10:21:14.321385 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 5 10:21:14.321695 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 5 10:21:14.347372 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Sep 5 10:21:14.764569 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 5 10:21:14.767599 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 10:21:14.770454 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 10:21:14.772845 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 10:21:14.775831 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 5 10:21:14.804453 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 5 10:21:15.039360 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 10:21:15.040271 disk-uuid[637]: The operation has completed successfully. Sep 5 10:21:15.071936 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 5 10:21:15.072067 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 5 10:21:15.105785 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 5 10:21:15.135116 sh[668]: Success Sep 5 10:21:15.156122 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 5 10:21:15.156187 kernel: device-mapper: uevent: version 1.0.3 Sep 5 10:21:15.156205 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 5 10:21:15.165382 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 5 10:21:15.196995 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 5 10:21:15.199701 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 5 10:21:15.219438 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 5 10:21:15.223467 kernel: BTRFS: device fsid 83e2c774-9d5a-40cd-998c-9ad33a3eb6de devid 1 transid 42 /dev/mapper/usr (253:0) scanned by mount (680) Sep 5 10:21:15.225461 kernel: BTRFS info (device dm-0): first mount of filesystem 83e2c774-9d5a-40cd-998c-9ad33a3eb6de Sep 5 10:21:15.225497 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 5 10:21:15.232358 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 5 10:21:15.232394 kernel: BTRFS info (device dm-0): enabling free space tree Sep 5 10:21:15.233758 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 5 10:21:15.234730 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 5 10:21:15.235888 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 5 10:21:15.236894 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 5 10:21:15.242221 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 5 10:21:15.269083 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (715) Sep 5 10:21:15.269135 kernel: BTRFS info (device vda6): first mount of filesystem d3ae9a42-14ef-4e13-9ff8-c1d0a1e17dd5 Sep 5 10:21:15.269150 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 5 10:21:15.273359 kernel: BTRFS info (device vda6): turning on async discard Sep 5 10:21:15.273388 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 10:21:15.279354 kernel: BTRFS info (device vda6): last unmount of filesystem d3ae9a42-14ef-4e13-9ff8-c1d0a1e17dd5 Sep 5 10:21:15.280954 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 5 10:21:15.284281 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 5 10:21:15.512622 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 10:21:15.515913 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 10:21:15.595569 ignition[759]: Ignition 2.22.0 Sep 5 10:21:15.595584 ignition[759]: Stage: fetch-offline Sep 5 10:21:15.595629 ignition[759]: no configs at "/usr/lib/ignition/base.d" Sep 5 10:21:15.595640 ignition[759]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 10:21:15.595747 ignition[759]: parsed url from cmdline: "" Sep 5 10:21:15.595752 ignition[759]: no config URL provided Sep 5 10:21:15.595762 ignition[759]: reading system config file "/usr/lib/ignition/user.ign" Sep 5 10:21:15.595773 ignition[759]: no config at "/usr/lib/ignition/user.ign" Sep 5 10:21:15.595805 ignition[759]: op(1): [started] loading QEMU firmware config module Sep 5 10:21:15.595812 ignition[759]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 5 10:21:15.664313 ignition[759]: op(1): [finished] loading QEMU firmware config module Sep 5 10:21:15.665807 ignition[759]: parsing config with SHA512: 98466982e1df6436170d5fb638263bced567ec6c8694e393226d49d438bf0f2c41250921b853eb5a992f6c41fe4379494fa38551b9f68f6e34a8b799b6f49972 Sep 5 10:21:15.667043 systemd-networkd[855]: lo: Link UP Sep 5 10:21:15.667052 systemd-networkd[855]: lo: Gained carrier Sep 5 10:21:15.668897 systemd-networkd[855]: Enumeration completed Sep 5 10:21:15.669012 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 10:21:15.669874 systemd[1]: Reached target network.target - Network. Sep 5 10:21:15.670450 systemd-networkd[855]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 10:21:15.670454 systemd-networkd[855]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 10:21:15.671479 systemd-networkd[855]: eth0: Link UP Sep 5 10:21:15.671678 systemd-networkd[855]: eth0: Gained carrier Sep 5 10:21:15.671688 systemd-networkd[855]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 10:21:15.681771 unknown[759]: fetched base config from "system" Sep 5 10:21:15.682161 ignition[759]: fetch-offline: fetch-offline passed Sep 5 10:21:15.681779 unknown[759]: fetched user config from "qemu" Sep 5 10:21:15.682243 ignition[759]: Ignition finished successfully Sep 5 10:21:15.689056 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 10:21:15.689813 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 5 10:21:15.690834 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 5 10:21:15.692382 systemd-networkd[855]: eth0: DHCPv4 address 10.0.0.92/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 10:21:15.805425 ignition[861]: Ignition 2.22.0 Sep 5 10:21:15.805442 ignition[861]: Stage: kargs Sep 5 10:21:15.805614 ignition[861]: no configs at "/usr/lib/ignition/base.d" Sep 5 10:21:15.805623 ignition[861]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 10:21:15.809136 ignition[861]: kargs: kargs passed Sep 5 10:21:15.809180 ignition[861]: Ignition finished successfully Sep 5 10:21:15.814323 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 5 10:21:15.816419 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 5 10:21:15.870853 ignition[870]: Ignition 2.22.0 Sep 5 10:21:15.870865 ignition[870]: Stage: disks Sep 5 10:21:15.870999 ignition[870]: no configs at "/usr/lib/ignition/base.d" Sep 5 10:21:15.871009 ignition[870]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 10:21:15.871649 ignition[870]: disks: disks passed Sep 5 10:21:15.871696 ignition[870]: Ignition finished successfully Sep 5 10:21:15.878382 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 5 10:21:15.880515 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 5 10:21:15.880979 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 5 10:21:15.881307 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 10:21:15.881793 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 10:21:15.882109 systemd[1]: Reached target basic.target - Basic System. Sep 5 10:21:15.884021 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 5 10:21:15.911997 systemd-fsck[880]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 5 10:21:15.922082 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 5 10:21:15.923791 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 5 10:21:16.102354 kernel: EXT4-fs (vda9): mounted filesystem 6f79a409-f2f2-4927-84c4-ff6044672b6d r/w with ordered data mode. Quota mode: none. Sep 5 10:21:16.102663 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 5 10:21:16.103642 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 5 10:21:16.106458 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 10:21:16.108823 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 5 10:21:16.110869 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 5 10:21:16.110917 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 5 10:21:16.110942 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 10:21:16.126699 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 5 10:21:16.130933 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 5 10:21:16.136446 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (888) Sep 5 10:21:16.136474 kernel: BTRFS info (device vda6): first mount of filesystem d3ae9a42-14ef-4e13-9ff8-c1d0a1e17dd5 Sep 5 10:21:16.136487 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 5 10:21:16.140383 kernel: BTRFS info (device vda6): turning on async discard Sep 5 10:21:16.140438 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 10:21:16.143318 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 10:21:16.184832 initrd-setup-root[912]: cut: /sysroot/etc/passwd: No such file or directory Sep 5 10:21:16.190533 initrd-setup-root[919]: cut: /sysroot/etc/group: No such file or directory Sep 5 10:21:16.196244 initrd-setup-root[926]: cut: /sysroot/etc/shadow: No such file or directory Sep 5 10:21:16.201664 initrd-setup-root[933]: cut: /sysroot/etc/gshadow: No such file or directory Sep 5 10:21:16.290229 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 5 10:21:16.292023 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 5 10:21:16.294112 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 5 10:21:16.311570 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 5 10:21:16.312892 kernel: BTRFS info (device vda6): last unmount of filesystem d3ae9a42-14ef-4e13-9ff8-c1d0a1e17dd5 Sep 5 10:21:16.325455 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 5 10:21:16.344567 ignition[1002]: INFO : Ignition 2.22.0 Sep 5 10:21:16.344567 ignition[1002]: INFO : Stage: mount Sep 5 10:21:16.346559 ignition[1002]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 10:21:16.346559 ignition[1002]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 10:21:16.346559 ignition[1002]: INFO : mount: mount passed Sep 5 10:21:16.346559 ignition[1002]: INFO : Ignition finished successfully Sep 5 10:21:16.353117 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 5 10:21:16.355139 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 5 10:21:16.384197 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 10:21:16.420379 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1014) Sep 5 10:21:16.420433 kernel: BTRFS info (device vda6): first mount of filesystem d3ae9a42-14ef-4e13-9ff8-c1d0a1e17dd5 Sep 5 10:21:16.420460 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 5 10:21:16.424657 kernel: BTRFS info (device vda6): turning on async discard Sep 5 10:21:16.424696 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 10:21:16.427098 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 10:21:16.461920 ignition[1031]: INFO : Ignition 2.22.0 Sep 5 10:21:16.461920 ignition[1031]: INFO : Stage: files Sep 5 10:21:16.463728 ignition[1031]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 10:21:16.463728 ignition[1031]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 10:21:16.463728 ignition[1031]: DEBUG : files: compiled without relabeling support, skipping Sep 5 10:21:16.467158 ignition[1031]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 5 10:21:16.467158 ignition[1031]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 5 10:21:16.476692 ignition[1031]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 5 10:21:16.478075 ignition[1031]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 5 10:21:16.479651 unknown[1031]: wrote ssh authorized keys file for user: core Sep 5 10:21:16.480931 ignition[1031]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 5 10:21:16.482472 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/hostname" Sep 5 10:21:16.482472 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/hostname" Sep 5 10:21:16.482472 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/exports" Sep 5 10:21:16.482472 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/exports" Sep 5 10:21:16.490003 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 10:21:16.492133 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 10:21:16.492133 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/var/lib/nfs/etab" Sep 5 10:21:16.492133 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/var/lib/nfs/etab" Sep 5 10:21:16.492133 ignition[1031]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Sep 5 10:21:16.492133 ignition[1031]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 10:21:16.502131 ignition[1031]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 10:21:16.502131 ignition[1031]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Sep 5 10:21:16.502131 ignition[1031]: INFO : files: op(9): [started] processing unit "nfs-server.service" Sep 5 10:21:16.502131 ignition[1031]: INFO : files: op(9): [finished] processing unit "nfs-server.service" Sep 5 10:21:16.502131 ignition[1031]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Sep 5 10:21:16.517016 ignition[1031]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 10:21:16.523340 ignition[1031]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 10:21:16.525119 ignition[1031]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Sep 5 10:21:16.525119 ignition[1031]: INFO : files: op(c): [started] setting preset to enabled for "nfs-server.service" Sep 5 10:21:16.525119 ignition[1031]: INFO : files: op(c): [finished] setting preset to enabled for "nfs-server.service" Sep 5 10:21:16.525119 ignition[1031]: INFO : files: createResultFile: createFiles: op(d): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 5 10:21:16.525119 ignition[1031]: INFO : files: createResultFile: createFiles: op(d): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 5 10:21:16.525119 ignition[1031]: INFO : files: files passed Sep 5 10:21:16.525119 ignition[1031]: INFO : Ignition finished successfully Sep 5 10:21:16.532997 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 5 10:21:16.536270 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 5 10:21:16.538668 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 5 10:21:16.547608 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 5 10:21:16.548067 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 5 10:21:16.552528 initrd-setup-root-after-ignition[1061]: grep: /sysroot/oem/oem-release: No such file or directory Sep 5 10:21:16.556982 initrd-setup-root-after-ignition[1063]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 10:21:16.556982 initrd-setup-root-after-ignition[1063]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 5 10:21:16.560827 initrd-setup-root-after-ignition[1067]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 10:21:16.564488 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 10:21:16.567597 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 5 10:21:16.568896 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 5 10:21:16.617184 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 5 10:21:16.617364 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 5 10:21:16.618204 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 5 10:21:16.621777 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 5 10:21:16.622213 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 5 10:21:16.626159 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 5 10:21:16.653660 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 10:21:16.657971 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 5 10:21:16.691056 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 5 10:21:16.691778 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 10:21:16.692148 systemd[1]: Stopped target timers.target - Timer Units. Sep 5 10:21:16.697786 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 5 10:21:16.697970 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 10:21:16.701102 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 5 10:21:16.701659 systemd[1]: Stopped target basic.target - Basic System. Sep 5 10:21:16.702009 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 5 10:21:16.702430 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 10:21:16.702972 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 5 10:21:16.703360 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 5 10:21:16.703889 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 5 10:21:16.704242 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 10:21:16.704814 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 5 10:21:16.705157 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 5 10:21:16.705701 systemd[1]: Stopped target swap.target - Swaps. Sep 5 10:21:16.706025 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 5 10:21:16.706197 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 5 10:21:16.720816 systemd-networkd[855]: eth0: Gained IPv6LL Sep 5 10:21:16.724963 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 5 10:21:16.726391 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 10:21:16.728313 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 5 10:21:16.730223 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 10:21:16.730897 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 5 10:21:16.731101 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 5 10:21:16.734579 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 5 10:21:16.734713 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 10:21:16.737846 systemd[1]: Stopped target paths.target - Path Units. Sep 5 10:21:16.740631 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 5 10:21:16.744397 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 10:21:16.745068 systemd[1]: Stopped target slices.target - Slice Units. Sep 5 10:21:16.745435 systemd[1]: Stopped target sockets.target - Socket Units. Sep 5 10:21:16.745967 systemd[1]: iscsid.socket: Deactivated successfully. Sep 5 10:21:16.746098 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 10:21:16.751941 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 5 10:21:16.752076 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 10:21:16.753892 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 5 10:21:16.754017 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 10:21:16.756456 systemd[1]: ignition-files.service: Deactivated successfully. Sep 5 10:21:16.756564 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 5 10:21:16.757919 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 5 10:21:16.763789 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 5 10:21:16.764181 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 5 10:21:16.764364 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 10:21:16.766665 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 5 10:21:16.766765 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 10:21:16.773876 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 5 10:21:16.774007 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 5 10:21:16.787728 ignition[1087]: INFO : Ignition 2.22.0 Sep 5 10:21:16.787728 ignition[1087]: INFO : Stage: umount Sep 5 10:21:16.790264 ignition[1087]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 10:21:16.790264 ignition[1087]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 10:21:16.790264 ignition[1087]: INFO : umount: umount passed Sep 5 10:21:16.790264 ignition[1087]: INFO : Ignition finished successfully Sep 5 10:21:16.791769 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 5 10:21:16.791933 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 5 10:21:16.794591 systemd[1]: Stopped target network.target - Network. Sep 5 10:21:16.797207 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 5 10:21:16.797303 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 5 10:21:16.798858 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 5 10:21:16.798911 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 5 10:21:16.799263 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 5 10:21:16.799319 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 5 10:21:16.804072 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 5 10:21:16.804153 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 5 10:21:16.805875 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 5 10:21:16.807944 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 5 10:21:16.811692 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 5 10:21:16.811857 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 5 10:21:16.813482 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 5 10:21:16.813600 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 5 10:21:16.822913 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 5 10:21:16.823069 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 5 10:21:16.827995 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 5 10:21:16.828158 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 5 10:21:16.831657 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 5 10:21:16.834139 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 5 10:21:16.834225 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 5 10:21:16.837440 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 5 10:21:16.837910 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 5 10:21:16.837979 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 10:21:16.838344 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 5 10:21:16.838405 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 5 10:21:16.844143 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 5 10:21:16.844222 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 5 10:21:16.844908 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 5 10:21:16.844960 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 10:21:16.850057 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 10:21:16.868443 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 5 10:21:16.873788 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 10:21:16.877349 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 5 10:21:16.877422 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 5 10:21:16.877993 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 5 10:21:16.878049 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 10:21:16.878785 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 5 10:21:16.878854 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 5 10:21:16.879602 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 5 10:21:16.879666 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 5 10:21:16.880286 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 5 10:21:16.880373 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 10:21:16.890191 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 5 10:21:16.892050 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 5 10:21:16.892161 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 10:21:16.896004 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 5 10:21:16.896087 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 10:21:16.899632 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 5 10:21:16.899709 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 10:21:16.903200 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 5 10:21:16.903301 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 10:21:16.903816 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 10:21:16.903868 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:16.910014 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 5 10:21:16.925747 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 5 10:21:16.935976 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 5 10:21:16.936107 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 5 10:21:16.937474 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 5 10:21:16.945003 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 5 10:21:16.972082 systemd[1]: Switching root. Sep 5 10:21:17.011700 systemd-journald[220]: Journal stopped Sep 5 10:21:18.066432 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Sep 5 10:21:18.066508 kernel: SELinux: policy capability network_peer_controls=1 Sep 5 10:21:18.066535 kernel: SELinux: policy capability open_perms=1 Sep 5 10:21:18.066549 kernel: SELinux: policy capability extended_socket_class=1 Sep 5 10:21:18.066563 kernel: SELinux: policy capability always_check_network=0 Sep 5 10:21:18.066578 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 5 10:21:18.066594 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 5 10:21:18.066609 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 5 10:21:18.066629 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 5 10:21:18.066644 kernel: SELinux: policy capability userspace_initial_context=0 Sep 5 10:21:18.066659 kernel: audit: type=1403 audit(1757067677.141:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 5 10:21:18.066675 systemd[1]: Successfully loaded SELinux policy in 77.484ms. Sep 5 10:21:18.066704 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 10.335ms. Sep 5 10:21:18.066727 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) Sep 5 10:21:18.066743 systemd[1]: Detected virtualization kvm. Sep 5 10:21:18.066759 systemd[1]: Detected architecture x86-64. Sep 5 10:21:18.066775 systemd[1]: Detected first boot. Sep 5 10:21:18.066790 systemd[1]: Hostname set to . Sep 5 10:21:18.066806 systemd[1]: Initializing machine ID from VM UUID. Sep 5 10:21:18.066822 (sd-exec-[1117]: /usr/lib/systemd/system-generators/nfs-server-generator failed with exit status 1. Sep 5 10:21:18.066839 zram_generator::config[1134]: No configuration found. Sep 5 10:21:18.066863 kernel: Guest personality initialized and is inactive Sep 5 10:21:18.066878 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Sep 5 10:21:18.066893 kernel: Initialized host personality Sep 5 10:21:18.066908 kernel: NET: Registered PF_VSOCK protocol family Sep 5 10:21:18.066923 systemd[1]: Populated /etc with preset unit settings. Sep 5 10:21:18.066940 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 5 10:21:18.066956 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 5 10:21:18.066978 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 5 10:21:18.066999 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 5 10:21:18.067017 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 5 10:21:18.067033 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 5 10:21:18.067049 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 5 10:21:18.067065 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 5 10:21:18.067081 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 5 10:21:18.067097 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 5 10:21:18.067113 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 5 10:21:18.067128 systemd[1]: Created slice user.slice - User and Session Slice. Sep 5 10:21:18.067147 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 10:21:18.067163 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 10:21:18.067179 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 5 10:21:18.067196 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 5 10:21:18.067223 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 5 10:21:18.067240 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 10:21:18.067259 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 5 10:21:18.067275 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 10:21:18.067291 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 10:21:18.067306 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 5 10:21:18.067322 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 5 10:21:18.067353 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 5 10:21:18.067369 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 5 10:21:18.067387 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 10:21:18.067403 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 10:21:18.067419 systemd[1]: Reached target slices.target - Slice Units. Sep 5 10:21:18.067439 systemd[1]: Reached target swap.target - Swaps. Sep 5 10:21:18.067455 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 5 10:21:18.067470 systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Sep 5 10:21:18.067485 systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Sep 5 10:21:18.067500 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 5 10:21:18.067515 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 5 10:21:18.067530 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 10:21:18.067545 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 10:21:18.067560 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 10:21:18.067577 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 5 10:21:18.067592 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 5 10:21:18.067607 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 5 10:21:18.067622 systemd[1]: Mounting media.mount - External Media Directory... Sep 5 10:21:18.067638 systemd[1]: Mounting proc-fs-nfsd.mount - NFSD configuration filesystem... Sep 5 10:21:18.067653 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 5 10:21:18.067668 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 5 10:21:18.067682 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 5 10:21:18.067698 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 5 10:21:18.067713 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). Sep 5 10:21:18.067728 systemd[1]: Reached target machines.target - Containers. Sep 5 10:21:18.067742 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 5 10:21:18.067757 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 5 10:21:18.067771 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 10:21:18.067785 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 10:21:18.067799 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 5 10:21:18.067814 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 10:21:18.067831 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 10:21:18.067846 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 10:21:18.067860 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 5 10:21:18.067874 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 10:21:18.067888 systemd[1]: Starting rpcbind.service - RPC Bind... Sep 5 10:21:18.067903 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 5 10:21:18.067917 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 5 10:21:18.067931 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 5 10:21:18.067949 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 5 10:21:18.067963 kernel: RPC: Registered named UNIX socket transport module. Sep 5 10:21:18.067977 systemd[1]: Stopped systemd-fsck-usr.service. Sep 5 10:21:18.067990 kernel: RPC: Registered udp transport module. Sep 5 10:21:18.068004 (rpcbind)[1208]: rpcbind.service: Referenced but unset environment variable evaluates to an empty string: RPCBIND_OPTIONS Sep 5 10:21:18.068022 kernel: RPC: Registered tcp transport module. Sep 5 10:21:18.068037 kernel: RPC: Registered tcp-with-tls transport module. Sep 5 10:21:18.068051 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 5 10:21:18.068069 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). Sep 5 10:21:18.068084 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 10:21:18.068099 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 10:21:18.068114 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 10:21:18.068128 kernel: loop: module loaded Sep 5 10:21:18.068145 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 5 10:21:18.068160 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 5 10:21:18.068175 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 10:21:18.068190 kernel: fuse: init (API version 7.41) Sep 5 10:21:18.068204 systemd[1]: verity-setup.service: Deactivated successfully. Sep 5 10:21:18.068230 systemd[1]: Stopped verity-setup.service. Sep 5 10:21:18.068250 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 5 10:21:18.068264 kernel: ACPI: bus type drm_connector registered Sep 5 10:21:18.068278 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 5 10:21:18.068291 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 5 10:21:18.068305 systemd[1]: Mounted media.mount - External Media Directory. Sep 5 10:21:18.068320 systemd[1]: Started rpcbind.service - RPC Bind. Sep 5 10:21:18.068353 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 5 10:21:18.068370 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 5 10:21:18.068391 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 5 10:21:18.068407 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 10:21:18.068452 systemd-journald[1218]: Collecting audit messages is disabled. Sep 5 10:21:18.068480 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 5 10:21:18.068500 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 5 10:21:18.068516 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 5 10:21:18.068532 systemd-journald[1218]: Journal started Sep 5 10:21:18.068563 systemd-journald[1218]: Runtime Journal (/run/log/journal/e3169e4e1f3d4ee9b55c892648ee92c9) is 6M, max 48.5M, 42.4M free. Sep 5 10:21:17.722511 systemd[1]: Queued start job for default target multi-user.target. Sep 5 10:21:17.743317 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 5 10:21:17.743825 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 5 10:21:18.071992 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 10:21:18.073399 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 10:21:18.073660 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 10:21:18.075284 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 10:21:18.075561 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 10:21:18.077110 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 10:21:18.077386 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 10:21:18.078947 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 5 10:21:18.079168 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 5 10:21:18.080604 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 10:21:18.080852 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 10:21:18.082640 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 10:21:18.084157 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 10:21:18.085825 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 5 10:21:18.087646 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 5 10:21:18.106157 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 10:21:18.108579 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 5 10:21:18.111967 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 5 10:21:18.113063 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 5 10:21:18.113091 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 10:21:18.116431 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 5 10:21:18.124729 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 5 10:21:18.127100 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 5 10:21:18.127288 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 10:21:18.128691 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 5 10:21:18.133444 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 5 10:21:18.136045 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 10:21:18.137267 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 5 10:21:18.138669 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 10:21:18.144435 systemd-journald[1218]: Time spent on flushing to /var/log/journal/e3169e4e1f3d4ee9b55c892648ee92c9 is 35.742ms for 1056 entries. Sep 5 10:21:18.144435 systemd-journald[1218]: System Journal (/var/log/journal/e3169e4e1f3d4ee9b55c892648ee92c9) is 8M, max 195.6M, 187.6M free. Sep 5 10:21:18.192495 systemd-journald[1218]: Received client request to flush runtime journal. Sep 5 10:21:18.192553 kernel: loop0: detected capacity change from 0 to 128008 Sep 5 10:21:18.141620 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 10:21:18.150494 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 5 10:21:18.157511 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 5 10:21:18.162283 systemd[1]: Mounted proc-fs-nfsd.mount - NFSD configuration filesystem. Sep 5 10:21:18.164389 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 10:21:18.166176 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 5 10:21:18.168221 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 5 10:21:18.170072 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 5 10:21:18.177596 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 5 10:21:18.180860 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 5 10:21:18.194626 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 10:21:18.197124 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 5 10:21:18.198225 systemd-tmpfiles[1263]: ACLs are not supported, ignoring. Sep 5 10:21:18.198238 systemd-tmpfiles[1263]: ACLs are not supported, ignoring. Sep 5 10:21:18.204814 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 10:21:18.208591 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 5 10:21:18.224734 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 5 10:21:18.223185 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 5 10:21:18.249621 kernel: loop1: detected capacity change from 0 to 120800 Sep 5 10:21:18.255867 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 5 10:21:18.260565 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 10:21:18.283389 kernel: loop2: detected capacity change from 0 to 128008 Sep 5 10:21:18.298357 kernel: loop3: detected capacity change from 0 to 120800 Sep 5 10:21:18.294372 systemd-tmpfiles[1285]: ACLs are not supported, ignoring. Sep 5 10:21:18.294388 systemd-tmpfiles[1285]: ACLs are not supported, ignoring. Sep 5 10:21:18.300118 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 10:21:18.307287 (sd-merge)[1287]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 5 10:21:18.307766 (sd-merge)[1287]: Merged extensions into '/usr'. Sep 5 10:21:18.313729 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 5 10:21:18.317536 systemd[1]: Starting ensure-sysext.service... Sep 5 10:21:18.320469 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 10:21:18.342532 systemd[1]: Reload requested from client PID 1290 ('systemctl') (unit ensure-sysext.service)... Sep 5 10:21:18.343089 systemd[1]: Reloading... Sep 5 10:21:18.348186 systemd-tmpfiles[1291]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 5 10:21:18.348235 systemd-tmpfiles[1291]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 5 10:21:18.348536 systemd-tmpfiles[1291]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 5 10:21:18.348813 systemd-tmpfiles[1291]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 5 10:21:18.350133 systemd-tmpfiles[1291]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 5 10:21:18.350493 systemd-tmpfiles[1291]: ACLs are not supported, ignoring. Sep 5 10:21:18.350625 systemd-tmpfiles[1291]: ACLs are not supported, ignoring. Sep 5 10:21:18.356894 systemd-tmpfiles[1291]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 10:21:18.356994 systemd-tmpfiles[1291]: Skipping /boot Sep 5 10:21:18.368768 systemd-tmpfiles[1291]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 10:21:18.368889 systemd-tmpfiles[1291]: Skipping /boot Sep 5 10:21:18.397397 zram_generator::config[1320]: No configuration found. Sep 5 10:21:18.465033 (sd-exec-[1299]: /usr/lib/systemd/system-generators/nfs-server-generator failed with exit status 1. Sep 5 10:21:18.510134 ldconfig[1257]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 5 10:21:18.614614 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 5 10:21:18.614731 systemd[1]: Reloading finished in 271 ms. Sep 5 10:21:18.652762 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 5 10:21:18.675406 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 10:21:18.684286 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 10:21:18.704834 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 5 10:21:18.707925 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 5 10:21:18.715685 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 10:21:18.718550 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 5 10:21:18.723237 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 10:21:18.725219 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 10:21:18.729565 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 10:21:18.731315 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 10:21:18.734864 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 10:21:18.734979 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). Sep 5 10:21:18.739119 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 5 10:21:18.743519 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 10:21:18.743861 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 10:21:18.747803 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 5 10:21:18.749887 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 10:21:18.750088 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 10:21:18.752413 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 10:21:18.752677 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 10:21:18.761911 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 5 10:21:18.763720 systemd[1]: Mounting var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System... Sep 5 10:21:18.765061 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 10:21:18.765859 augenrules[1391]: No rules Sep 5 10:21:18.766659 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 10:21:18.772617 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 10:21:18.781241 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 10:21:18.782639 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 10:21:18.782892 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). Sep 5 10:21:18.784792 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 10:21:18.787630 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 5 10:21:18.790654 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 5 10:21:18.793376 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 5 10:21:18.799370 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 10:21:18.805604 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 10:21:18.807561 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 5 10:21:18.809568 systemd[1]: Mounted var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System. Sep 5 10:21:18.811447 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 10:21:18.811723 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 10:21:18.813440 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 10:21:18.813724 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 10:21:18.815596 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 10:21:18.815873 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 10:21:18.817649 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 5 10:21:18.822230 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 5 10:21:18.822868 systemd-udevd[1400]: Using default interface naming scheme 'v255'. Sep 5 10:21:18.833501 systemd[1]: Reached target rpc_pipefs.target. Sep 5 10:21:18.834477 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 5 10:21:18.835931 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 10:21:18.836932 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 5 10:21:18.837296 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 10:21:18.840515 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 10:21:18.846793 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 10:21:18.849022 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 10:21:18.852702 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 10:21:18.855626 systemd[1]: Starting nfsdcld.service - NFSv4 Client Tracking Daemon... Sep 5 10:21:18.856841 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 5 10:21:18.856986 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Sep 5 10:21:18.857243 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 10:21:18.857391 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). Sep 5 10:21:18.857570 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). Sep 5 10:21:18.857684 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 5 10:21:18.860649 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 10:21:18.862499 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 10:21:18.873095 augenrules[1411]: /sbin/augenrules: No change Sep 5 10:21:18.873419 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 10:21:18.876044 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 5 10:21:18.877917 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 10:21:18.882638 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 10:21:18.884867 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 10:21:18.885267 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 10:21:18.887470 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 10:21:18.888284 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 10:21:18.892456 systemd[1]: Started nfsdcld.service - NFSv4 Client Tracking Daemon. Sep 5 10:21:18.898651 augenrules[1468]: No rules Sep 5 10:21:18.903358 systemd[1]: Finished ensure-sysext.service. Sep 5 10:21:18.904817 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 10:21:18.905117 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 10:21:18.915486 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 10:21:18.916527 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 10:21:18.916581 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 10:21:18.920429 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 5 10:21:18.967881 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 5 10:21:19.000636 systemd-resolved[1368]: Positive Trust Anchors: Sep 5 10:21:19.000652 systemd-resolved[1368]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 10:21:19.000682 systemd-resolved[1368]: 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 Sep 5 10:21:19.004402 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 10:21:19.005512 systemd-resolved[1368]: Using system hostname 'nfs1'. Sep 5 10:21:19.007773 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 5 10:21:19.009912 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 10:21:19.011310 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 10:21:19.022361 kernel: mousedev: PS/2 mouse device common for all mice Sep 5 10:21:19.046397 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Sep 5 10:21:19.047429 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 5 10:21:19.058122 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Sep 5 10:21:19.058369 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Sep 5 10:21:19.058524 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Sep 5 10:21:19.060358 kernel: ACPI: button: Power Button [PWRF] Sep 5 10:21:19.090059 systemd-networkd[1481]: lo: Link UP Sep 5 10:21:19.090075 systemd-networkd[1481]: lo: Gained carrier Sep 5 10:21:19.092204 systemd-networkd[1481]: Enumeration completed Sep 5 10:21:19.092775 systemd-networkd[1481]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 10:21:19.092790 systemd-networkd[1481]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 10:21:19.094227 systemd-networkd[1481]: eth0: Link UP Sep 5 10:21:19.094457 systemd-networkd[1481]: eth0: Gained carrier Sep 5 10:21:19.094486 systemd-networkd[1481]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 10:21:19.096040 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 10:21:19.097511 systemd[1]: Reached target network.target - Network. Sep 5 10:21:19.100657 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 5 10:21:19.103552 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 5 10:21:19.108457 systemd-networkd[1481]: eth0: DHCPv4 address 10.0.0.92/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 10:21:19.139044 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 5 10:21:19.140504 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 10:21:19.141652 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 5 10:21:19.143315 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 5 10:21:20.557318 systemd-resolved[1368]: Clock change detected. Flushing caches. Sep 5 10:21:20.557664 systemd-timesyncd[1483]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 5 10:21:20.557713 systemd-timesyncd[1483]: Initial clock synchronization to Fri 2025-09-05 10:21:20.557105 UTC. Sep 5 10:21:20.559098 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 5 10:21:20.560301 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 5 10:21:20.561538 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 5 10:21:20.561583 systemd[1]: Reached target paths.target - Path Units. Sep 5 10:21:20.563618 systemd[1]: Reached target time-set.target - System Time Set. Sep 5 10:21:20.564835 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 5 10:21:20.565984 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 5 10:21:20.567209 systemd[1]: Reached target timers.target - Timer Units. Sep 5 10:21:20.568711 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 5 10:21:20.571596 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 10:21:20.576184 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 5 10:21:20.577614 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 5 10:21:20.578931 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 5 10:21:20.584465 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 5 10:21:20.589967 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 5 10:21:20.592223 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 5 10:21:20.593652 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 10:21:20.596958 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 10:21:20.598097 systemd[1]: Reached target basic.target - Basic System. Sep 5 10:21:20.599081 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 5 10:21:20.599110 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 5 10:21:20.600349 systemd[1]: Starting containerd.service - containerd container runtime... Sep 5 10:21:20.602312 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 5 10:21:20.604260 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 5 10:21:20.613386 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 5 10:21:20.619696 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 5 10:21:20.620776 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). Sep 5 10:21:20.621773 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 5 10:21:20.624443 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 5 10:21:20.626903 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 5 10:21:20.630420 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 5 10:21:20.637760 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 5 10:21:20.639660 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 5 10:21:20.641753 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 5 10:21:20.642371 systemd[1]: Starting update-engine.service - Update Engine... Sep 5 10:21:20.644656 jq[1524]: false Sep 5 10:21:20.645485 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Refreshing passwd entry cache Sep 5 10:21:20.645494 oslogin_cache_refresh[1526]: Refreshing passwd entry cache Sep 5 10:21:20.646844 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 5 10:21:20.651281 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 5 10:21:20.653011 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 5 10:21:20.653256 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 5 10:21:20.653610 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 5 10:21:20.653847 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 5 10:21:20.657419 jq[1533]: true Sep 5 10:21:20.657884 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Failure getting users, quitting Sep 5 10:21:20.659064 oslogin_cache_refresh[1526]: Failure getting users, quitting Sep 5 10:21:20.659142 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 5 10:21:20.659172 oslogin_cache_refresh[1526]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 5 10:21:20.659274 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Refreshing group entry cache Sep 5 10:21:20.659306 oslogin_cache_refresh[1526]: Refreshing group entry cache Sep 5 10:21:20.666681 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Failure getting groups, quitting Sep 5 10:21:20.666753 oslogin_cache_refresh[1526]: Failure getting groups, quitting Sep 5 10:21:20.666826 google_oslogin_nss_cache[1526]: oslogin_cache_refresh[1526]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 5 10:21:20.666856 oslogin_cache_refresh[1526]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 5 10:21:20.670709 extend-filesystems[1525]: Found /dev/vda6 Sep 5 10:21:20.672069 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 5 10:21:20.673676 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 5 10:21:20.674899 (ntainerd)[1546]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 5 10:21:20.684230 systemd[1]: motdgen.service: Deactivated successfully. Sep 5 10:21:20.685614 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 5 10:21:20.689005 jq[1545]: true Sep 5 10:21:20.689321 update_engine[1532]: I20250905 10:21:20.689014 1532 main.cc:92] Flatcar Update Engine starting Sep 5 10:21:20.696942 extend-filesystems[1525]: Found /dev/vda9 Sep 5 10:21:20.703728 extend-filesystems[1525]: Checking size of /dev/vda9 Sep 5 10:21:20.710031 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 10:21:20.716236 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 10:21:20.716662 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:20.723982 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 10:21:20.732851 extend-filesystems[1525]: Old size kept for /dev/vda9 Sep 5 10:21:20.738738 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 5 10:21:20.740186 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 5 10:21:20.754477 dbus-daemon[1522]: [system] SELinux support is enabled Sep 5 10:21:20.756838 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 5 10:21:20.759283 dbus-daemon[1522]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1481 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 5 10:21:20.763091 update_engine[1532]: I20250905 10:21:20.760643 1532 update_check_scheduler.cc:74] Next update check in 5m10s Sep 5 10:21:20.760644 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). Sep 5 10:21:20.760672 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 5 10:21:20.762057 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). Sep 5 10:21:20.762079 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 5 10:21:20.765087 systemd[1]: Started update-engine.service - Update Engine. Sep 5 10:21:20.766186 dbus-daemon[1522]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 5 10:21:20.771342 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 5 10:21:20.774740 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 5 10:21:20.796570 kernel: kvm_amd: TSC scaling supported Sep 5 10:21:20.796632 kernel: kvm_amd: Nested Virtualization enabled Sep 5 10:21:20.796646 kernel: kvm_amd: Nested Paging enabled Sep 5 10:21:20.796659 kernel: kvm_amd: LBR virtualization supported Sep 5 10:21:20.800586 bash[1582]: Updated "/home/core/.ssh/authorized_keys" Sep 5 10:21:20.807571 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Sep 5 10:21:20.807625 kernel: kvm_amd: Virtual GIF supported Sep 5 10:21:20.805759 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 5 10:21:20.807785 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 5 10:21:20.871589 kernel: EDAC MC: Ver: 3.0.0 Sep 5 10:21:20.880619 locksmithd[1583]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 5 10:21:20.881009 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 10:21:20.886728 sshd_keygen[1550]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 5 10:21:20.892676 systemd-logind[1530]: Watching system buttons on /dev/input/event2 (Power Button) Sep 5 10:21:20.892970 systemd-logind[1530]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 5 10:21:20.893533 systemd-logind[1530]: New seat seat0. Sep 5 10:21:20.908201 systemd[1]: Started systemd-logind.service - User Login Management. Sep 5 10:21:20.916146 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 5 10:21:20.921280 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 5 10:21:20.938201 systemd[1]: issuegen.service: Deactivated successfully. Sep 5 10:21:20.938487 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 5 10:21:20.941894 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 5 10:21:20.958187 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 5 10:21:20.963196 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 5 10:21:20.968612 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 5 10:21:20.969914 systemd[1]: Reached target getty.target - Login Prompts. Sep 5 10:21:20.972412 containerd[1546]: time="2025-09-05T10:21:20Z" 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 Sep 5 10:21:20.973224 containerd[1546]: time="2025-09-05T10:21:20.973169852Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 5 10:21:20.983596 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 5 10:21:20.983891 containerd[1546]: time="2025-09-05T10:21:20.983775845Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.046µs" Sep 5 10:21:20.983891 containerd[1546]: time="2025-09-05T10:21:20.983807775Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 5 10:21:20.983891 containerd[1546]: time="2025-09-05T10:21:20.983824887Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 5 10:21:20.984052 containerd[1546]: time="2025-09-05T10:21:20.984019392Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 5 10:21:20.984052 containerd[1546]: time="2025-09-05T10:21:20.984038789Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 5 10:21:20.984145 containerd[1546]: time="2025-09-05T10:21:20.984069536Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984145 containerd[1546]: time="2025-09-05T10:21:20.984131302Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984145 containerd[1546]: time="2025-09-05T10:21:20.984141812Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984502 containerd[1546]: time="2025-09-05T10:21:20.984460940Z" 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 Sep 5 10:21:20.984502 containerd[1546]: time="2025-09-05T10:21:20.984481649Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984603 containerd[1546]: time="2025-09-05T10:21:20.984503550Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984603 containerd[1546]: time="2025-09-05T10:21:20.984514060Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984657 containerd[1546]: time="2025-09-05T10:21:20.984636590Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984952 containerd[1546]: time="2025-09-05T10:21:20.984916144Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 10:21:20.984952 containerd[1546]: time="2025-09-05T10:21:20.984950779Z" 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 Sep 5 10:21:20.985018 containerd[1546]: time="2025-09-05T10:21:20.984960868Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 5 10:21:20.985018 containerd[1546]: time="2025-09-05T10:21:20.985008558Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 5 10:21:20.985140 dbus-daemon[1522]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 5 10:21:20.985417 containerd[1546]: time="2025-09-05T10:21:20.985338667Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 5 10:21:20.985606 containerd[1546]: time="2025-09-05T10:21:20.985577344Z" level=info msg="metadata content store policy set" policy=shared Sep 5 10:21:20.986136 dbus-daemon[1522]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=1581 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 5 10:21:20.990932 systemd[1]: Starting polkit.service - Authorization Manager... Sep 5 10:21:20.992411 containerd[1546]: time="2025-09-05T10:21:20.992358805Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 5 10:21:20.992453 containerd[1546]: time="2025-09-05T10:21:20.992443864Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 5 10:21:20.992475 containerd[1546]: time="2025-09-05T10:21:20.992460255Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 5 10:21:20.992475 containerd[1546]: time="2025-09-05T10:21:20.992472818Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 5 10:21:20.992585 containerd[1546]: time="2025-09-05T10:21:20.992542419Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 5 10:21:20.992585 containerd[1546]: time="2025-09-05T10:21:20.992574820Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 5 10:21:20.992629 containerd[1546]: time="2025-09-05T10:21:20.992586722Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 5 10:21:20.992629 containerd[1546]: time="2025-09-05T10:21:20.992597953Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 5 10:21:20.992629 containerd[1546]: time="2025-09-05T10:21:20.992610376Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 5 10:21:20.992629 containerd[1546]: time="2025-09-05T10:21:20.992620105Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 5 10:21:20.992629 containerd[1546]: time="2025-09-05T10:21:20.992629863Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 5 10:21:20.992726 containerd[1546]: time="2025-09-05T10:21:20.992642998Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 5 10:21:20.992797 containerd[1546]: time="2025-09-05T10:21:20.992770747Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 5 10:21:20.992797 containerd[1546]: time="2025-09-05T10:21:20.992792939Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 5 10:21:20.992837 containerd[1546]: time="2025-09-05T10:21:20.992806975Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 5 10:21:20.992837 containerd[1546]: time="2025-09-05T10:21:20.992821342Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 5 10:21:20.992837 containerd[1546]: time="2025-09-05T10:21:20.992831411Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 5 10:21:20.992901 containerd[1546]: time="2025-09-05T10:21:20.992841019Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 5 10:21:20.992901 containerd[1546]: time="2025-09-05T10:21:20.992851859Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 5 10:21:20.992901 containerd[1546]: time="2025-09-05T10:21:20.992861237Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 5 10:21:20.992901 containerd[1546]: time="2025-09-05T10:21:20.992871236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 5 10:21:20.992901 containerd[1546]: time="2025-09-05T10:21:20.992881565Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 5 10:21:20.992901 containerd[1546]: time="2025-09-05T10:21:20.992892566Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 5 10:21:20.993018 containerd[1546]: time="2025-09-05T10:21:20.992961275Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 5 10:21:20.993018 containerd[1546]: time="2025-09-05T10:21:20.992973638Z" level=info msg="Start snapshots syncer" Sep 5 10:21:20.993018 containerd[1546]: time="2025-09-05T10:21:20.993000518Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 5 10:21:20.993313 containerd[1546]: time="2025-09-05T10:21:20.993267599Z" 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\"}" Sep 5 10:21:20.993431 containerd[1546]: time="2025-09-05T10:21:20.993320198Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 5 10:21:20.993431 containerd[1546]: time="2025-09-05T10:21:20.993386763Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 5 10:21:20.993612 containerd[1546]: time="2025-09-05T10:21:20.993588311Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 5 10:21:20.993645 containerd[1546]: time="2025-09-05T10:21:20.993624358Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 5 10:21:20.993645 containerd[1546]: time="2025-09-05T10:21:20.993636882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 5 10:21:20.993697 containerd[1546]: time="2025-09-05T10:21:20.993649596Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 5 10:21:20.993697 containerd[1546]: time="2025-09-05T10:21:20.993664534Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 5 10:21:20.993697 containerd[1546]: time="2025-09-05T10:21:20.993679953Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 5 10:21:20.993697 containerd[1546]: time="2025-09-05T10:21:20.993690382Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 5 10:21:20.993768 containerd[1546]: time="2025-09-05T10:21:20.993709468Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 5 10:21:20.993768 containerd[1546]: time="2025-09-05T10:21:20.993720358Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 5 10:21:20.993768 containerd[1546]: time="2025-09-05T10:21:20.993730507Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 5 10:21:20.993827 containerd[1546]: time="2025-09-05T10:21:20.993780942Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 10:21:20.993827 containerd[1546]: time="2025-09-05T10:21:20.993793566Z" 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 Sep 5 10:21:20.993827 containerd[1546]: time="2025-09-05T10:21:20.993802162Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 10:21:20.993827 containerd[1546]: time="2025-09-05T10:21:20.993811309Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 10:21:20.993899 containerd[1546]: time="2025-09-05T10:21:20.993818903Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 5 10:21:20.993899 containerd[1546]: time="2025-09-05T10:21:20.993890317Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 5 10:21:20.993940 containerd[1546]: time="2025-09-05T10:21:20.993902580Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 5 10:21:20.993940 containerd[1546]: time="2025-09-05T10:21:20.993920213Z" level=info msg="runtime interface created" Sep 5 10:21:20.993940 containerd[1546]: time="2025-09-05T10:21:20.993925613Z" level=info msg="created NRI interface" Sep 5 10:21:20.993940 containerd[1546]: time="2025-09-05T10:21:20.993933548Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 5 10:21:20.994011 containerd[1546]: time="2025-09-05T10:21:20.993944028Z" level=info msg="Connect containerd service" Sep 5 10:21:20.994011 containerd[1546]: time="2025-09-05T10:21:20.993966821Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 5 10:21:20.994943 containerd[1546]: time="2025-09-05T10:21:20.994910561Z" 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" Sep 5 10:21:21.077439 polkitd[1620]: Started polkitd version 126 Sep 5 10:21:21.079299 containerd[1546]: time="2025-09-05T10:21:21.079259566Z" level=info msg="Start subscribing containerd event" Sep 5 10:21:21.079354 containerd[1546]: time="2025-09-05T10:21:21.079319588Z" level=info msg="Start recovering state" Sep 5 10:21:21.079448 containerd[1546]: time="2025-09-05T10:21:21.079424234Z" level=info msg="Start event monitor" Sep 5 10:21:21.079448 containerd[1546]: time="2025-09-05T10:21:21.079442178Z" level=info msg="Start cni network conf syncer for default" Sep 5 10:21:21.079501 containerd[1546]: time="2025-09-05T10:21:21.079452377Z" level=info msg="Start streaming server" Sep 5 10:21:21.079501 containerd[1546]: time="2025-09-05T10:21:21.079461104Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 5 10:21:21.079501 containerd[1546]: time="2025-09-05T10:21:21.079468868Z" level=info msg="runtime interface starting up..." Sep 5 10:21:21.079501 containerd[1546]: time="2025-09-05T10:21:21.079474388Z" level=info msg="starting plugins..." Sep 5 10:21:21.079501 containerd[1546]: time="2025-09-05T10:21:21.079489106Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 5 10:21:21.079975 containerd[1546]: time="2025-09-05T10:21:21.079943629Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 5 10:21:21.080013 containerd[1546]: time="2025-09-05T10:21:21.079996858Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 5 10:21:21.080686 containerd[1546]: time="2025-09-05T10:21:21.080658710Z" level=info msg="containerd successfully booted in 0.108748s" Sep 5 10:21:21.080868 systemd[1]: Started containerd.service - containerd container runtime. Sep 5 10:21:21.081643 polkitd[1620]: Loading rules from directory /etc/polkit-1/rules.d Sep 5 10:21:21.082024 polkitd[1620]: Loading rules from directory /run/polkit-1/rules.d Sep 5 10:21:21.082073 polkitd[1620]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 5 10:21:21.082329 polkitd[1620]: Loading rules from directory /usr/local/share/polkit-1/rules.d Sep 5 10:21:21.082352 polkitd[1620]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 5 10:21:21.082403 polkitd[1620]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 5 10:21:21.083357 polkitd[1620]: Finished loading, compiling and executing 2 rules Sep 5 10:21:21.083759 systemd[1]: Started polkit.service - Authorization Manager. Sep 5 10:21:21.087013 dbus-daemon[1522]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 5 10:21:21.087279 polkitd[1620]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 5 10:21:21.095714 systemd-hostnamed[1581]: Hostname set to (static) Sep 5 10:21:21.653798 systemd-networkd[1481]: eth0: Gained IPv6LL Sep 5 10:21:21.657501 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 5 10:21:21.659868 systemd[1]: Reached target network-online.target - Network is Online. Sep 5 10:21:21.663034 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 5 10:21:21.665539 systemd[1]: Starting nfs-idmapd.service - NFSv4 ID-name mapping service... Sep 5 10:21:21.673592 systemd[1]: Starting nfs-mountd.service - NFS Mount Daemon... Sep 5 10:21:21.676027 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 5 10:21:21.677818 rpc.idmapd[1647]: Setting log level to 0 Sep 5 10:21:21.679008 rpc.idmapd[1647]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Sep 5 10:21:21.679153 systemd[1]: Starting rpc-statd.service - NFS status monitor for NFSv2/3 locking.... Sep 5 10:21:21.683803 systemd[1]: Started nfs-idmapd.service - NFSv4 ID-name mapping service. Sep 5 10:21:21.693192 rpc.statd[1655]: Version 2.7.1 starting Sep 5 10:21:21.693204 rpc.statd[1655]: Flags: TI-RPC Sep 5 10:21:21.693901 rpc.statd[1655]: Failed to read /var/lib/nfs/state: Success Sep 5 10:21:21.694062 rpc.statd[1655]: Initializing NSM state Sep 5 10:21:21.703015 rpc.mountd[1659]: Version 2.7.1 starting Sep 5 10:21:21.703379 systemd[1]: Started rpc-statd.service - NFS status monitor for NFSv2/3 locking.. Sep 5 10:21:21.705247 systemd[1]: Started nfs-mountd.service - NFS Mount Daemon. Sep 5 10:21:21.707800 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 5 10:21:21.713024 systemd[1]: Starting nfs-server.service - NFS server and services... Sep 5 10:21:21.731983 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 5 10:21:21.732274 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 5 10:21:21.735457 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 5 10:21:21.735691 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 5 10:21:21.869352 kernel: NFSD: Using nfsdcld client tracking operations. Sep 5 10:21:21.869529 kernel: NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) Sep 5 10:21:21.878810 systemd[1]: Finished nfs-server.service - NFS server and services. Sep 5 10:21:21.882444 systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Sep 5 10:21:21.910804 sm-notify[1680]: Version 2.7.1 starting Sep 5 10:21:21.912708 systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Sep 5 10:21:21.914709 systemd[1]: Startup finished in 3.243s (kernel) + 4.462s (initrd) + 3.435s (userspace) = 11.142s. Sep 5 10:21:27.697403 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 5 10:21:27.699068 systemd[1]: Started sshd@0-10.0.0.92:22-10.0.0.1:36318.service - OpenSSH per-connection server daemon (10.0.0.1:36318). Sep 5 10:21:27.774447 sshd[1687]: Accepted publickey for core from 10.0.0.1 port 36318 ssh2: RSA SHA256:4AV+lHLuPhRFQszLVoeJw3OvhccGvLYECZDzAb+ne9k Sep 5 10:21:27.777356 sshd-session[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 10:21:27.788965 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 5 10:21:27.790541 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 5 10:21:27.793254 systemd-logind[1530]: New session 1 of user core. Sep 5 10:21:27.819283 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 5 10:21:27.822777 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 5 10:21:27.842907 (systemd)[1692]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 5 10:21:27.845998 systemd-logind[1530]: New session c1 of user core. Sep 5 10:21:28.013765 systemd[1692]: Queued start job for default target default.target. Sep 5 10:21:28.024090 systemd[1692]: Created slice app.slice - User Application Slice. Sep 5 10:21:28.024123 systemd[1692]: Reached target paths.target - Paths. Sep 5 10:21:28.024169 systemd[1692]: Reached target timers.target - Timers. Sep 5 10:21:28.025915 systemd[1692]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 5 10:21:28.040021 systemd[1692]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 5 10:21:28.040175 systemd[1692]: Reached target sockets.target - Sockets. Sep 5 10:21:28.040240 systemd[1692]: Reached target basic.target - Basic System. Sep 5 10:21:28.040280 systemd[1692]: Reached target default.target - Main User Target. Sep 5 10:21:28.040320 systemd[1692]: Startup finished in 185ms. Sep 5 10:21:28.040779 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 5 10:21:28.042624 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 5 10:21:28.048085 sshd[1700]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 10:21:28.108198 systemd[1]: Started sshd@1-10.0.0.92:22-10.0.0.1:36328.service - OpenSSH per-connection server daemon (10.0.0.1:36328). Sep 5 10:21:28.164790 sshd[1703]: Accepted publickey for core from 10.0.0.1 port 36328 ssh2: RSA SHA256:4AV+lHLuPhRFQszLVoeJw3OvhccGvLYECZDzAb+ne9k Sep 5 10:21:28.166385 sshd-session[1703]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 10:21:28.171015 systemd-logind[1530]: New session 2 of user core. Sep 5 10:21:28.180800 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 5 10:21:28.185154 sshd[1706]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 10:21:28.235495 sshd[1706]: Connection closed by 10.0.0.1 port 36328 Sep 5 10:21:28.235841 sshd-session[1703]: pam_unix(sshd:session): session closed for user core Sep 5 10:21:28.255886 systemd[1]: sshd@1-10.0.0.92:22-10.0.0.1:36328.service: Deactivated successfully. Sep 5 10:21:28.257913 systemd[1]: session-2.scope: Deactivated successfully. Sep 5 10:21:28.258697 systemd-logind[1530]: Session 2 logged out. Waiting for processes to exit. Sep 5 10:21:28.261615 systemd[1]: Started sshd@2-10.0.0.92:22-10.0.0.1:36334.service - OpenSSH per-connection server daemon (10.0.0.1:36334). Sep 5 10:21:28.262334 systemd-logind[1530]: Removed session 2. Sep 5 10:21:28.324471 sshd[1712]: Accepted publickey for core from 10.0.0.1 port 36334 ssh2: RSA SHA256:4AV+lHLuPhRFQszLVoeJw3OvhccGvLYECZDzAb+ne9k Sep 5 10:21:28.326226 sshd-session[1712]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 10:21:28.330822 systemd-logind[1530]: New session 3 of user core. Sep 5 10:21:28.346739 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 5 10:21:28.350905 sshd[1715]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 10:21:28.395574 sshd[1715]: Connection closed by 10.0.0.1 port 36334 Sep 5 10:21:28.395909 sshd-session[1712]: pam_unix(sshd:session): session closed for user core Sep 5 10:21:28.406123 systemd[1]: sshd@2-10.0.0.92:22-10.0.0.1:36334.service: Deactivated successfully. Sep 5 10:21:28.407918 systemd[1]: session-3.scope: Deactivated successfully. Sep 5 10:21:28.408710 systemd-logind[1530]: Session 3 logged out. Waiting for processes to exit. Sep 5 10:21:28.411453 systemd[1]: Started sshd@3-10.0.0.92:22-10.0.0.1:36340.service - OpenSSH per-connection server daemon (10.0.0.1:36340). Sep 5 10:21:28.412226 systemd-logind[1530]: Removed session 3. Sep 5 10:21:28.468413 sshd[1721]: Accepted publickey for core from 10.0.0.1 port 36340 ssh2: RSA SHA256:4AV+lHLuPhRFQszLVoeJw3OvhccGvLYECZDzAb+ne9k Sep 5 10:21:28.470154 sshd-session[1721]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 10:21:28.474787 systemd-logind[1530]: New session 4 of user core. Sep 5 10:21:28.484694 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 5 10:21:28.489379 sshd[1724]: ssh_selinux_getctxbyname: Failed to get default SELinux security context for core Sep 5 10:21:28.539575 sshd[1724]: Connection closed by 10.0.0.1 port 36340 Sep 5 10:21:28.539942 sshd-session[1721]: pam_unix(sshd:session): session closed for user core Sep 5 10:21:28.553305 systemd[1]: sshd@3-10.0.0.92:22-10.0.0.1:36340.service: Deactivated successfully. Sep 5 10:21:28.555368 systemd[1]: session-4.scope: Deactivated successfully. Sep 5 10:21:28.556150 systemd-logind[1530]: Session 4 logged out. Waiting for processes to exit. Sep 5 10:21:28.558990 systemd[1]: Started sshd@4-10.0.0.92:22-10.0.0.1:36348.service - OpenSSH per-connection server daemon (10.0.0.1:36348). Sep 5 10:21:28.559820 systemd-logind[1530]: Removed session 4.