Nov 5 04:56:35.480092 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT_DYNAMIC Wed Nov 5 03:01:50 -00 2025 Nov 5 04:56:35.480148 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=9a076e14dca937d9663502c090e1ff4931f585a3752c3aa4c87feb67d6e5a465 Nov 5 04:56:35.480158 kernel: BIOS-provided physical RAM map: Nov 5 04:56:35.480169 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Nov 5 04:56:35.480185 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Nov 5 04:56:35.480202 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Nov 5 04:56:35.480210 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Nov 5 04:56:35.480217 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Nov 5 04:56:35.480227 kernel: BIOS-e820: [mem 0x000000000080c000-0x0000000000810fff] usable Nov 5 04:56:35.480233 kernel: BIOS-e820: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Nov 5 04:56:35.480240 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009bd3efff] usable Nov 5 04:56:35.480251 kernel: BIOS-e820: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Nov 5 04:56:35.480257 kernel: BIOS-e820: [mem 0x000000009be00000-0x000000009c8ecfff] usable Nov 5 04:56:35.480264 kernel: BIOS-e820: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Nov 5 04:56:35.480273 kernel: BIOS-e820: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Nov 5 04:56:35.480281 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Nov 5 04:56:35.480293 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009ce90fff] usable Nov 5 04:56:35.480301 kernel: BIOS-e820: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Nov 5 04:56:35.480308 kernel: BIOS-e820: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Nov 5 04:56:35.480316 kernel: BIOS-e820: [mem 0x000000009ce97000-0x000000009cedbfff] usable Nov 5 04:56:35.480323 kernel: BIOS-e820: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Nov 5 04:56:35.480331 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Nov 5 04:56:35.480338 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Nov 5 04:56:35.480345 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 5 04:56:35.480353 kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Nov 5 04:56:35.480360 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 5 04:56:35.480370 kernel: NX (Execute Disable) protection: active Nov 5 04:56:35.480378 kernel: APIC: Static calls initialized Nov 5 04:56:35.480385 kernel: e820: update [mem 0x9b320018-0x9b329c57] usable ==> usable Nov 5 04:56:35.480393 kernel: e820: update [mem 0x9b2e3018-0x9b31fe57] usable ==> usable Nov 5 04:56:35.480400 kernel: extended physical RAM map: Nov 5 04:56:35.480408 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable Nov 5 04:56:35.480415 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable Nov 5 04:56:35.480423 kernel: reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Nov 5 04:56:35.480430 kernel: reserve setup_data: [mem 0x0000000000808000-0x000000000080afff] usable Nov 5 04:56:35.480438 kernel: reserve setup_data: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Nov 5 04:56:35.480445 kernel: reserve setup_data: [mem 0x000000000080c000-0x0000000000810fff] usable Nov 5 04:56:35.480469 kernel: reserve setup_data: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Nov 5 04:56:35.480477 kernel: reserve setup_data: [mem 0x0000000000900000-0x000000009b2e3017] usable Nov 5 04:56:35.480484 kernel: reserve setup_data: [mem 0x000000009b2e3018-0x000000009b31fe57] usable Nov 5 04:56:35.480496 kernel: reserve setup_data: [mem 0x000000009b31fe58-0x000000009b320017] usable Nov 5 04:56:35.480506 kernel: reserve setup_data: [mem 0x000000009b320018-0x000000009b329c57] usable Nov 5 04:56:35.480513 kernel: reserve setup_data: [mem 0x000000009b329c58-0x000000009bd3efff] usable Nov 5 04:56:35.480521 kernel: reserve setup_data: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Nov 5 04:56:35.480529 kernel: reserve setup_data: [mem 0x000000009be00000-0x000000009c8ecfff] usable Nov 5 04:56:35.480537 kernel: reserve setup_data: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Nov 5 04:56:35.480544 kernel: reserve setup_data: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Nov 5 04:56:35.480552 kernel: reserve setup_data: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Nov 5 04:56:35.480560 kernel: reserve setup_data: [mem 0x000000009cbff000-0x000000009ce90fff] usable Nov 5 04:56:35.480567 kernel: reserve setup_data: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Nov 5 04:56:35.480577 kernel: reserve setup_data: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Nov 5 04:56:35.480585 kernel: reserve setup_data: [mem 0x000000009ce97000-0x000000009cedbfff] usable Nov 5 04:56:35.480593 kernel: reserve setup_data: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Nov 5 04:56:35.480600 kernel: reserve setup_data: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Nov 5 04:56:35.480608 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Nov 5 04:56:35.480615 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 5 04:56:35.480623 kernel: reserve setup_data: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Nov 5 04:56:35.480631 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 5 04:56:35.480641 kernel: efi: EFI v2.7 by EDK II Nov 5 04:56:35.480649 kernel: efi: SMBIOS=0x9c988000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b9e4198 RNG=0x9cb73018 Nov 5 04:56:35.480657 kernel: random: crng init done Nov 5 04:56:35.480669 kernel: efi: Remove mem151: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map Nov 5 04:56:35.480677 kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved Nov 5 04:56:35.480686 kernel: secureboot: Secure boot disabled Nov 5 04:56:35.480694 kernel: SMBIOS 2.8 present. Nov 5 04:56:35.480702 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Nov 5 04:56:35.480709 kernel: DMI: Memory slots populated: 1/1 Nov 5 04:56:35.480717 kernel: Hypervisor detected: KVM Nov 5 04:56:35.480725 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 Nov 5 04:56:35.480732 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 5 04:56:35.480740 kernel: kvm-clock: using sched offset of 4932601328 cycles Nov 5 04:56:35.480748 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 5 04:56:35.480759 kernel: tsc: Detected 2794.750 MHz processor Nov 5 04:56:35.480767 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 5 04:56:35.480775 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 5 04:56:35.480783 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 Nov 5 04:56:35.480791 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Nov 5 04:56:35.480799 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 5 04:56:35.480807 kernel: Using GB pages for direct mapping Nov 5 04:56:35.480818 kernel: ACPI: Early table checksum verification disabled Nov 5 04:56:35.480826 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Nov 5 04:56:35.480834 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Nov 5 04:56:35.480842 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 5 04:56:35.480850 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 5 04:56:35.480858 kernel: ACPI: FACS 0x000000009CBDD000 000040 Nov 5 04:56:35.480867 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 5 04:56:35.480877 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 5 04:56:35.480885 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 5 04:56:35.480893 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 5 04:56:35.480901 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Nov 5 04:56:35.480909 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Nov 5 04:56:35.480917 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Nov 5 04:56:35.480926 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Nov 5 04:56:35.480933 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Nov 5 04:56:35.480944 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Nov 5 04:56:35.480952 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Nov 5 04:56:35.480959 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Nov 5 04:56:35.480968 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Nov 5 04:56:35.480976 kernel: No NUMA configuration found Nov 5 04:56:35.480984 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cedbfff] Nov 5 04:56:35.480992 kernel: NODE_DATA(0) allocated [mem 0x9ce36dc0-0x9ce3dfff] Nov 5 04:56:35.481002 kernel: Zone ranges: Nov 5 04:56:35.481010 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 5 04:56:35.481018 kernel: DMA32 [mem 0x0000000001000000-0x000000009cedbfff] Nov 5 04:56:35.481026 kernel: Normal empty Nov 5 04:56:35.481034 kernel: Device empty Nov 5 04:56:35.481042 kernel: Movable zone start for each node Nov 5 04:56:35.481049 kernel: Early memory node ranges Nov 5 04:56:35.481057 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Nov 5 04:56:35.481070 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Nov 5 04:56:35.481078 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Nov 5 04:56:35.481086 kernel: node 0: [mem 0x000000000080c000-0x0000000000810fff] Nov 5 04:56:35.481094 kernel: node 0: [mem 0x0000000000900000-0x000000009bd3efff] Nov 5 04:56:35.481102 kernel: node 0: [mem 0x000000009be00000-0x000000009c8ecfff] Nov 5 04:56:35.481110 kernel: node 0: [mem 0x000000009cbff000-0x000000009ce90fff] Nov 5 04:56:35.481118 kernel: node 0: [mem 0x000000009ce97000-0x000000009cedbfff] Nov 5 04:56:35.481130 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cedbfff] Nov 5 04:56:35.481146 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 5 04:56:35.481162 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Nov 5 04:56:35.481173 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Nov 5 04:56:35.481181 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 5 04:56:35.481189 kernel: On node 0, zone DMA: 239 pages in unavailable ranges Nov 5 04:56:35.481197 kernel: On node 0, zone DMA32: 193 pages in unavailable ranges Nov 5 04:56:35.481206 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Nov 5 04:56:35.481214 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Nov 5 04:56:35.481222 kernel: On node 0, zone DMA32: 12580 pages in unavailable ranges Nov 5 04:56:35.481233 kernel: ACPI: PM-Timer IO Port: 0x608 Nov 5 04:56:35.481241 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 5 04:56:35.481250 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Nov 5 04:56:35.481258 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Nov 5 04:56:35.481269 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 5 04:56:35.481277 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 5 04:56:35.481285 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 5 04:56:35.481294 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 5 04:56:35.481304 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 5 04:56:35.481313 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Nov 5 04:56:35.481323 kernel: TSC deadline timer available Nov 5 04:56:35.481334 kernel: CPU topo: Max. logical packages: 1 Nov 5 04:56:35.481343 kernel: CPU topo: Max. logical dies: 1 Nov 5 04:56:35.481351 kernel: CPU topo: Max. dies per package: 1 Nov 5 04:56:35.481359 kernel: CPU topo: Max. threads per core: 1 Nov 5 04:56:35.481367 kernel: CPU topo: Num. cores per package: 4 Nov 5 04:56:35.481375 kernel: CPU topo: Num. threads per package: 4 Nov 5 04:56:35.481383 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Nov 5 04:56:35.481392 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 5 04:56:35.481402 kernel: kvm-guest: KVM setup pv remote TLB flush Nov 5 04:56:35.481411 kernel: kvm-guest: setup PV sched yield Nov 5 04:56:35.481419 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Nov 5 04:56:35.481427 kernel: Booting paravirtualized kernel on KVM Nov 5 04:56:35.481436 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 5 04:56:35.481444 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Nov 5 04:56:35.481464 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Nov 5 04:56:35.481475 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Nov 5 04:56:35.481483 kernel: pcpu-alloc: [0] 0 1 2 3 Nov 5 04:56:35.481491 kernel: kvm-guest: PV spinlocks enabled Nov 5 04:56:35.481499 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 5 04:56:35.481512 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=9a076e14dca937d9663502c090e1ff4931f585a3752c3aa4c87feb67d6e5a465 Nov 5 04:56:35.481520 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 5 04:56:35.481531 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 5 04:56:35.481540 kernel: Fallback order for Node 0: 0 Nov 5 04:56:35.481548 kernel: Built 1 zonelists, mobility grouping on. Total pages: 641450 Nov 5 04:56:35.481556 kernel: Policy zone: DMA32 Nov 5 04:56:35.481564 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 5 04:56:35.481573 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 5 04:56:35.481581 kernel: ftrace: allocating 40092 entries in 157 pages Nov 5 04:56:35.481592 kernel: ftrace: allocated 157 pages with 5 groups Nov 5 04:56:35.481600 kernel: Dynamic Preempt: voluntary Nov 5 04:56:35.481608 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 5 04:56:35.481617 kernel: rcu: RCU event tracing is enabled. Nov 5 04:56:35.481625 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 5 04:56:35.481634 kernel: Trampoline variant of Tasks RCU enabled. Nov 5 04:56:35.481642 kernel: Rude variant of Tasks RCU enabled. Nov 5 04:56:35.481650 kernel: Tracing variant of Tasks RCU enabled. Nov 5 04:56:35.481661 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 5 04:56:35.481670 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 5 04:56:35.481680 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 5 04:56:35.481689 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 5 04:56:35.481697 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 5 04:56:35.481705 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Nov 5 04:56:35.481714 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 5 04:56:35.481724 kernel: Console: colour dummy device 80x25 Nov 5 04:56:35.481733 kernel: printk: legacy console [ttyS0] enabled Nov 5 04:56:35.481741 kernel: ACPI: Core revision 20240827 Nov 5 04:56:35.481749 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Nov 5 04:56:35.481758 kernel: APIC: Switch to symmetric I/O mode setup Nov 5 04:56:35.481766 kernel: x2apic enabled Nov 5 04:56:35.481774 kernel: APIC: Switched APIC routing to: physical x2apic Nov 5 04:56:35.481785 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Nov 5 04:56:35.481794 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Nov 5 04:56:35.481802 kernel: kvm-guest: setup PV IPIs Nov 5 04:56:35.481810 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Nov 5 04:56:35.481819 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Nov 5 04:56:35.481827 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Nov 5 04:56:35.481836 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Nov 5 04:56:35.481846 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Nov 5 04:56:35.481854 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Nov 5 04:56:35.481863 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 5 04:56:35.481871 kernel: Spectre V2 : Mitigation: Retpolines Nov 5 04:56:35.481880 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 5 04:56:35.481888 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Nov 5 04:56:35.481896 kernel: active return thunk: retbleed_return_thunk Nov 5 04:56:35.481907 kernel: RETBleed: Mitigation: untrained return thunk Nov 5 04:56:35.481917 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Nov 5 04:56:35.481926 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Nov 5 04:56:35.481934 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Nov 5 04:56:35.481943 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Nov 5 04:56:35.481952 kernel: active return thunk: srso_return_thunk Nov 5 04:56:35.481960 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Nov 5 04:56:35.481971 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 5 04:56:35.481979 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 5 04:56:35.481987 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 5 04:56:35.481996 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 5 04:56:35.482004 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Nov 5 04:56:35.482012 kernel: Freeing SMP alternatives memory: 32K Nov 5 04:56:35.482021 kernel: pid_max: default: 32768 minimum: 301 Nov 5 04:56:35.482031 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 5 04:56:35.482039 kernel: landlock: Up and running. Nov 5 04:56:35.482048 kernel: SELinux: Initializing. Nov 5 04:56:35.482056 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 5 04:56:35.482064 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 5 04:56:35.482073 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Nov 5 04:56:35.482081 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Nov 5 04:56:35.482092 kernel: ... version: 0 Nov 5 04:56:35.482100 kernel: ... bit width: 48 Nov 5 04:56:35.482108 kernel: ... generic registers: 6 Nov 5 04:56:35.482117 kernel: ... value mask: 0000ffffffffffff Nov 5 04:56:35.482125 kernel: ... max period: 00007fffffffffff Nov 5 04:56:35.482133 kernel: ... fixed-purpose events: 0 Nov 5 04:56:35.482149 kernel: ... event mask: 000000000000003f Nov 5 04:56:35.482160 kernel: signal: max sigframe size: 1776 Nov 5 04:56:35.482168 kernel: rcu: Hierarchical SRCU implementation. Nov 5 04:56:35.482177 kernel: rcu: Max phase no-delay instances is 400. Nov 5 04:56:35.482187 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Nov 5 04:56:35.482195 kernel: smp: Bringing up secondary CPUs ... Nov 5 04:56:35.482204 kernel: smpboot: x86: Booting SMP configuration: Nov 5 04:56:35.482212 kernel: .... node #0, CPUs: #1 #2 #3 Nov 5 04:56:35.482223 kernel: smp: Brought up 1 node, 4 CPUs Nov 5 04:56:35.482231 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Nov 5 04:56:35.482240 kernel: Memory: 2441100K/2565800K available (14336K kernel code, 2443K rwdata, 29892K rodata, 15348K init, 2696K bss, 118764K reserved, 0K cma-reserved) Nov 5 04:56:35.482248 kernel: devtmpfs: initialized Nov 5 04:56:35.482256 kernel: x86/mm: Memory block size: 128MB Nov 5 04:56:35.482265 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Nov 5 04:56:35.482273 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Nov 5 04:56:35.482284 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00811000-0x008fffff] (978944 bytes) Nov 5 04:56:35.482292 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Nov 5 04:56:35.482301 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9ce95000-0x9ce96fff] (8192 bytes) Nov 5 04:56:35.482309 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Nov 5 04:56:35.482318 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 5 04:56:35.482326 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 5 04:56:35.482335 kernel: pinctrl core: initialized pinctrl subsystem Nov 5 04:56:35.482346 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 5 04:56:35.482354 kernel: audit: initializing netlink subsys (disabled) Nov 5 04:56:35.482362 kernel: audit: type=2000 audit(1762318591.267:1): state=initialized audit_enabled=0 res=1 Nov 5 04:56:35.482371 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 5 04:56:35.482379 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 5 04:56:35.482387 kernel: cpuidle: using governor menu Nov 5 04:56:35.482395 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 5 04:56:35.482404 kernel: dca service started, version 1.12.1 Nov 5 04:56:35.482415 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Nov 5 04:56:35.482423 kernel: PCI: Using configuration type 1 for base access Nov 5 04:56:35.482431 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 5 04:56:35.482440 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 5 04:56:35.482448 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 5 04:56:35.482467 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 5 04:56:35.482476 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 5 04:56:35.482487 kernel: ACPI: Added _OSI(Module Device) Nov 5 04:56:35.482495 kernel: ACPI: Added _OSI(Processor Device) Nov 5 04:56:35.482503 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 5 04:56:35.482511 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 5 04:56:35.482520 kernel: ACPI: Interpreter enabled Nov 5 04:56:35.482528 kernel: ACPI: PM: (supports S0 S3 S5) Nov 5 04:56:35.482536 kernel: ACPI: Using IOAPIC for interrupt routing Nov 5 04:56:35.482547 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 5 04:56:35.482556 kernel: PCI: Using E820 reservations for host bridge windows Nov 5 04:56:35.482564 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Nov 5 04:56:35.482572 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 5 04:56:35.482836 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 5 04:56:35.483024 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Nov 5 04:56:35.483221 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Nov 5 04:56:35.483234 kernel: PCI host bridge to bus 0000:00 Nov 5 04:56:35.483415 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 5 04:56:35.483598 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 5 04:56:35.483767 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 5 04:56:35.483927 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Nov 5 04:56:35.484229 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Nov 5 04:56:35.484574 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Nov 5 04:56:35.484892 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 5 04:56:35.485126 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Nov 5 04:56:35.485369 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Nov 5 04:56:35.485580 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Nov 5 04:56:35.485849 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Nov 5 04:56:35.486023 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Nov 5 04:56:35.486206 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 5 04:56:35.486400 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Nov 5 04:56:35.486597 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Nov 5 04:56:35.486779 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Nov 5 04:56:35.486953 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Nov 5 04:56:35.487147 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Nov 5 04:56:35.487328 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Nov 5 04:56:35.487738 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Nov 5 04:56:35.487939 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Nov 5 04:56:35.488123 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Nov 5 04:56:35.488311 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Nov 5 04:56:35.488503 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Nov 5 04:56:35.488678 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Nov 5 04:56:35.488862 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Nov 5 04:56:35.489051 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Nov 5 04:56:35.489235 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Nov 5 04:56:35.489417 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Nov 5 04:56:35.489612 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Nov 5 04:56:35.489786 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Nov 5 04:56:35.489969 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Nov 5 04:56:35.490159 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Nov 5 04:56:35.490171 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 5 04:56:35.490180 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 5 04:56:35.490189 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 5 04:56:35.490197 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 5 04:56:35.490205 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Nov 5 04:56:35.490218 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Nov 5 04:56:35.490226 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Nov 5 04:56:35.490234 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Nov 5 04:56:35.490243 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Nov 5 04:56:35.490251 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Nov 5 04:56:35.490260 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Nov 5 04:56:35.490268 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Nov 5 04:56:35.490279 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Nov 5 04:56:35.490287 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Nov 5 04:56:35.490296 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Nov 5 04:56:35.490304 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Nov 5 04:56:35.490313 kernel: iommu: Default domain type: Translated Nov 5 04:56:35.490323 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 5 04:56:35.490332 kernel: efivars: Registered efivars operations Nov 5 04:56:35.490345 kernel: PCI: Using ACPI for IRQ routing Nov 5 04:56:35.490353 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 5 04:56:35.490362 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Nov 5 04:56:35.490370 kernel: e820: reserve RAM buffer [mem 0x00811000-0x008fffff] Nov 5 04:56:35.490378 kernel: e820: reserve RAM buffer [mem 0x9b2e3018-0x9bffffff] Nov 5 04:56:35.490386 kernel: e820: reserve RAM buffer [mem 0x9b320018-0x9bffffff] Nov 5 04:56:35.490394 kernel: e820: reserve RAM buffer [mem 0x9bd3f000-0x9bffffff] Nov 5 04:56:35.490406 kernel: e820: reserve RAM buffer [mem 0x9c8ed000-0x9fffffff] Nov 5 04:56:35.490414 kernel: e820: reserve RAM buffer [mem 0x9ce91000-0x9fffffff] Nov 5 04:56:35.490423 kernel: e820: reserve RAM buffer [mem 0x9cedc000-0x9fffffff] Nov 5 04:56:35.490616 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Nov 5 04:56:35.490789 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Nov 5 04:56:35.490961 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 5 04:56:35.490973 kernel: vgaarb: loaded Nov 5 04:56:35.490986 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Nov 5 04:56:35.490994 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Nov 5 04:56:35.491002 kernel: clocksource: Switched to clocksource kvm-clock Nov 5 04:56:35.491011 kernel: VFS: Disk quotas dquot_6.6.0 Nov 5 04:56:35.491019 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 5 04:56:35.491028 kernel: pnp: PnP ACPI init Nov 5 04:56:35.491248 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Nov 5 04:56:35.491268 kernel: pnp: PnP ACPI: found 6 devices Nov 5 04:56:35.491277 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 5 04:56:35.491286 kernel: NET: Registered PF_INET protocol family Nov 5 04:56:35.491295 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 5 04:56:35.491304 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 5 04:56:35.491313 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 5 04:56:35.491324 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 5 04:56:35.491332 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 5 04:56:35.491341 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 5 04:56:35.491349 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 5 04:56:35.491358 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 5 04:56:35.491367 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 5 04:56:35.491375 kernel: NET: Registered PF_XDP protocol family Nov 5 04:56:35.491571 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Nov 5 04:56:35.491747 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Nov 5 04:56:35.491910 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 5 04:56:35.492071 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 5 04:56:35.492245 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 5 04:56:35.492407 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Nov 5 04:56:35.492588 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Nov 5 04:56:35.492750 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Nov 5 04:56:35.492761 kernel: PCI: CLS 0 bytes, default 64 Nov 5 04:56:35.492770 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Nov 5 04:56:35.492784 kernel: Initialise system trusted keyrings Nov 5 04:56:35.492795 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 5 04:56:35.492803 kernel: Key type asymmetric registered Nov 5 04:56:35.492812 kernel: Asymmetric key parser 'x509' registered Nov 5 04:56:35.492821 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 5 04:56:35.492829 kernel: io scheduler mq-deadline registered Nov 5 04:56:35.492838 kernel: io scheduler kyber registered Nov 5 04:56:35.492846 kernel: io scheduler bfq registered Nov 5 04:56:35.492858 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 5 04:56:35.492867 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Nov 5 04:56:35.492875 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Nov 5 04:56:35.492884 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Nov 5 04:56:35.492893 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 5 04:56:35.492901 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 5 04:56:35.492910 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 5 04:56:35.492921 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 5 04:56:35.492930 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 5 04:56:35.493111 kernel: rtc_cmos 00:04: RTC can wake from S4 Nov 5 04:56:35.493124 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Nov 5 04:56:35.493300 kernel: rtc_cmos 00:04: registered as rtc0 Nov 5 04:56:35.493503 kernel: rtc_cmos 00:04: setting system clock to 2025-11-05T04:56:33 UTC (1762318593) Nov 5 04:56:35.493682 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Nov 5 04:56:35.493694 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Nov 5 04:56:35.493703 kernel: efifb: probing for efifb Nov 5 04:56:35.493711 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Nov 5 04:56:35.493720 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Nov 5 04:56:35.493729 kernel: efifb: scrolling: redraw Nov 5 04:56:35.493737 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Nov 5 04:56:35.493750 kernel: Console: switching to colour frame buffer device 160x50 Nov 5 04:56:35.493759 kernel: fb0: EFI VGA frame buffer device Nov 5 04:56:35.493767 kernel: pstore: Using crash dump compression: deflate Nov 5 04:56:35.493776 kernel: pstore: Registered efi_pstore as persistent store backend Nov 5 04:56:35.493785 kernel: NET: Registered PF_INET6 protocol family Nov 5 04:56:35.493793 kernel: Segment Routing with IPv6 Nov 5 04:56:35.493802 kernel: In-situ OAM (IOAM) with IPv6 Nov 5 04:56:35.493810 kernel: NET: Registered PF_PACKET protocol family Nov 5 04:56:35.493822 kernel: Key type dns_resolver registered Nov 5 04:56:35.493830 kernel: IPI shorthand broadcast: enabled Nov 5 04:56:35.493839 kernel: sched_clock: Marking stable (2157002638, 282612910)->(2494838100, -55222552) Nov 5 04:56:35.493847 kernel: registered taskstats version 1 Nov 5 04:56:35.493856 kernel: Loading compiled-in X.509 certificates Nov 5 04:56:35.493865 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: cfd469c5acf75e2b7be33dd554bbf88cbfe73c93' Nov 5 04:56:35.493874 kernel: Demotion targets for Node 0: null Nov 5 04:56:35.493884 kernel: Key type .fscrypt registered Nov 5 04:56:35.493893 kernel: Key type fscrypt-provisioning registered Nov 5 04:56:35.493901 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 5 04:56:35.493910 kernel: ima: Allocated hash algorithm: sha1 Nov 5 04:56:35.493918 kernel: ima: No architecture policies found Nov 5 04:56:35.493927 kernel: clk: Disabling unused clocks Nov 5 04:56:35.493936 kernel: Freeing unused kernel image (initmem) memory: 15348K Nov 5 04:56:35.493947 kernel: Write protecting the kernel read-only data: 45056k Nov 5 04:56:35.493955 kernel: Freeing unused kernel image (rodata/data gap) memory: 828K Nov 5 04:56:35.493964 kernel: Run /init as init process Nov 5 04:56:35.493972 kernel: with arguments: Nov 5 04:56:35.493981 kernel: /init Nov 5 04:56:35.493989 kernel: with environment: Nov 5 04:56:35.493998 kernel: HOME=/ Nov 5 04:56:35.494009 kernel: TERM=linux Nov 5 04:56:35.494017 kernel: SCSI subsystem initialized Nov 5 04:56:35.494026 kernel: libata version 3.00 loaded. Nov 5 04:56:35.494211 kernel: ahci 0000:00:1f.2: version 3.0 Nov 5 04:56:35.494224 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Nov 5 04:56:35.494514 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Nov 5 04:56:35.494695 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Nov 5 04:56:35.494891 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Nov 5 04:56:35.495104 kernel: scsi host0: ahci Nov 5 04:56:35.495310 kernel: scsi host1: ahci Nov 5 04:56:35.495526 kernel: scsi host2: ahci Nov 5 04:56:35.495738 kernel: scsi host3: ahci Nov 5 04:56:35.495940 kernel: scsi host4: ahci Nov 5 04:56:35.496127 kernel: scsi host5: ahci Nov 5 04:56:35.496152 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 26 lpm-pol 1 Nov 5 04:56:35.496161 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 26 lpm-pol 1 Nov 5 04:56:35.496170 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 26 lpm-pol 1 Nov 5 04:56:35.496178 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 26 lpm-pol 1 Nov 5 04:56:35.496190 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 26 lpm-pol 1 Nov 5 04:56:35.496199 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 26 lpm-pol 1 Nov 5 04:56:35.496208 kernel: ata6: SATA link down (SStatus 0 SControl 300) Nov 5 04:56:35.496217 kernel: ata1: SATA link down (SStatus 0 SControl 300) Nov 5 04:56:35.496225 kernel: ata2: SATA link down (SStatus 0 SControl 300) Nov 5 04:56:35.496234 kernel: ata4: SATA link down (SStatus 0 SControl 300) Nov 5 04:56:35.496242 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Nov 5 04:56:35.496254 kernel: ata5: SATA link down (SStatus 0 SControl 300) Nov 5 04:56:35.496262 kernel: ata3.00: LPM support broken, forcing max_power Nov 5 04:56:35.496271 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Nov 5 04:56:35.496279 kernel: ata3.00: applying bridge limits Nov 5 04:56:35.496288 kernel: ata3.00: LPM support broken, forcing max_power Nov 5 04:56:35.496296 kernel: ata3.00: configured for UDMA/100 Nov 5 04:56:35.496532 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Nov 5 04:56:35.496789 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Nov 5 04:56:35.496967 kernel: virtio_blk virtio1: [vda] 27000832 512-byte logical blocks (13.8 GB/12.9 GiB) Nov 5 04:56:35.496980 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 5 04:56:35.496989 kernel: GPT:16515071 != 27000831 Nov 5 04:56:35.496998 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 5 04:56:35.497006 kernel: GPT:16515071 != 27000831 Nov 5 04:56:35.497019 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 5 04:56:35.497028 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 5 04:56:35.497234 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Nov 5 04:56:35.497247 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Nov 5 04:56:35.497438 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Nov 5 04:56:35.497472 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 5 04:56:35.497481 kernel: device-mapper: uevent: version 1.0.3 Nov 5 04:56:35.497494 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 5 04:56:35.497503 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Nov 5 04:56:35.497512 kernel: raid6: avx2x4 gen() 30055 MB/s Nov 5 04:56:35.497527 kernel: raid6: avx2x2 gen() 26179 MB/s Nov 5 04:56:35.497544 kernel: raid6: avx2x1 gen() 25267 MB/s Nov 5 04:56:35.497555 kernel: raid6: using algorithm avx2x4 gen() 30055 MB/s Nov 5 04:56:35.497564 kernel: raid6: .... xor() 7195 MB/s, rmw enabled Nov 5 04:56:35.497576 kernel: raid6: using avx2x2 recovery algorithm Nov 5 04:56:35.497585 kernel: xor: automatically using best checksumming function avx Nov 5 04:56:35.497594 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 5 04:56:35.497603 kernel: BTRFS: device fsid 8119ddf0-7fda-4d84-ad78-3566733896c1 devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (181) Nov 5 04:56:35.497612 kernel: BTRFS info (device dm-0): first mount of filesystem 8119ddf0-7fda-4d84-ad78-3566733896c1 Nov 5 04:56:35.497620 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 5 04:56:35.497629 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 5 04:56:35.497641 kernel: BTRFS info (device dm-0): enabling free space tree Nov 5 04:56:35.497649 kernel: loop: module loaded Nov 5 04:56:35.497658 kernel: loop0: detected capacity change from 0 to 100136 Nov 5 04:56:35.497667 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 5 04:56:35.497677 systemd[1]: Successfully made /usr/ read-only. Nov 5 04:56:35.497688 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 5 04:56:35.497701 systemd[1]: Detected virtualization kvm. Nov 5 04:56:35.497710 systemd[1]: Detected architecture x86-64. Nov 5 04:56:35.497719 systemd[1]: Running in initrd. Nov 5 04:56:35.497728 systemd[1]: No hostname configured, using default hostname. Nov 5 04:56:35.497737 systemd[1]: Hostname set to . Nov 5 04:56:35.497746 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 5 04:56:35.497755 systemd[1]: Queued start job for default target initrd.target. Nov 5 04:56:35.497767 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 5 04:56:35.497776 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 5 04:56:35.497786 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 5 04:56:35.497795 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 5 04:56:35.497805 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 5 04:56:35.497815 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 5 04:56:35.497828 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 5 04:56:35.497837 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 5 04:56:35.497846 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 5 04:56:35.497855 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 5 04:56:35.497865 systemd[1]: Reached target paths.target - Path Units. Nov 5 04:56:35.497874 systemd[1]: Reached target slices.target - Slice Units. Nov 5 04:56:35.497886 systemd[1]: Reached target swap.target - Swaps. Nov 5 04:56:35.497895 systemd[1]: Reached target timers.target - Timer Units. Nov 5 04:56:35.497904 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 5 04:56:35.497913 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 5 04:56:35.497922 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 5 04:56:35.497932 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 5 04:56:35.497941 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 5 04:56:35.497953 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 5 04:56:35.497962 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 5 04:56:35.497971 systemd[1]: Reached target sockets.target - Socket Units. Nov 5 04:56:35.497980 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 5 04:56:35.497990 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 5 04:56:35.497999 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 5 04:56:35.498008 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 5 04:56:35.498020 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Nov 5 04:56:35.498029 systemd[1]: Starting systemd-fsck-usr.service... Nov 5 04:56:35.498039 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 5 04:56:35.498048 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 5 04:56:35.498057 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 5 04:56:35.498069 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 5 04:56:35.498079 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 5 04:56:35.498088 systemd[1]: Finished systemd-fsck-usr.service. Nov 5 04:56:35.498097 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 5 04:56:35.498151 systemd-journald[317]: Collecting audit messages is disabled. Nov 5 04:56:35.498176 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 5 04:56:35.498185 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 5 04:56:35.498195 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 5 04:56:35.498207 kernel: Bridge firewalling registered Nov 5 04:56:35.498216 systemd-journald[317]: Journal started Nov 5 04:56:35.498234 systemd-journald[317]: Runtime Journal (/run/log/journal/e1e3fd95d5984ce09a1ab027bd0d77d0) is 6M, max 48.1M, 42M free. Nov 5 04:56:35.497573 systemd-modules-load[319]: Inserted module 'br_netfilter' Nov 5 04:56:35.504895 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 5 04:56:35.509511 systemd[1]: Started systemd-journald.service - Journal Service. Nov 5 04:56:35.511329 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 5 04:56:35.517374 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 5 04:56:35.520042 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 5 04:56:35.624918 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 5 04:56:35.629028 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 5 04:56:35.643159 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 5 04:56:35.644960 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 5 04:56:35.646533 systemd-tmpfiles[341]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 5 04:56:35.652915 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 5 04:56:35.657891 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 5 04:56:35.663295 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 5 04:56:35.698281 dracut-cmdline[360]: 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=9a076e14dca937d9663502c090e1ff4931f585a3752c3aa4c87feb67d6e5a465 Nov 5 04:56:35.719803 systemd-resolved[355]: Positive Trust Anchors: Nov 5 04:56:35.719817 systemd-resolved[355]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 5 04:56:35.719821 systemd-resolved[355]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 5 04:56:35.719852 systemd-resolved[355]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Nov 5 04:56:35.739472 systemd-resolved[355]: Defaulting to hostname 'linux'. Nov 5 04:56:35.742964 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 5 04:56:35.745001 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 5 04:56:35.821491 kernel: Loading iSCSI transport class v2.0-870. Nov 5 04:56:35.835500 kernel: iscsi: registered transport (tcp) Nov 5 04:56:35.862489 kernel: iscsi: registered transport (qla4xxx) Nov 5 04:56:35.862526 kernel: QLogic iSCSI HBA Driver Nov 5 04:56:35.891677 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 5 04:56:35.925267 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 5 04:56:35.926677 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 5 04:56:35.996572 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 5 04:56:35.998930 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 5 04:56:36.046409 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 5 04:56:36.095229 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 5 04:56:36.098357 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 5 04:56:36.135814 systemd-udevd[596]: Using default interface naming scheme 'v257'. Nov 5 04:56:36.151274 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 5 04:56:36.158208 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 5 04:56:36.194775 dracut-pre-trigger[663]: rd.md=0: removing MD RAID activation Nov 5 04:56:36.196000 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 5 04:56:36.201349 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 5 04:56:36.232801 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 5 04:56:36.236345 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 5 04:56:36.260301 systemd-networkd[710]: lo: Link UP Nov 5 04:56:36.260309 systemd-networkd[710]: lo: Gained carrier Nov 5 04:56:36.261330 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 5 04:56:36.261895 systemd[1]: Reached target network.target - Network. Nov 5 04:56:36.332265 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 5 04:56:36.336321 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 5 04:56:36.401693 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 5 04:56:36.414036 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 5 04:56:36.427599 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 5 04:56:36.440419 kernel: cryptd: max_cpu_qlen set to 1000 Nov 5 04:56:36.440476 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Nov 5 04:56:36.442927 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 5 04:56:36.449971 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 5 04:56:36.467480 kernel: AES CTR mode by8 optimization enabled Nov 5 04:56:36.469213 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 5 04:56:36.469261 systemd-networkd[710]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 5 04:56:36.469267 systemd-networkd[710]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 5 04:56:36.480053 disk-uuid[780]: Primary Header is updated. Nov 5 04:56:36.480053 disk-uuid[780]: Secondary Entries is updated. Nov 5 04:56:36.480053 disk-uuid[780]: Secondary Header is updated. Nov 5 04:56:36.471243 systemd-networkd[710]: eth0: Link UP Nov 5 04:56:36.471485 systemd-networkd[710]: eth0: Gained carrier Nov 5 04:56:36.471494 systemd-networkd[710]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 5 04:56:36.473759 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 5 04:56:36.478023 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 5 04:56:36.486351 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 5 04:56:36.498596 systemd-networkd[710]: eth0: DHCPv4 address 10.0.0.130/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 5 04:56:36.540130 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 5 04:56:36.580318 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 5 04:56:36.581018 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 5 04:56:36.585729 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 5 04:56:36.587685 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 5 04:56:36.594281 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 5 04:56:36.635907 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 5 04:56:37.539977 disk-uuid[787]: Warning: The kernel is still using the old partition table. Nov 5 04:56:37.539977 disk-uuid[787]: The new table will be used at the next reboot or after you Nov 5 04:56:37.539977 disk-uuid[787]: run partprobe(8) or kpartx(8) Nov 5 04:56:37.539977 disk-uuid[787]: The operation has completed successfully. Nov 5 04:56:37.551012 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 5 04:56:37.551200 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 5 04:56:37.556173 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 5 04:56:37.609863 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (864) Nov 5 04:56:37.609926 kernel: BTRFS info (device vda6): first mount of filesystem e7137982-ac37-41c2-8fd6-d0cf0728ebd4 Nov 5 04:56:37.609938 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 5 04:56:37.615179 kernel: BTRFS info (device vda6): turning on async discard Nov 5 04:56:37.615211 kernel: BTRFS info (device vda6): enabling free space tree Nov 5 04:56:37.623470 kernel: BTRFS info (device vda6): last unmount of filesystem e7137982-ac37-41c2-8fd6-d0cf0728ebd4 Nov 5 04:56:37.624117 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 5 04:56:37.627308 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 5 04:56:37.804328 ignition[883]: Ignition 2.22.0 Nov 5 04:56:37.805929 ignition[883]: Stage: fetch-offline Nov 5 04:56:37.805993 ignition[883]: no configs at "/usr/lib/ignition/base.d" Nov 5 04:56:37.806010 ignition[883]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 5 04:56:37.806123 ignition[883]: parsed url from cmdline: "" Nov 5 04:56:37.806128 ignition[883]: no config URL provided Nov 5 04:56:37.806133 ignition[883]: reading system config file "/usr/lib/ignition/user.ign" Nov 5 04:56:37.806148 ignition[883]: no config at "/usr/lib/ignition/user.ign" Nov 5 04:56:37.806194 ignition[883]: op(1): [started] loading QEMU firmware config module Nov 5 04:56:37.806204 ignition[883]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 5 04:56:37.824188 ignition[883]: op(1): [finished] loading QEMU firmware config module Nov 5 04:56:37.853303 ignition[883]: parsing config with SHA512: f6049ac13b382afa800ffa00c3db3306c233353e921cce2aa20a4ed5cc2cdc0277918fec24c7a95a917ad6b6bb1f0cc59fc06d2bf2c4df6faed83968b44023ce Nov 5 04:56:37.870338 unknown[883]: fetched base config from "system" Nov 5 04:56:37.870353 unknown[883]: fetched user config from "qemu" Nov 5 04:56:37.870642 ignition[883]: fetch-offline: fetch-offline passed Nov 5 04:56:37.870779 ignition[883]: Ignition finished successfully Nov 5 04:56:37.875393 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 5 04:56:37.878745 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 5 04:56:37.879901 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 5 04:56:37.921556 ignition[892]: Ignition 2.22.0 Nov 5 04:56:37.921570 ignition[892]: Stage: kargs Nov 5 04:56:37.921760 ignition[892]: no configs at "/usr/lib/ignition/base.d" Nov 5 04:56:37.921772 ignition[892]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 5 04:56:37.922821 ignition[892]: kargs: kargs passed Nov 5 04:56:37.922866 ignition[892]: Ignition finished successfully Nov 5 04:56:37.927812 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 5 04:56:37.933549 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 5 04:56:37.991125 ignition[900]: Ignition 2.22.0 Nov 5 04:56:37.991151 ignition[900]: Stage: disks Nov 5 04:56:37.991599 ignition[900]: no configs at "/usr/lib/ignition/base.d" Nov 5 04:56:37.991673 ignition[900]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 5 04:56:37.994667 ignition[900]: disks: disks passed Nov 5 04:56:37.994773 ignition[900]: Ignition finished successfully Nov 5 04:56:38.004101 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 5 04:56:38.007983 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 5 04:56:38.008120 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 5 04:56:38.011839 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 5 04:56:38.015809 systemd[1]: Reached target sysinit.target - System Initialization. Nov 5 04:56:38.019021 systemd[1]: Reached target basic.target - Basic System. Nov 5 04:56:38.023937 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 5 04:56:38.030656 systemd-networkd[710]: eth0: Gained IPv6LL Nov 5 04:56:38.081023 systemd-fsck[910]: ROOT: clean, 15/456736 files, 38230/456704 blocks Nov 5 04:56:38.089504 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 5 04:56:38.095666 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 5 04:56:38.251485 kernel: EXT4-fs (vda9): mounted filesystem d6ba737d-b2ad-4de6-9309-ffb105e40987 r/w with ordered data mode. Quota mode: none. Nov 5 04:56:38.251822 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 5 04:56:38.252936 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 5 04:56:38.258282 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 5 04:56:38.261283 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 5 04:56:38.263638 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 5 04:56:38.263701 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 5 04:56:38.263744 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 5 04:56:38.279691 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 5 04:56:38.285606 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 5 04:56:38.294226 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (918) Nov 5 04:56:38.294252 kernel: BTRFS info (device vda6): first mount of filesystem e7137982-ac37-41c2-8fd6-d0cf0728ebd4 Nov 5 04:56:38.294284 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 5 04:56:38.294312 kernel: BTRFS info (device vda6): turning on async discard Nov 5 04:56:38.294338 kernel: BTRFS info (device vda6): enabling free space tree Nov 5 04:56:38.293791 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 5 04:56:38.363504 initrd-setup-root[942]: cut: /sysroot/etc/passwd: No such file or directory Nov 5 04:56:38.369737 initrd-setup-root[949]: cut: /sysroot/etc/group: No such file or directory Nov 5 04:56:38.375809 initrd-setup-root[956]: cut: /sysroot/etc/shadow: No such file or directory Nov 5 04:56:38.379925 initrd-setup-root[963]: cut: /sysroot/etc/gshadow: No such file or directory Nov 5 04:56:38.482534 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 5 04:56:38.485885 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 5 04:56:38.488351 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 5 04:56:38.525469 kernel: BTRFS info (device vda6): last unmount of filesystem e7137982-ac37-41c2-8fd6-d0cf0728ebd4 Nov 5 04:56:38.546634 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 5 04:56:38.680992 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 5 04:56:38.685943 ignition[1032]: INFO : Ignition 2.22.0 Nov 5 04:56:38.685943 ignition[1032]: INFO : Stage: mount Nov 5 04:56:38.688569 ignition[1032]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 5 04:56:38.688569 ignition[1032]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 5 04:56:38.688569 ignition[1032]: INFO : mount: mount passed Nov 5 04:56:38.688569 ignition[1032]: INFO : Ignition finished successfully Nov 5 04:56:38.689886 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 5 04:56:38.693202 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 5 04:56:38.718202 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 5 04:56:38.731480 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1044) Nov 5 04:56:38.734693 kernel: BTRFS info (device vda6): first mount of filesystem e7137982-ac37-41c2-8fd6-d0cf0728ebd4 Nov 5 04:56:38.734718 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 5 04:56:38.738658 kernel: BTRFS info (device vda6): turning on async discard Nov 5 04:56:38.738681 kernel: BTRFS info (device vda6): enabling free space tree Nov 5 04:56:38.740579 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 5 04:56:38.780866 ignition[1061]: INFO : Ignition 2.22.0 Nov 5 04:56:38.780866 ignition[1061]: INFO : Stage: files Nov 5 04:56:38.783802 ignition[1061]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 5 04:56:38.783802 ignition[1061]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 5 04:56:38.783802 ignition[1061]: DEBUG : files: compiled without relabeling support, skipping Nov 5 04:56:38.783802 ignition[1061]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 5 04:56:38.783802 ignition[1061]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/dev-container-script" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/dev-container-script" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/download-library.sh" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/download-library.sh" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/home/core/main-script" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/home/core/main-script" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Nov 5 04:56:38.794307 ignition[1061]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 5 04:56:38.786940 unknown[1061]: wrote ssh authorized keys file for user: core Nov 5 04:56:38.836246 ignition[1061]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 5 04:56:38.836246 ignition[1061]: INFO : files: files passed Nov 5 04:56:38.836246 ignition[1061]: INFO : Ignition finished successfully Nov 5 04:56:38.828856 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 5 04:56:38.834300 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 5 04:56:38.837158 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 5 04:56:38.861208 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 5 04:56:38.870756 initrd-setup-root-after-ignition[1096]: grep: /sysroot/oem/oem-release: No such file or directory Nov 5 04:56:38.861381 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 5 04:56:38.874742 initrd-setup-root-after-ignition[1098]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 5 04:56:38.874742 initrd-setup-root-after-ignition[1098]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 5 04:56:38.874437 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 5 04:56:38.885315 initrd-setup-root-after-ignition[1102]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 5 04:56:38.877435 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 5 04:56:38.880348 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 5 04:56:38.951319 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 5 04:56:38.951494 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 5 04:56:38.953200 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 5 04:56:38.956867 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 5 04:56:38.963257 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 5 04:56:38.966034 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 5 04:56:39.004229 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 5 04:56:39.007769 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 5 04:56:39.038295 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 5 04:56:39.038624 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 5 04:56:39.044072 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 5 04:56:39.044311 systemd[1]: Stopped target timers.target - Timer Units. Nov 5 04:56:39.047944 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 5 04:56:39.048155 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 5 04:56:39.055920 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 5 04:56:39.056162 systemd[1]: Stopped target basic.target - Basic System. Nov 5 04:56:39.062347 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 5 04:56:39.062549 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 5 04:56:39.065953 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 5 04:56:39.072944 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 5 04:56:39.073149 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 5 04:56:39.076570 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 5 04:56:39.077166 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 5 04:56:39.077987 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 5 04:56:39.089852 systemd[1]: Stopped target swap.target - Swaps. Nov 5 04:56:39.090044 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 5 04:56:39.090239 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 5 04:56:39.097254 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 5 04:56:39.097481 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 5 04:56:39.100692 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 5 04:56:39.105689 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 5 04:56:39.105840 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 5 04:56:39.105968 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 5 04:56:39.114317 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 5 04:56:39.114501 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 5 04:56:39.116212 systemd[1]: Stopped target paths.target - Path Units. Nov 5 04:56:39.119635 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 5 04:56:39.125555 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 5 04:56:39.125735 systemd[1]: Stopped target slices.target - Slice Units. Nov 5 04:56:39.129922 systemd[1]: Stopped target sockets.target - Socket Units. Nov 5 04:56:39.130486 systemd[1]: iscsid.socket: Deactivated successfully. Nov 5 04:56:39.130597 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 5 04:56:39.135609 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 5 04:56:39.135736 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 5 04:56:39.136417 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 5 04:56:39.136612 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 5 04:56:39.141168 systemd[1]: ignition-files.service: Deactivated successfully. Nov 5 04:56:39.141319 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 5 04:56:39.149356 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 5 04:56:39.156944 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 5 04:56:39.157066 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 5 04:56:39.157204 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 5 04:56:39.163630 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 5 04:56:39.163841 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 5 04:56:39.166140 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 5 04:56:39.166347 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 5 04:56:39.178565 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 5 04:56:39.178698 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 5 04:56:39.194302 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 5 04:56:39.199260 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 5 04:56:39.199406 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 5 04:56:39.216533 ignition[1124]: INFO : Ignition 2.22.0 Nov 5 04:56:39.216533 ignition[1124]: INFO : Stage: umount Nov 5 04:56:39.219073 ignition[1124]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 5 04:56:39.219073 ignition[1124]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 5 04:56:39.219073 ignition[1124]: INFO : umount: umount passed Nov 5 04:56:39.219073 ignition[1124]: INFO : Ignition finished successfully Nov 5 04:56:39.222430 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 5 04:56:39.222587 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 5 04:56:39.225972 systemd[1]: Stopped target network.target - Network. Nov 5 04:56:39.228563 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 5 04:56:39.228627 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 5 04:56:39.230126 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 5 04:56:39.230176 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 5 04:56:39.230940 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 5 04:56:39.230996 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 5 04:56:39.238270 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 5 04:56:39.238323 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 5 04:56:39.240051 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 5 04:56:39.240108 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 5 04:56:39.243793 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 5 04:56:39.247288 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 5 04:56:39.258144 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 5 04:56:39.258292 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 5 04:56:39.271991 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 5 04:56:39.272196 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 5 04:56:39.278672 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 5 04:56:39.278813 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 5 04:56:39.278859 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 5 04:56:39.287194 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 5 04:56:39.288677 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 5 04:56:39.288760 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 5 04:56:39.290431 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 5 04:56:39.290539 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 5 04:56:39.290939 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 5 04:56:39.290986 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 5 04:56:39.291514 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 5 04:56:39.323835 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 5 04:56:39.324136 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 5 04:56:39.327516 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 5 04:56:39.327604 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 5 04:56:39.331689 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 5 04:56:39.331742 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 5 04:56:39.333361 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 5 04:56:39.333418 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 5 04:56:39.339979 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 5 04:56:39.340102 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 5 04:56:39.344931 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 5 04:56:39.345001 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 5 04:56:39.355919 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 5 04:56:39.359738 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 5 04:56:39.359814 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 5 04:56:39.360225 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 5 04:56:39.360276 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 5 04:56:39.369153 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 5 04:56:39.369212 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 5 04:56:39.373562 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 5 04:56:39.373619 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 5 04:56:39.377838 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 5 04:56:39.377921 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 5 04:56:39.382353 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 5 04:56:39.382484 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 5 04:56:39.385712 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 5 04:56:39.385814 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 5 04:56:39.391321 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 5 04:56:39.393529 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 5 04:56:39.422481 systemd[1]: Switching root. Nov 5 04:56:39.465159 systemd-journald[317]: Journal stopped Nov 5 04:56:40.466843 systemd-journald[317]: Received SIGTERM from PID 1 (systemd). Nov 5 04:56:40.466919 kernel: SELinux: policy capability network_peer_controls=1 Nov 5 04:56:40.466937 kernel: SELinux: policy capability open_perms=1 Nov 5 04:56:40.466950 kernel: SELinux: policy capability extended_socket_class=1 Nov 5 04:56:40.466963 kernel: SELinux: policy capability always_check_network=0 Nov 5 04:56:40.467075 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 5 04:56:40.467088 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 5 04:56:40.467100 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 5 04:56:40.467113 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 5 04:56:40.467130 kernel: SELinux: policy capability userspace_initial_context=0 Nov 5 04:56:40.467142 kernel: audit: type=1403 audit(1762318599.556:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 5 04:56:40.467160 systemd[1]: Successfully loaded SELinux policy in 69.551ms. Nov 5 04:56:40.467191 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.364ms. Nov 5 04:56:40.467205 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 5 04:56:40.467219 systemd[1]: Detected virtualization kvm. Nov 5 04:56:40.467232 systemd[1]: Detected architecture x86-64. Nov 5 04:56:40.467244 systemd[1]: Detected first boot. Nov 5 04:56:40.467257 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 5 04:56:40.467269 zram_generator::config[1170]: No configuration found. Nov 5 04:56:40.467291 kernel: Guest personality initialized and is inactive Nov 5 04:56:40.467303 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Nov 5 04:56:40.467315 kernel: Initialized host personality Nov 5 04:56:40.467327 kernel: NET: Registered PF_VSOCK protocol family Nov 5 04:56:40.467343 systemd[1]: Populated /etc with preset unit settings. Nov 5 04:56:40.467356 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 5 04:56:40.467369 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 5 04:56:40.467390 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 5 04:56:40.467404 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 5 04:56:40.467424 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 5 04:56:40.467445 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 5 04:56:40.467479 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 5 04:56:40.467500 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 5 04:56:40.467513 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 5 04:56:40.467526 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 5 04:56:40.467539 systemd[1]: Created slice user.slice - User and Session Slice. Nov 5 04:56:40.467552 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 5 04:56:40.467569 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 5 04:56:40.467590 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 5 04:56:40.467603 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 5 04:56:40.467616 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 5 04:56:40.467633 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 5 04:56:40.467649 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 5 04:56:40.467666 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 5 04:56:40.467704 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 5 04:56:40.467723 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 5 04:56:40.467740 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 5 04:56:40.467755 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 5 04:56:40.467771 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 5 04:56:40.467786 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 5 04:56:40.467802 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 5 04:56:40.467830 systemd[1]: Reached target slices.target - Slice Units. Nov 5 04:56:40.467846 systemd[1]: Reached target swap.target - Swaps. Nov 5 04:56:40.467862 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 5 04:56:40.467878 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 5 04:56:40.467894 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 5 04:56:40.467910 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 5 04:56:40.467925 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 5 04:56:40.467942 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 5 04:56:40.467967 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 5 04:56:40.467983 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 5 04:56:40.468008 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 5 04:56:40.468024 systemd[1]: Mounting media.mount - External Media Directory... Nov 5 04:56:40.468040 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:40.468066 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 5 04:56:40.468082 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 5 04:56:40.468108 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 5 04:56:40.468125 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 5 04:56:40.468140 systemd[1]: Reached target machines.target - Containers. Nov 5 04:56:40.468162 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 5 04:56:40.468180 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 5 04:56:40.468197 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 5 04:56:40.468228 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 5 04:56:40.468247 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 5 04:56:40.468264 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 5 04:56:40.468282 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 5 04:56:40.468299 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 5 04:56:40.468321 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 5 04:56:40.468340 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 5 04:56:40.468369 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 5 04:56:40.468388 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 5 04:56:40.468406 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 5 04:56:40.468424 systemd[1]: Stopped systemd-fsck-usr.service. Nov 5 04:56:40.468442 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 5 04:56:40.468480 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 5 04:56:40.468513 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 5 04:56:40.468544 kernel: ACPI: bus type drm_connector registered Nov 5 04:56:40.468561 kernel: fuse: init (API version 7.41) Nov 5 04:56:40.468578 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 5 04:56:40.468597 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 5 04:56:40.468628 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 5 04:56:40.468646 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 5 04:56:40.468664 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:40.468713 systemd-journald[1251]: Collecting audit messages is disabled. Nov 5 04:56:40.468748 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 5 04:56:40.468767 systemd-journald[1251]: Journal started Nov 5 04:56:40.468810 systemd-journald[1251]: Runtime Journal (/run/log/journal/e1e3fd95d5984ce09a1ab027bd0d77d0) is 6M, max 48.1M, 42M free. Nov 5 04:56:40.474509 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 5 04:56:40.474588 systemd[1]: Mounted media.mount - External Media Directory. Nov 5 04:56:40.127050 systemd[1]: Queued start job for default target multi-user.target. Nov 5 04:56:40.146742 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 5 04:56:40.147324 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 5 04:56:40.482982 systemd[1]: Started systemd-journald.service - Journal Service. Nov 5 04:56:40.485166 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 5 04:56:40.487430 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 5 04:56:40.489734 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 5 04:56:40.492124 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 5 04:56:40.494878 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 5 04:56:40.497557 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 5 04:56:40.497787 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 5 04:56:40.500420 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 5 04:56:40.500764 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 5 04:56:40.503200 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 5 04:56:40.503445 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 5 04:56:40.505840 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 5 04:56:40.506132 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 5 04:56:40.508662 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 5 04:56:40.508967 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 5 04:56:40.511123 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 5 04:56:40.511395 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 5 04:56:40.513748 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 5 04:56:40.516131 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 5 04:56:40.520096 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 5 04:56:40.522800 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 5 04:56:40.539555 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 5 04:56:40.542350 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Nov 5 04:56:40.545736 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 5 04:56:40.548569 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 5 04:56:40.550331 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 5 04:56:40.550362 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 5 04:56:40.552903 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 5 04:56:40.555187 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 5 04:56:40.561586 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 5 04:56:40.565619 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 5 04:56:40.567649 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 5 04:56:40.569371 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 5 04:56:40.571372 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 5 04:56:40.574606 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 5 04:56:40.574815 systemd-journald[1251]: Time spent on flushing to /var/log/journal/e1e3fd95d5984ce09a1ab027bd0d77d0 is 15.853ms for 1031 entries. Nov 5 04:56:40.574815 systemd-journald[1251]: System Journal (/var/log/journal/e1e3fd95d5984ce09a1ab027bd0d77d0) is 8M, max 163.5M, 155.5M free. Nov 5 04:56:40.712585 systemd-journald[1251]: Received client request to flush runtime journal. Nov 5 04:56:40.712652 kernel: loop1: detected capacity change from 0 to 111544 Nov 5 04:56:40.581587 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 5 04:56:40.585621 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 5 04:56:40.588667 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 5 04:56:40.592153 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 5 04:56:40.594225 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 5 04:56:40.686133 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 5 04:56:40.692405 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 5 04:56:40.695714 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 5 04:56:40.703186 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 5 04:56:40.709531 systemd-tmpfiles[1291]: ACLs are not supported, ignoring. Nov 5 04:56:40.709545 systemd-tmpfiles[1291]: ACLs are not supported, ignoring. Nov 5 04:56:40.715526 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 5 04:56:40.718692 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 5 04:56:40.725191 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 5 04:56:40.736479 kernel: loop2: detected capacity change from 0 to 119080 Nov 5 04:56:40.736843 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 5 04:56:40.760493 kernel: loop3: detected capacity change from 0 to 111544 Nov 5 04:56:40.761896 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 5 04:56:40.766269 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 5 04:56:40.770670 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 5 04:56:40.771684 kernel: loop4: detected capacity change from 0 to 119080 Nov 5 04:56:40.781522 (sd-merge)[1309]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw'. Nov 5 04:56:40.785542 (sd-merge)[1309]: Merged extensions into '/usr'. Nov 5 04:56:40.788464 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 5 04:56:40.794471 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 5 04:56:40.809358 systemd-tmpfiles[1312]: ACLs are not supported, ignoring. Nov 5 04:56:40.809748 systemd-tmpfiles[1312]: ACLs are not supported, ignoring. Nov 5 04:56:40.811607 systemd[1]: Starting ensure-sysext.service... Nov 5 04:56:40.814646 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 5 04:56:40.823024 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 5 04:56:40.835853 systemd[1]: Reload requested from client PID 1317 ('systemctl') (unit ensure-sysext.service)... Nov 5 04:56:40.836042 systemd[1]: Reloading... Nov 5 04:56:40.841350 systemd-tmpfiles[1318]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 5 04:56:40.841398 systemd-tmpfiles[1318]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 5 04:56:40.842136 systemd-tmpfiles[1318]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 5 04:56:40.842377 systemd-tmpfiles[1318]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 5 04:56:40.843260 systemd-tmpfiles[1318]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 5 04:56:40.843558 systemd-tmpfiles[1318]: ACLs are not supported, ignoring. Nov 5 04:56:40.843629 systemd-tmpfiles[1318]: ACLs are not supported, ignoring. Nov 5 04:56:40.849868 systemd-tmpfiles[1318]: Detected autofs mount point /boot during canonicalization of boot. Nov 5 04:56:40.849883 systemd-tmpfiles[1318]: Skipping /boot Nov 5 04:56:40.861016 systemd-tmpfiles[1318]: Detected autofs mount point /boot during canonicalization of boot. Nov 5 04:56:40.861119 systemd-tmpfiles[1318]: Skipping /boot Nov 5 04:56:40.893496 zram_generator::config[1354]: No configuration found. Nov 5 04:56:40.986516 systemd-resolved[1311]: Positive Trust Anchors: Nov 5 04:56:40.986537 systemd-resolved[1311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 5 04:56:40.986542 systemd-resolved[1311]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 5 04:56:40.986575 systemd-resolved[1311]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Nov 5 04:56:40.990711 systemd-resolved[1311]: Defaulting to hostname 'linux'. Nov 5 04:56:41.135630 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 5 04:56:41.136234 systemd[1]: Reloading finished in 299 ms. Nov 5 04:56:41.174681 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 5 04:56:41.177061 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 5 04:56:41.202977 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 5 04:56:41.214505 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 5 04:56:41.218652 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 5 04:56:41.222238 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 5 04:56:41.226705 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 5 04:56:41.233708 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 5 04:56:41.239743 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 5 04:56:41.245205 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:41.245393 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 5 04:56:41.250849 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 5 04:56:41.254034 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 5 04:56:41.260083 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 5 04:56:41.260267 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 5 04:56:41.260376 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 5 04:56:41.260515 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:41.268710 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:41.269030 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 5 04:56:41.269255 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 5 04:56:41.269383 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 5 04:56:41.270036 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:41.271241 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 5 04:56:41.279413 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 5 04:56:41.279683 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 5 04:56:41.282497 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 5 04:56:41.282849 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 5 04:56:41.286779 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:41.287346 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 5 04:56:41.289945 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 5 04:56:41.292089 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 5 04:56:41.292217 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 5 04:56:41.292336 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 5 04:56:41.292437 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 5 04:56:41.293230 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 5 04:56:41.293476 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 5 04:56:41.297926 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 5 04:56:41.302812 systemd[1]: Finished ensure-sysext.service. Nov 5 04:56:41.304707 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 5 04:56:41.317109 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 5 04:56:41.322778 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 5 04:56:41.323039 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 5 04:56:41.349465 augenrules[1429]: No rules Nov 5 04:56:41.350933 systemd[1]: audit-rules.service: Deactivated successfully. Nov 5 04:56:41.528003 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 5 04:56:41.537473 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 5 04:56:41.542229 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 5 04:56:41.610531 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 5 04:56:41.613268 systemd[1]: Reached target time-set.target - System Time Set. Nov 5 04:56:41.665756 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 5 04:56:41.669902 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 5 04:56:41.705979 systemd-udevd[1440]: Using default interface naming scheme 'v257'. Nov 5 04:56:41.763519 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 5 04:56:41.770801 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 5 04:56:41.815205 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 5 04:56:41.944885 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 5 04:56:41.948383 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 5 04:56:41.964306 systemd-networkd[1447]: lo: Link UP Nov 5 04:56:41.964321 systemd-networkd[1447]: lo: Gained carrier Nov 5 04:56:41.969495 kernel: mousedev: PS/2 mouse device common for all mice Nov 5 04:56:41.969616 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Nov 5 04:56:41.969777 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 5 04:56:41.972848 systemd[1]: Reached target network.target - Network. Nov 5 04:56:41.976834 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 5 04:56:41.978411 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 5 04:56:41.982505 kernel: ACPI: button: Power Button [PWRF] Nov 5 04:56:41.987632 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 5 04:56:41.998518 ldconfig[1394]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 5 04:56:42.008600 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 5 04:56:42.012055 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 5 04:56:42.013337 systemd-networkd[1447]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 5 04:56:42.013343 systemd-networkd[1447]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 5 04:56:42.014411 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 5 04:56:42.014855 systemd-networkd[1447]: eth0: Link UP Nov 5 04:56:42.015239 systemd-networkd[1447]: eth0: Gained carrier Nov 5 04:56:42.015254 systemd-networkd[1447]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 5 04:56:42.033537 systemd-networkd[1447]: eth0: DHCPv4 address 10.0.0.130/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 5 04:56:42.034218 systemd-timesyncd[1424]: Network configuration changed, trying to establish connection. Nov 5 04:56:42.037579 systemd-timesyncd[1424]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 5 04:56:42.037629 systemd-timesyncd[1424]: Initial clock synchronization to Wed 2025-11-05 04:56:42.001968 UTC. Nov 5 04:56:42.037884 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 5 04:56:42.040114 systemd[1]: Reached target sysinit.target - System Initialization. Nov 5 04:56:42.041987 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 5 04:56:42.044578 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 5 04:56:42.046976 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 5 04:56:42.049648 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 5 04:56:42.052787 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 5 04:56:42.055047 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 5 04:56:42.057243 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 5 04:56:42.057287 systemd[1]: Reached target paths.target - Path Units. Nov 5 04:56:42.059000 systemd[1]: Reached target timers.target - Timer Units. Nov 5 04:56:42.063443 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 5 04:56:42.069863 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 5 04:56:42.079270 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 5 04:56:42.083114 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 5 04:56:42.085384 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 5 04:56:42.098527 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Nov 5 04:56:42.099110 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Nov 5 04:56:42.099608 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 5 04:56:42.103215 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Nov 5 04:56:42.104569 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 5 04:56:42.107443 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 5 04:56:42.110611 systemd[1]: Reached target sockets.target - Socket Units. Nov 5 04:56:42.112617 systemd[1]: Reached target basic.target - Basic System. Nov 5 04:56:42.114285 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 5 04:56:42.114319 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 5 04:56:42.117984 systemd[1]: Starting containerd.service - containerd container runtime... Nov 5 04:56:42.123212 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 5 04:56:42.135220 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 5 04:56:42.143888 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 5 04:56:42.148725 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 5 04:56:42.151558 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Nov 5 04:56:42.161891 jq[1501]: false Nov 5 04:56:42.164079 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 5 04:56:42.168754 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 5 04:56:42.171795 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 5 04:56:42.185884 extend-filesystems[1502]: Found /dev/vda6 Nov 5 04:56:42.185884 extend-filesystems[1502]: Found /dev/vda9 Nov 5 04:56:42.185884 extend-filesystems[1502]: Checking size of /dev/vda9 Nov 5 04:56:42.202289 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 5 04:56:42.209780 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 5 04:56:42.211503 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 5 04:56:42.212737 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 5 04:56:42.213491 systemd[1]: Starting update-engine.service - Update Engine... Nov 5 04:56:42.217568 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 5 04:56:42.224636 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 5 04:56:42.226989 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 5 04:56:42.227735 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 5 04:56:42.235868 extend-filesystems[1502]: Resized partition /dev/vda9 Nov 5 04:56:42.241726 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 5 04:56:42.242023 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 5 04:56:42.252475 google_oslogin_nss_cache[1503]: oslogin_cache_refresh[1503]: Refreshing passwd entry cache Nov 5 04:56:42.262906 jq[1520]: true Nov 5 04:56:42.263354 oslogin_cache_refresh[1503]: Refreshing passwd entry cache Nov 5 04:56:42.268122 extend-filesystems[1529]: resize2fs 1.47.3 (8-Jul-2025) Nov 5 04:56:42.280970 google_oslogin_nss_cache[1503]: oslogin_cache_refresh[1503]: Failure getting users, quitting Nov 5 04:56:42.280970 google_oslogin_nss_cache[1503]: oslogin_cache_refresh[1503]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 5 04:56:42.280970 google_oslogin_nss_cache[1503]: oslogin_cache_refresh[1503]: Refreshing group entry cache Nov 5 04:56:42.280136 oslogin_cache_refresh[1503]: Failure getting users, quitting Nov 5 04:56:42.280190 oslogin_cache_refresh[1503]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 5 04:56:42.280316 oslogin_cache_refresh[1503]: Refreshing group entry cache Nov 5 04:56:42.288207 update_engine[1518]: I20251105 04:56:42.287993 1518 main.cc:92] Flatcar Update Engine starting Nov 5 04:56:42.297501 google_oslogin_nss_cache[1503]: oslogin_cache_refresh[1503]: Failure getting groups, quitting Nov 5 04:56:42.297501 google_oslogin_nss_cache[1503]: oslogin_cache_refresh[1503]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 5 04:56:42.292842 oslogin_cache_refresh[1503]: Failure getting groups, quitting Nov 5 04:56:42.292876 oslogin_cache_refresh[1503]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 5 04:56:42.309434 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 5 04:56:42.310135 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 5 04:56:42.335576 kernel: kvm_amd: TSC scaling supported Nov 5 04:56:42.335695 kernel: kvm_amd: Nested Virtualization enabled Nov 5 04:56:42.335710 kernel: kvm_amd: Nested Paging enabled Nov 5 04:56:42.336472 jq[1533]: true Nov 5 04:56:42.338397 kernel: kvm_amd: LBR virtualization supported Nov 5 04:56:42.338427 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Nov 5 04:56:42.338441 kernel: kvm_amd: Virtual GIF supported Nov 5 04:56:42.349745 systemd[1]: motdgen.service: Deactivated successfully. Nov 5 04:56:42.353005 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 5 04:56:42.368607 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 1784827 blocks Nov 5 04:56:42.385384 dbus-daemon[1499]: [system] SELinux support is enabled Nov 5 04:56:42.386415 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 5 04:56:42.398282 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Nov 5 04:56:42.399222 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 5 04:56:42.405668 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 5 04:56:42.406690 update_engine[1518]: I20251105 04:56:42.406019 1518 update_check_scheduler.cc:74] Next update check in 3m34s Nov 5 04:56:42.407609 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Nov 5 04:56:42.407737 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 5 04:56:42.419319 systemd[1]: Started update-engine.service - Update Engine. Nov 5 04:56:42.425782 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 5 04:56:42.552351 sshd_keygen[1524]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 5 04:56:42.579224 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 5 04:56:42.582689 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 5 04:56:42.604242 kernel: EXT4-fs (vda9): resized filesystem to 1784827 Nov 5 04:56:42.652324 kernel: EDAC MC: Ver: 3.0.0 Nov 5 04:56:42.624666 systemd[1]: issuegen.service: Deactivated successfully. Nov 5 04:56:42.624967 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 5 04:56:42.629751 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 5 04:56:42.651745 systemd-logind[1517]: Watching system buttons on /dev/input/event2 (Power Button) Nov 5 04:56:42.651769 systemd-logind[1517]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 5 04:56:42.652217 systemd-logind[1517]: New seat seat0. Nov 5 04:56:42.674693 extend-filesystems[1529]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Nov 5 04:56:42.674693 extend-filesystems[1529]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 5 04:56:42.674693 extend-filesystems[1529]: The filesystem on /dev/vda9 is now 1784827 (4k) blocks long. Nov 5 04:56:42.717090 extend-filesystems[1502]: Resized filesystem in /dev/vda9 Nov 5 04:56:42.678228 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 5 04:56:42.717520 bash[1566]: Updated "/home/core/.ssh/authorized_keys" Nov 5 04:56:42.714232 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 5 04:56:42.741360 locksmithd[1565]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 5 04:56:42.765072 systemd[1]: Started systemd-logind.service - User Login Management. Nov 5 04:56:42.767529 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 5 04:56:42.770707 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 5 04:56:42.775649 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 5 04:56:42.785364 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 5 04:56:42.788605 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 5 04:56:42.790913 systemd[1]: Reached target getty.target - Login Prompts. Nov 5 04:56:42.793147 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 5 04:56:42.924827 containerd[1538]: time="2025-11-05T04:56:42Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Nov 5 04:56:42.925880 containerd[1538]: time="2025-11-05T04:56:42.925698943Z" level=info msg="starting containerd" revision=75cb2b7193e4e490e9fbdc236c0e811ccaba3376 version=v2.1.4 Nov 5 04:56:42.940297 containerd[1538]: time="2025-11-05T04:56:42.940227363Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="19.226µs" Nov 5 04:56:42.940297 containerd[1538]: time="2025-11-05T04:56:42.940282096Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 5 04:56:42.940362 containerd[1538]: time="2025-11-05T04:56:42.940342048Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 5 04:56:42.940400 containerd[1538]: time="2025-11-05T04:56:42.940380601Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 5 04:56:42.940719 containerd[1538]: time="2025-11-05T04:56:42.940680473Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 5 04:56:42.940719 containerd[1538]: time="2025-11-05T04:56:42.940705209Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 5 04:56:42.940823 containerd[1538]: time="2025-11-05T04:56:42.940791431Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 5 04:56:42.940823 containerd[1538]: time="2025-11-05T04:56:42.940809906Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941180 containerd[1538]: time="2025-11-05T04:56:42.941142730Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941180 containerd[1538]: time="2025-11-05T04:56:42.941164731Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941236 containerd[1538]: time="2025-11-05T04:56:42.941192924Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941236 containerd[1538]: time="2025-11-05T04:56:42.941202943Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941468 containerd[1538]: time="2025-11-05T04:56:42.941404100Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941468 containerd[1538]: time="2025-11-05T04:56:42.941425660Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941609 containerd[1538]: time="2025-11-05T04:56:42.941569991Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941887 containerd[1538]: time="2025-11-05T04:56:42.941837883Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941887 containerd[1538]: time="2025-11-05T04:56:42.941877157Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 5 04:56:42.941887 containerd[1538]: time="2025-11-05T04:56:42.941888628Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 5 04:56:42.942008 containerd[1538]: time="2025-11-05T04:56:42.941926189Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 5 04:56:42.942847 containerd[1538]: time="2025-11-05T04:56:42.942781202Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 5 04:56:42.943145 containerd[1538]: time="2025-11-05T04:56:42.943099779Z" level=info msg="metadata content store policy set" policy=shared Nov 5 04:56:42.949817 containerd[1538]: time="2025-11-05T04:56:42.949745109Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 5 04:56:42.949817 containerd[1538]: time="2025-11-05T04:56:42.949821262Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 5 04:56:42.950024 containerd[1538]: time="2025-11-05T04:56:42.949995639Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 5 04:56:42.950024 containerd[1538]: time="2025-11-05T04:56:42.950017510Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 5 04:56:42.950123 containerd[1538]: time="2025-11-05T04:56:42.950036485Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 5 04:56:42.950123 containerd[1538]: time="2025-11-05T04:56:42.950053567Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 5 04:56:42.950123 containerd[1538]: time="2025-11-05T04:56:42.950067964Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 5 04:56:42.950123 containerd[1538]: time="2025-11-05T04:56:42.950082772Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 5 04:56:42.950123 containerd[1538]: time="2025-11-05T04:56:42.950102840Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 5 04:56:42.950123 containerd[1538]: time="2025-11-05T04:56:42.950121876Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 5 04:56:42.950272 containerd[1538]: time="2025-11-05T04:56:42.950138827Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 5 04:56:42.950272 containerd[1538]: time="2025-11-05T04:56:42.950153535Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 5 04:56:42.950272 containerd[1538]: time="2025-11-05T04:56:42.950165417Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 5 04:56:42.950272 containerd[1538]: time="2025-11-05T04:56:42.950182419Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950343221Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950371133Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950397633Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950429041Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950484235Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950502910Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950518209Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950539228Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950569294Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950585916Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 5 04:56:42.950612 containerd[1538]: time="2025-11-05T04:56:42.950599752Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 5 04:56:42.950882 containerd[1538]: time="2025-11-05T04:56:42.950633685Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 5 04:56:42.950882 containerd[1538]: time="2025-11-05T04:56:42.950713375Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 5 04:56:42.950882 containerd[1538]: time="2025-11-05T04:56:42.950730136Z" level=info msg="Start snapshots syncer" Nov 5 04:56:42.950882 containerd[1538]: time="2025-11-05T04:56:42.950765552Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 5 04:56:42.951232 containerd[1538]: time="2025-11-05T04:56:42.951138051Z" 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,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Nov 5 04:56:42.951413 containerd[1538]: time="2025-11-05T04:56:42.951236836Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 5 04:56:42.951413 containerd[1538]: time="2025-11-05T04:56:42.951330422Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 5 04:56:42.951573 containerd[1538]: time="2025-11-05T04:56:42.951531438Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 5 04:56:42.951606 containerd[1538]: time="2025-11-05T04:56:42.951585690Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 5 04:56:42.951606 containerd[1538]: time="2025-11-05T04:56:42.951599877Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 5 04:56:42.951654 containerd[1538]: time="2025-11-05T04:56:42.951613512Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 5 04:56:42.951654 containerd[1538]: time="2025-11-05T04:56:42.951625635Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 5 04:56:42.951654 containerd[1538]: time="2025-11-05T04:56:42.951635734Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 5 04:56:42.951654 containerd[1538]: time="2025-11-05T04:56:42.951645933Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951656824Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951667995Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951703872Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951716515Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951724821Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951735180Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951742885Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951751922Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 5 04:56:42.951758 containerd[1538]: time="2025-11-05T04:56:42.951761760Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 5 04:56:42.951978 containerd[1538]: time="2025-11-05T04:56:42.951799491Z" level=info msg="runtime interface created" Nov 5 04:56:42.951978 containerd[1538]: time="2025-11-05T04:56:42.951813928Z" level=info msg="created NRI interface" Nov 5 04:56:42.951978 containerd[1538]: time="2025-11-05T04:56:42.951832683Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 5 04:56:42.951978 containerd[1538]: time="2025-11-05T04:56:42.951845397Z" level=info msg="Connect containerd service" Nov 5 04:56:42.951978 containerd[1538]: time="2025-11-05T04:56:42.951866126Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 5 04:56:42.952885 containerd[1538]: time="2025-11-05T04:56:42.952842427Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Nov 5 04:56:43.113382 containerd[1538]: time="2025-11-05T04:56:43.113286010Z" level=info msg="Start subscribing containerd event" Nov 5 04:56:43.113685 containerd[1538]: time="2025-11-05T04:56:43.113618915Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 5 04:56:43.113685 containerd[1538]: time="2025-11-05T04:56:43.113661318Z" level=info msg="Start recovering state" Nov 5 04:56:43.113867 containerd[1538]: time="2025-11-05T04:56:43.113714798Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 5 04:56:43.113988 containerd[1538]: time="2025-11-05T04:56:43.113948848Z" level=info msg="Start event monitor" Nov 5 04:56:43.114052 containerd[1538]: time="2025-11-05T04:56:43.113989399Z" level=info msg="Start cni network conf syncer for default" Nov 5 04:56:43.114052 containerd[1538]: time="2025-11-05T04:56:43.114004250Z" level=info msg="Start streaming server" Nov 5 04:56:43.114052 containerd[1538]: time="2025-11-05T04:56:43.114019932Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 5 04:56:43.114052 containerd[1538]: time="2025-11-05T04:56:43.114029549Z" level=info msg="runtime interface starting up..." Nov 5 04:56:43.114052 containerd[1538]: time="2025-11-05T04:56:43.114037976Z" level=info msg="starting plugins..." Nov 5 04:56:43.114183 containerd[1538]: time="2025-11-05T04:56:43.114058541Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 5 04:56:43.114316 containerd[1538]: time="2025-11-05T04:56:43.114288748Z" level=info msg="containerd successfully booted in 0.190179s" Nov 5 04:56:43.114471 systemd[1]: Started containerd.service - containerd container runtime. Nov 5 04:56:43.342673 systemd-networkd[1447]: eth0: Gained IPv6LL Nov 5 04:56:43.345999 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 5 04:56:43.348823 systemd[1]: Reached target network-online.target - Network is Online. Nov 5 04:56:43.352787 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 5 04:56:43.356065 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 5 04:56:43.402044 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 5 04:56:43.435405 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 5 04:56:43.435717 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 5 04:56:43.438057 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 5 04:56:43.438207 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 5 04:56:43.440131 systemd[1]: Startup finished in 3.371s (kernel) + 4.719s (initrd) + 3.950s (userspace) = 12.041s. Nov 5 04:56:47.150333 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 5 04:56:47.151990 systemd[1]: Started sshd@0-10.0.0.130:22-10.0.0.1:40004.service - OpenSSH per-connection server daemon (10.0.0.1:40004). Nov 5 04:56:47.244385 sshd[1638]: Accepted publickey for core from 10.0.0.1 port 40004 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:47.247686 sshd-session[1638]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:47.286319 systemd-logind[1517]: New session 1 of user core. Nov 5 04:56:47.290949 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 5 04:56:47.293274 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 5 04:56:47.335915 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 5 04:56:47.339392 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 5 04:56:47.358632 (systemd)[1643]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 5 04:56:47.362438 systemd-logind[1517]: New session c1 of user core. Nov 5 04:56:47.508492 systemd[1643]: Queued start job for default target default.target. Nov 5 04:56:47.520864 systemd[1643]: Created slice app.slice - User Application Slice. Nov 5 04:56:47.520892 systemd[1643]: Reached target paths.target - Paths. Nov 5 04:56:47.520939 systemd[1643]: Reached target timers.target - Timers. Nov 5 04:56:47.522673 systemd[1643]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 5 04:56:47.534820 systemd[1643]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 5 04:56:47.534956 systemd[1643]: Reached target sockets.target - Sockets. Nov 5 04:56:47.535004 systemd[1643]: Reached target basic.target - Basic System. Nov 5 04:56:47.535056 systemd[1643]: Reached target default.target - Main User Target. Nov 5 04:56:47.535093 systemd[1643]: Startup finished in 164ms. Nov 5 04:56:47.535518 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 5 04:56:47.537277 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 5 04:56:47.560947 systemd[1]: Started sshd@1-10.0.0.130:22-10.0.0.1:40012.service - OpenSSH per-connection server daemon (10.0.0.1:40012). Nov 5 04:56:47.621665 sshd[1654]: Accepted publickey for core from 10.0.0.1 port 40012 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:47.622994 sshd-session[1654]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:47.627551 systemd-logind[1517]: New session 2 of user core. Nov 5 04:56:47.641587 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 5 04:56:47.654543 sshd[1657]: Connection closed by 10.0.0.1 port 40012 Nov 5 04:56:47.654806 sshd-session[1654]: pam_unix(sshd:session): session closed for user core Nov 5 04:56:47.659389 systemd[1]: sshd@1-10.0.0.130:22-10.0.0.1:40012.service: Deactivated successfully. Nov 5 04:56:47.661489 systemd[1]: session-2.scope: Deactivated successfully. Nov 5 04:56:47.662171 systemd-logind[1517]: Session 2 logged out. Waiting for processes to exit. Nov 5 04:56:47.665024 systemd[1]: Started sshd@2-10.0.0.130:22-10.0.0.1:40028.service - OpenSSH per-connection server daemon (10.0.0.1:40028). Nov 5 04:56:47.665594 systemd-logind[1517]: Removed session 2. Nov 5 04:56:47.729302 sshd[1663]: Accepted publickey for core from 10.0.0.1 port 40028 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:47.730666 sshd-session[1663]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:47.735574 systemd-logind[1517]: New session 3 of user core. Nov 5 04:56:47.757607 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 5 04:56:47.766583 sshd[1666]: Connection closed by 10.0.0.1 port 40028 Nov 5 04:56:47.766891 sshd-session[1663]: pam_unix(sshd:session): session closed for user core Nov 5 04:56:47.784266 systemd[1]: sshd@2-10.0.0.130:22-10.0.0.1:40028.service: Deactivated successfully. Nov 5 04:56:47.786221 systemd[1]: session-3.scope: Deactivated successfully. Nov 5 04:56:47.786991 systemd-logind[1517]: Session 3 logged out. Waiting for processes to exit. Nov 5 04:56:47.789944 systemd[1]: Started sshd@3-10.0.0.130:22-10.0.0.1:40034.service - OpenSSH per-connection server daemon (10.0.0.1:40034). Nov 5 04:56:47.790656 systemd-logind[1517]: Removed session 3. Nov 5 04:56:47.846769 sshd[1672]: Accepted publickey for core from 10.0.0.1 port 40034 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:47.848148 sshd-session[1672]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:47.852797 systemd-logind[1517]: New session 4 of user core. Nov 5 04:56:47.867602 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 5 04:56:47.880679 sshd[1676]: Connection closed by 10.0.0.1 port 40034 Nov 5 04:56:47.881055 sshd-session[1672]: pam_unix(sshd:session): session closed for user core Nov 5 04:56:47.893100 systemd[1]: sshd@3-10.0.0.130:22-10.0.0.1:40034.service: Deactivated successfully. Nov 5 04:56:47.895088 systemd[1]: session-4.scope: Deactivated successfully. Nov 5 04:56:47.895827 systemd-logind[1517]: Session 4 logged out. Waiting for processes to exit. Nov 5 04:56:47.898899 systemd[1]: Started sshd@4-10.0.0.130:22-10.0.0.1:40038.service - OpenSSH per-connection server daemon (10.0.0.1:40038). Nov 5 04:56:47.899639 systemd-logind[1517]: Removed session 4. Nov 5 04:56:47.939423 sshd[1682]: Accepted publickey for core from 10.0.0.1 port 40038 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:47.940891 sshd-session[1682]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:47.946246 systemd-logind[1517]: New session 5 of user core. Nov 5 04:56:47.962651 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 5 04:56:47.985919 sudo[1686]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 5 04:56:47.986238 sudo[1686]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 5 04:56:48.007397 sudo[1686]: pam_unix(sudo:session): session closed for user root Nov 5 04:56:48.009348 sshd[1685]: Connection closed by 10.0.0.1 port 40038 Nov 5 04:56:48.009819 sshd-session[1682]: pam_unix(sshd:session): session closed for user core Nov 5 04:56:48.025189 systemd[1]: sshd@4-10.0.0.130:22-10.0.0.1:40038.service: Deactivated successfully. Nov 5 04:56:48.027390 systemd[1]: session-5.scope: Deactivated successfully. Nov 5 04:56:48.028242 systemd-logind[1517]: Session 5 logged out. Waiting for processes to exit. Nov 5 04:56:48.031442 systemd[1]: Started sshd@5-10.0.0.130:22-10.0.0.1:40040.service - OpenSSH per-connection server daemon (10.0.0.1:40040). Nov 5 04:56:48.032309 systemd-logind[1517]: Removed session 5. Nov 5 04:56:48.072347 sshd[1692]: Accepted publickey for core from 10.0.0.1 port 40040 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:48.073789 sshd-session[1692]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:48.078647 systemd-logind[1517]: New session 6 of user core. Nov 5 04:56:48.088678 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 5 04:56:48.103769 sudo[1697]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 5 04:56:48.104085 sudo[1697]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 5 04:56:48.110766 sudo[1697]: pam_unix(sudo:session): session closed for user root Nov 5 04:56:48.118638 sudo[1696]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Nov 5 04:56:48.118953 sudo[1696]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 5 04:56:48.129598 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 5 04:56:48.183056 augenrules[1719]: No rules Nov 5 04:56:48.184872 systemd[1]: audit-rules.service: Deactivated successfully. Nov 5 04:56:48.185198 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 5 04:56:48.186401 sudo[1696]: pam_unix(sudo:session): session closed for user root Nov 5 04:56:48.188346 sshd[1695]: Connection closed by 10.0.0.1 port 40040 Nov 5 04:56:48.188668 sshd-session[1692]: pam_unix(sshd:session): session closed for user core Nov 5 04:56:48.198225 systemd[1]: sshd@5-10.0.0.130:22-10.0.0.1:40040.service: Deactivated successfully. Nov 5 04:56:48.200003 systemd[1]: session-6.scope: Deactivated successfully. Nov 5 04:56:48.200790 systemd-logind[1517]: Session 6 logged out. Waiting for processes to exit. Nov 5 04:56:48.203303 systemd[1]: Started sshd@6-10.0.0.130:22-10.0.0.1:40052.service - OpenSSH per-connection server daemon (10.0.0.1:40052). Nov 5 04:56:48.203966 systemd-logind[1517]: Removed session 6. Nov 5 04:56:48.255048 sshd[1728]: Accepted publickey for core from 10.0.0.1 port 40052 ssh2: RSA SHA256:XiGyK5fqllnBQWxDYED3xW8VH4cMJfuo/fZHqIgMrko Nov 5 04:56:48.256877 sshd-session[1728]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 5 04:56:48.261297 systemd-logind[1517]: New session 7 of user core. Nov 5 04:56:48.271575 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 5 04:57:08.164714 sudo[1747]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --console=pipe --setenv=PORTAGE_BINHOST=http://bincache.flatcar-linux.net/boards/amd64-usr/4509.0.0+nightly-20251104-2100/pkgs --setenv=EXPECTED_VERSION=4509.0.0+nightly-20251104-2100 --bind-ro=/lib/modules --bind-ro=/home/core/dev-container-script --bind=/home/core/dev-container-workdir-23761/src:/usr/src --bind=/home/core/dev-container-workdir-23761/tmp:/var/tmp --image=flatcar_developer_container.bin --machine=flatcar-developer-container /bin/bash /home/core/dev-container-script Nov 5 04:57:08.165072 sudo[1747]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 5 04:57:08.174278 systemd-udevd[1440]: Received message with invalid length, ignoring Nov 5 04:57:08.177483 kernel: loop5: detected capacity change from 0 to 12644352 Nov 5 04:57:08.186491 kernel: loop5: p9 Nov 5 04:57:08.923520 kernel: EXT4-fs (loop5p9): mounted filesystem 15b5d4a6-bfa6-43f0-9b7e-40f0f963eb28 r/w with ordered data mode. Quota mode: none. Nov 5 04:57:08.958648 dbus-daemon[1499]: [system] Activating via systemd: service name='org.freedesktop.machine1' unit='dbus-org.freedesktop.machine1.service' requested by ':1.31' (uid=0 pid=1748 comm="systemd-nspawn --console=pipe --setenv=PORTAGE_BIN" label="system_u:system_r:kernel_t:s0") Nov 5 04:57:08.976775 systemd[1]: Created slice machine.slice - Virtual Machine and Container Slice. Nov 5 04:57:08.976969 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 5 04:57:08.987287 systemd[1]: Starting systemd-machined.service - Virtual Machine and Container Registration Service... Nov 5 04:57:09.058558 dbus-daemon[1499]: [system] Successfully activated service 'org.freedesktop.machine1' Nov 5 04:57:09.059962 systemd[1]: Started systemd-machined.service - Virtual Machine and Container Registration Service. Nov 5 04:57:09.065830 systemd-machined[1759]: New machine flatcar-developer-container. Nov 5 04:57:09.093745 systemd[1]: Started machine-flatcar\x2ddeveloper\x2dcontainer.scope - Container flatcar-developer-container. Nov 5 04:57:09.102423 systemd-resolved[1311]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 5 04:57:27.417066 update_engine[1518]: I20251105 04:57:27.416942 1518 update_attempter.cc:509] Updating boot flags... Nov 5 05:00:15.907524 kernel: EXT4-fs (loop5p9): unmounting filesystem 15b5d4a6-bfa6-43f0-9b7e-40f0f963eb28. Nov 5 05:00:15.925236 systemd[1]: machine-flatcar\x2ddeveloper\x2dcontainer.scope: Deactivated successfully. Nov 5 05:00:15.925851 systemd[1]: machine-flatcar\x2ddeveloper\x2dcontainer.scope: Consumed 4min 2.443s CPU time, 1.8G memory peak. Nov 5 05:00:15.928130 systemd-machined[1759]: Machine flatcar-developer-container terminated. Nov 5 05:00:15.931017 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcar\x2ddeveloper\x2dcontainer.mount: Deactivated successfully. Nov 5 05:00:15.960403 sudo[1747]: pam_unix(sudo:session): session closed for user root Nov 5 05:00:15.969463 sshd[1731]: Connection closed by 10.0.0.1 port 40052 Nov 5 05:00:15.970176 sshd-session[1728]: pam_unix(sshd:session): session closed for user core Nov 5 05:00:15.980475 systemd[1]: sshd@6-10.0.0.130:22-10.0.0.1:40052.service: Deactivated successfully. Nov 5 05:00:15.982532 systemd[1]: session-7.scope: Deactivated successfully. Nov 5 05:00:15.982823 systemd[1]: session-7.scope: Consumed 1min 8.753s CPU time, 1.8G memory peak. Nov 5 05:00:15.983475 systemd-logind[1517]: Session 7 logged out. Waiting for processes to exit. Nov 5 05:00:15.984846 systemd-logind[1517]: Removed session 7. Nov 5 05:00:16.423552 update_engine[1518]: I20251105 05:00:16.422890 1518 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Nov 5 05:00:16.423994 update_engine[1518]: I20251105 05:00:16.423575 1518 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Nov 5 05:00:16.423994 update_engine[1518]: I20251105 05:00:16.423872 1518 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Nov 5 05:00:16.424815 update_engine[1518]: I20251105 05:00:16.424782 1518 omaha_request_params.cc:62] Current group set to developer Nov 5 05:00:16.425758 update_engine[1518]: I20251105 05:00:16.425719 1518 update_attempter.cc:499] Already updated boot flags. Skipping. Nov 5 05:00:16.425758 update_engine[1518]: I20251105 05:00:16.425736 1518 update_attempter.cc:643] Scheduling an action processor start. Nov 5 05:00:16.425846 update_engine[1518]: I20251105 05:00:16.425765 1518 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 5 05:00:16.425920 update_engine[1518]: I20251105 05:00:16.425854 1518 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Nov 5 05:00:16.425970 update_engine[1518]: I20251105 05:00:16.425944 1518 omaha_request_action.cc:271] Posting an Omaha request to disabled Nov 5 05:00:16.426010 update_engine[1518]: I20251105 05:00:16.425966 1518 omaha_request_action.cc:272] Request: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: Nov 5 05:00:16.426010 update_engine[1518]: I20251105 05:00:16.425976 1518 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 5 05:00:16.430280 update_engine[1518]: I20251105 05:00:16.430243 1518 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 5 05:00:16.431302 update_engine[1518]: I20251105 05:00:16.431249 1518 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 5 05:00:16.439751 locksmithd[1565]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Nov 5 05:00:16.446600 update_engine[1518]: E20251105 05:00:16.446555 1518 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Nov 5 05:00:16.446674 update_engine[1518]: I20251105 05:00:16.446640 1518 libcurl_http_fetcher.cc:283] No HTTP response, retry 1