May 14 18:12:44.835971 kernel: Linux version 6.12.20-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Wed May 14 16:37:27 -00 2025
May 14 18:12:44.835990 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=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0
May 14 18:12:44.836001 kernel: BIOS-provided physical RAM map:
May 14 18:12:44.836007 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
May 14 18:12:44.836014 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable
May 14 18:12:44.836020 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS
May 14 18:12:44.836027 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable
May 14 18:12:44.836034 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS
May 14 18:12:44.836042 kernel: BIOS-e820: [mem 0x000000000080c000-0x0000000000810fff] usable
May 14 18:12:44.836049 kernel: BIOS-e820: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS
May 14 18:12:44.836055 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009bd3efff] usable
May 14 18:12:44.836061 kernel: BIOS-e820: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved
May 14 18:12:44.836067 kernel: BIOS-e820: [mem 0x000000009be00000-0x000000009c8ecfff] usable
May 14 18:12:44.836074 kernel: BIOS-e820: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved
May 14 18:12:44.836084 kernel: BIOS-e820: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data
May 14 18:12:44.836091 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS
May 14 18:12:44.836098 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009ce90fff] usable
May 14 18:12:44.836104 kernel: BIOS-e820: [mem 0x000000009ce91000-0x000000009ce94fff] reserved
May 14 18:12:44.836111 kernel: BIOS-e820: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS
May 14 18:12:44.836118 kernel: BIOS-e820: [mem 0x000000009ce97000-0x000000009cedbfff] usable
May 14 18:12:44.836125 kernel: BIOS-e820: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved
May 14 18:12:44.836131 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS
May 14 18:12:44.836138 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved
May 14 18:12:44.836145 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
May 14 18:12:44.836152 kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved
May 14 18:12:44.836161 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
May 14 18:12:44.836167 kernel: NX (Execute Disable) protection: active
May 14 18:12:44.836174 kernel: APIC: Static calls initialized
May 14 18:12:44.836181 kernel: e820: update [mem 0x9b320018-0x9b329c57] usable ==> usable
May 14 18:12:44.836188 kernel: e820: update [mem 0x9b2e3018-0x9b31fe57] usable ==> usable
May 14 18:12:44.836194 kernel: extended physical RAM map:
May 14 18:12:44.836201 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable
May 14 18:12:44.836208 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable
May 14 18:12:44.836215 kernel: reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS
May 14 18:12:44.836222 kernel: reserve setup_data: [mem 0x0000000000808000-0x000000000080afff] usable
May 14 18:12:44.836229 kernel: reserve setup_data: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS
May 14 18:12:44.836238 kernel: reserve setup_data: [mem 0x000000000080c000-0x0000000000810fff] usable
May 14 18:12:44.836244 kernel: reserve setup_data: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS
May 14 18:12:44.836251 kernel: reserve setup_data: [mem 0x0000000000900000-0x000000009b2e3017] usable
May 14 18:12:44.836258 kernel: reserve setup_data: [mem 0x000000009b2e3018-0x000000009b31fe57] usable
May 14 18:12:44.836268 kernel: reserve setup_data: [mem 0x000000009b31fe58-0x000000009b320017] usable
May 14 18:12:44.836275 kernel: reserve setup_data: [mem 0x000000009b320018-0x000000009b329c57] usable
May 14 18:12:44.836366 kernel: reserve setup_data: [mem 0x000000009b329c58-0x000000009bd3efff] usable
May 14 18:12:44.836374 kernel: reserve setup_data: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved
May 14 18:12:44.836381 kernel: reserve setup_data: [mem 0x000000009be00000-0x000000009c8ecfff] usable
May 14 18:12:44.836388 kernel: reserve setup_data: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved
May 14 18:12:44.836395 kernel: reserve setup_data: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data
May 14 18:12:44.836402 kernel: reserve setup_data: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS
May 14 18:12:44.836409 kernel: reserve setup_data: [mem 0x000000009cbff000-0x000000009ce90fff] usable
May 14 18:12:44.836416 kernel: reserve setup_data: [mem 0x000000009ce91000-0x000000009ce94fff] reserved
May 14 18:12:44.836423 kernel: reserve setup_data: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS
May 14 18:12:44.836433 kernel: reserve setup_data: [mem 0x000000009ce97000-0x000000009cedbfff] usable
May 14 18:12:44.836440 kernel: reserve setup_data: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved
May 14 18:12:44.836447 kernel: reserve setup_data: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS
May 14 18:12:44.836454 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved
May 14 18:12:44.836461 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved
May 14 18:12:44.836468 kernel: reserve setup_data: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved
May 14 18:12:44.836475 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
May 14 18:12:44.836482 kernel: efi: EFI v2.7 by EDK II
May 14 18:12:44.836489 kernel: efi: SMBIOS=0x9c988000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b9e4198 RNG=0x9cb73018 
May 14 18:12:44.836496 kernel: random: crng init done
May 14 18:12:44.836504 kernel: efi: Remove mem149: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map
May 14 18:12:44.836511 kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved
May 14 18:12:44.836520 kernel: secureboot: Secure boot disabled
May 14 18:12:44.836526 kernel: SMBIOS 2.8 present.
May 14 18:12:44.836534 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022
May 14 18:12:44.836541 kernel: DMI: Memory slots populated: 1/1
May 14 18:12:44.836548 kernel: Hypervisor detected: KVM
May 14 18:12:44.836555 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00
May 14 18:12:44.836562 kernel: kvm-clock: using sched offset of 3992022714 cycles
May 14 18:12:44.836569 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
May 14 18:12:44.836577 kernel: tsc: Detected 2794.746 MHz processor
May 14 18:12:44.836584 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 14 18:12:44.836591 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 14 18:12:44.836600 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000
May 14 18:12:44.836608 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs
May 14 18:12:44.836615 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
May 14 18:12:44.836622 kernel: Using GB pages for direct mapping
May 14 18:12:44.836629 kernel: ACPI: Early table checksum verification disabled
May 14 18:12:44.836637 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS )
May 14 18:12:44.836644 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS  BXPC     00000001      01000013)
May 14 18:12:44.836651 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 18:12:44.836658 kernel: ACPI: DSDT 0x000000009CB7A000 0021A8 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 18:12:44.836667 kernel: ACPI: FACS 0x000000009CBDD000 000040
May 14 18:12:44.836675 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 18:12:44.836682 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 18:12:44.836689 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 18:12:44.836696 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 14 18:12:44.836704 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL  EDK2     00000002      01000013)
May 14 18:12:44.836711 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3]
May 14 18:12:44.836718 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1a7]
May 14 18:12:44.836727 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f]
May 14 18:12:44.836735 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f]
May 14 18:12:44.836742 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037]
May 14 18:12:44.836749 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b]
May 14 18:12:44.836756 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027]
May 14 18:12:44.836763 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037]
May 14 18:12:44.836770 kernel: No NUMA configuration found
May 14 18:12:44.836777 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cedbfff]
May 14 18:12:44.836785 kernel: NODE_DATA(0) allocated [mem 0x9ce36dc0-0x9ce3dfff]
May 14 18:12:44.836792 kernel: Zone ranges:
May 14 18:12:44.836801 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 14 18:12:44.836808 kernel:   DMA32    [mem 0x0000000001000000-0x000000009cedbfff]
May 14 18:12:44.836815 kernel:   Normal   empty
May 14 18:12:44.836822 kernel:   Device   empty
May 14 18:12:44.836829 kernel: Movable zone start for each node
May 14 18:12:44.836837 kernel: Early memory node ranges
May 14 18:12:44.836844 kernel:   node   0: [mem 0x0000000000001000-0x000000000009ffff]
May 14 18:12:44.836851 kernel:   node   0: [mem 0x0000000000100000-0x00000000007fffff]
May 14 18:12:44.836858 kernel:   node   0: [mem 0x0000000000808000-0x000000000080afff]
May 14 18:12:44.836867 kernel:   node   0: [mem 0x000000000080c000-0x0000000000810fff]
May 14 18:12:44.836874 kernel:   node   0: [mem 0x0000000000900000-0x000000009bd3efff]
May 14 18:12:44.836881 kernel:   node   0: [mem 0x000000009be00000-0x000000009c8ecfff]
May 14 18:12:44.836888 kernel:   node   0: [mem 0x000000009cbff000-0x000000009ce90fff]
May 14 18:12:44.836895 kernel:   node   0: [mem 0x000000009ce97000-0x000000009cedbfff]
May 14 18:12:44.836903 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cedbfff]
May 14 18:12:44.836910 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 14 18:12:44.836917 kernel: On node 0, zone DMA: 96 pages in unavailable ranges
May 14 18:12:44.836933 kernel: On node 0, zone DMA: 8 pages in unavailable ranges
May 14 18:12:44.836941 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 14 18:12:44.836948 kernel: On node 0, zone DMA: 239 pages in unavailable ranges
May 14 18:12:44.836955 kernel: On node 0, zone DMA32: 193 pages in unavailable ranges
May 14 18:12:44.836965 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges
May 14 18:12:44.836972 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges
May 14 18:12:44.836980 kernel: On node 0, zone DMA32: 12580 pages in unavailable ranges
May 14 18:12:44.836987 kernel: ACPI: PM-Timer IO Port: 0x608
May 14 18:12:44.836995 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
May 14 18:12:44.837004 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
May 14 18:12:44.837012 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
May 14 18:12:44.837019 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
May 14 18:12:44.837027 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 14 18:12:44.837035 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
May 14 18:12:44.837042 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
May 14 18:12:44.837049 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 14 18:12:44.837057 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000
May 14 18:12:44.837064 kernel: TSC deadline timer available
May 14 18:12:44.837074 kernel: CPU topo: Max. logical packages:   1
May 14 18:12:44.837081 kernel: CPU topo: Max. logical dies:       1
May 14 18:12:44.837088 kernel: CPU topo: Max. dies per package:   1
May 14 18:12:44.837096 kernel: CPU topo: Max. threads per core:   1
May 14 18:12:44.837103 kernel: CPU topo: Num. cores per package:     4
May 14 18:12:44.837111 kernel: CPU topo: Num. threads per package:   4
May 14 18:12:44.837118 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs
May 14 18:12:44.837125 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
May 14 18:12:44.837133 kernel: kvm-guest: KVM setup pv remote TLB flush
May 14 18:12:44.837140 kernel: kvm-guest: setup PV sched yield
May 14 18:12:44.837149 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices
May 14 18:12:44.837157 kernel: Booting paravirtualized kernel on KVM
May 14 18:12:44.837165 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
May 14 18:12:44.837172 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
May 14 18:12:44.837180 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288
May 14 18:12:44.837188 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152
May 14 18:12:44.837195 kernel: pcpu-alloc: [0] 0 1 2 3 
May 14 18:12:44.837202 kernel: kvm-guest: PV spinlocks enabled
May 14 18:12:44.837210 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
May 14 18:12:44.837221 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=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0
May 14 18:12:44.837229 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 14 18:12:44.837236 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 14 18:12:44.837244 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 14 18:12:44.837251 kernel: Fallback order for Node 0: 0 
May 14 18:12:44.837259 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 641450
May 14 18:12:44.837266 kernel: Policy zone: DMA32
May 14 18:12:44.837273 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 14 18:12:44.837290 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
May 14 18:12:44.837309 kernel: ftrace: allocating 40065 entries in 157 pages
May 14 18:12:44.837317 kernel: ftrace: allocated 157 pages with 5 groups
May 14 18:12:44.837325 kernel: Dynamic Preempt: voluntary
May 14 18:12:44.837332 kernel: rcu: Preemptible hierarchical RCU implementation.
May 14 18:12:44.837340 kernel: rcu:         RCU event tracing is enabled.
May 14 18:12:44.837348 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
May 14 18:12:44.837355 kernel:         Trampoline variant of Tasks RCU enabled.
May 14 18:12:44.837363 kernel:         Rude variant of Tasks RCU enabled.
May 14 18:12:44.837373 kernel:         Tracing variant of Tasks RCU enabled.
May 14 18:12:44.837380 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 14 18:12:44.837388 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
May 14 18:12:44.837395 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 14 18:12:44.837403 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 14 18:12:44.837411 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 14 18:12:44.837418 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16
May 14 18:12:44.837426 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 14 18:12:44.837433 kernel: Console: colour dummy device 80x25
May 14 18:12:44.837443 kernel: printk: legacy console [ttyS0] enabled
May 14 18:12:44.837450 kernel: ACPI: Core revision 20240827
May 14 18:12:44.837458 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
May 14 18:12:44.837465 kernel: APIC: Switch to symmetric I/O mode setup
May 14 18:12:44.837473 kernel: x2apic enabled
May 14 18:12:44.837480 kernel: APIC: Switched APIC routing to: physical x2apic
May 14 18:12:44.837488 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask()
May 14 18:12:44.837495 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself()
May 14 18:12:44.837503 kernel: kvm-guest: setup PV IPIs
May 14 18:12:44.837512 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
May 14 18:12:44.837520 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns
May 14 18:12:44.837528 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794746)
May 14 18:12:44.837535 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated
May 14 18:12:44.837543 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
May 14 18:12:44.837550 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
May 14 18:12:44.837558 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 14 18:12:44.837565 kernel: Spectre V2 : Mitigation: Retpolines
May 14 18:12:44.837573 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
May 14 18:12:44.837582 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT
May 14 18:12:44.837590 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls
May 14 18:12:44.837597 kernel: RETBleed: Mitigation: untrained return thunk
May 14 18:12:44.837605 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
May 14 18:12:44.837613 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
May 14 18:12:44.837620 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied!
May 14 18:12:44.837628 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options.
May 14 18:12:44.837636 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode
May 14 18:12:44.837646 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
May 14 18:12:44.837653 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
May 14 18:12:44.837661 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
May 14 18:12:44.837668 kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
May 14 18:12:44.837676 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.
May 14 18:12:44.837683 kernel: Freeing SMP alternatives memory: 32K
May 14 18:12:44.837690 kernel: pid_max: default: 32768 minimum: 301
May 14 18:12:44.837698 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima
May 14 18:12:44.837706 kernel: landlock: Up and running.
May 14 18:12:44.837715 kernel: SELinux:  Initializing.
May 14 18:12:44.837722 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 14 18:12:44.837730 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 14 18:12:44.837738 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0)
May 14 18:12:44.837745 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver.
May 14 18:12:44.837752 kernel: ... version:                0
May 14 18:12:44.837760 kernel: ... bit width:              48
May 14 18:12:44.837767 kernel: ... generic registers:      6
May 14 18:12:44.837775 kernel: ... value mask:             0000ffffffffffff
May 14 18:12:44.837784 kernel: ... max period:             00007fffffffffff
May 14 18:12:44.837792 kernel: ... fixed-purpose events:   0
May 14 18:12:44.837799 kernel: ... event mask:             000000000000003f
May 14 18:12:44.837806 kernel: signal: max sigframe size: 1776
May 14 18:12:44.837814 kernel: rcu: Hierarchical SRCU implementation.
May 14 18:12:44.837821 kernel: rcu:         Max phase no-delay instances is 400.
May 14 18:12:44.837829 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
May 14 18:12:44.837836 kernel: smp: Bringing up secondary CPUs ...
May 14 18:12:44.837844 kernel: smpboot: x86: Booting SMP configuration:
May 14 18:12:44.837853 kernel: .... node  #0, CPUs:      #1 #2 #3
May 14 18:12:44.837860 kernel: smp: Brought up 1 node, 4 CPUs
May 14 18:12:44.837868 kernel: smpboot: Total of 4 processors activated (22357.96 BogoMIPS)
May 14 18:12:44.837876 kernel: Memory: 2422660K/2565800K available (14336K kernel code, 2438K rwdata, 9944K rodata, 54424K init, 2536K bss, 137200K reserved, 0K cma-reserved)
May 14 18:12:44.837883 kernel: devtmpfs: initialized
May 14 18:12:44.837891 kernel: x86/mm: Memory block size: 128MB
May 14 18:12:44.837898 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes)
May 14 18:12:44.837906 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes)
May 14 18:12:44.837914 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00811000-0x008fffff] (978944 bytes)
May 14 18:12:44.837923 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes)
May 14 18:12:44.837931 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9ce95000-0x9ce96fff] (8192 bytes)
May 14 18:12:44.837938 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes)
May 14 18:12:44.837946 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 14 18:12:44.837953 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
May 14 18:12:44.837961 kernel: pinctrl core: initialized pinctrl subsystem
May 14 18:12:44.837968 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 14 18:12:44.837976 kernel: audit: initializing netlink subsys (disabled)
May 14 18:12:44.837983 kernel: audit: type=2000 audit(1747246362.456:1): state=initialized audit_enabled=0 res=1
May 14 18:12:44.837992 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 14 18:12:44.838000 kernel: thermal_sys: Registered thermal governor 'user_space'
May 14 18:12:44.838007 kernel: cpuidle: using governor menu
May 14 18:12:44.838015 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 14 18:12:44.838022 kernel: dca service started, version 1.12.1
May 14 18:12:44.838030 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff]
May 14 18:12:44.838037 kernel: PCI: Using configuration type 1 for base access
May 14 18:12:44.838045 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 14 18:12:44.838052 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
May 14 18:12:44.838061 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
May 14 18:12:44.838069 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 14 18:12:44.838077 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 14 18:12:44.838084 kernel: ACPI: Added _OSI(Module Device)
May 14 18:12:44.838091 kernel: ACPI: Added _OSI(Processor Device)
May 14 18:12:44.838099 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 14 18:12:44.838106 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 14 18:12:44.838114 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 14 18:12:44.838121 kernel: ACPI: Interpreter enabled
May 14 18:12:44.838130 kernel: ACPI: PM: (supports S0 S3 S5)
May 14 18:12:44.838137 kernel: ACPI: Using IOAPIC for interrupt routing
May 14 18:12:44.838145 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 14 18:12:44.838153 kernel: PCI: Using E820 reservations for host bridge windows
May 14 18:12:44.838160 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F
May 14 18:12:44.838167 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
May 14 18:12:44.838366 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
May 14 18:12:44.838517 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]
May 14 18:12:44.838637 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]
May 14 18:12:44.838648 kernel: PCI host bridge to bus 0000:00
May 14 18:12:44.838764 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
May 14 18:12:44.838869 kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
May 14 18:12:44.839000 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
May 14 18:12:44.839112 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window]
May 14 18:12:44.839215 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window]
May 14 18:12:44.839365 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window]
May 14 18:12:44.839487 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
May 14 18:12:44.839669 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint
May 14 18:12:44.839796 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint
May 14 18:12:44.839911 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref]
May 14 18:12:44.840024 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff]
May 14 18:12:44.840144 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref]
May 14 18:12:44.840259 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
May 14 18:12:44.840414 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
May 14 18:12:44.840532 kernel: pci 0000:00:02.0: BAR 0 [io  0x6100-0x611f]
May 14 18:12:44.840679 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff]
May 14 18:12:44.840845 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref]
May 14 18:12:44.840988 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
May 14 18:12:44.841112 kernel: pci 0000:00:03.0: BAR 0 [io  0x6000-0x607f]
May 14 18:12:44.841227 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff]
May 14 18:12:44.841372 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref]
May 14 18:12:44.841497 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
May 14 18:12:44.841612 kernel: pci 0000:00:04.0: BAR 0 [io  0x60e0-0x60ff]
May 14 18:12:44.841726 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff]
May 14 18:12:44.841839 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref]
May 14 18:12:44.841957 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]
May 14 18:12:44.842103 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint
May 14 18:12:44.842249 kernel: pci 0000:00:1f.0: quirk: [io  0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO
May 14 18:12:44.842402 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint
May 14 18:12:44.842517 kernel: pci 0000:00:1f.2: BAR 4 [io  0x60c0-0x60df]
May 14 18:12:44.842631 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff]
May 14 18:12:44.842763 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint
May 14 18:12:44.842878 kernel: pci 0000:00:1f.3: BAR 4 [io  0x6080-0x60bf]
May 14 18:12:44.842888 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10
May 14 18:12:44.842896 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10
May 14 18:12:44.842904 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11
May 14 18:12:44.842912 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11
May 14 18:12:44.842919 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10
May 14 18:12:44.842927 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10
May 14 18:12:44.842937 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11
May 14 18:12:44.842945 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11
May 14 18:12:44.842952 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16
May 14 18:12:44.842960 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17
May 14 18:12:44.842967 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18
May 14 18:12:44.842981 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19
May 14 18:12:44.842996 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20
May 14 18:12:44.843004 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21
May 14 18:12:44.843020 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22
May 14 18:12:44.843030 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23
May 14 18:12:44.843038 kernel: iommu: Default domain type: Translated
May 14 18:12:44.843045 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 14 18:12:44.843053 kernel: efivars: Registered efivars operations
May 14 18:12:44.843060 kernel: PCI: Using ACPI for IRQ routing
May 14 18:12:44.843068 kernel: PCI: pci_cache_line_size set to 64 bytes
May 14 18:12:44.843079 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff]
May 14 18:12:44.843087 kernel: e820: reserve RAM buffer [mem 0x00811000-0x008fffff]
May 14 18:12:44.843094 kernel: e820: reserve RAM buffer [mem 0x9b2e3018-0x9bffffff]
May 14 18:12:44.843101 kernel: e820: reserve RAM buffer [mem 0x9b320018-0x9bffffff]
May 14 18:12:44.843111 kernel: e820: reserve RAM buffer [mem 0x9bd3f000-0x9bffffff]
May 14 18:12:44.843118 kernel: e820: reserve RAM buffer [mem 0x9c8ed000-0x9fffffff]
May 14 18:12:44.843125 kernel: e820: reserve RAM buffer [mem 0x9ce91000-0x9fffffff]
May 14 18:12:44.843133 kernel: e820: reserve RAM buffer [mem 0x9cedc000-0x9fffffff]
May 14 18:12:44.843250 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device
May 14 18:12:44.843390 kernel: pci 0000:00:01.0: vgaarb: bridge control possible
May 14 18:12:44.843506 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
May 14 18:12:44.843520 kernel: vgaarb: loaded
May 14 18:12:44.843528 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
May 14 18:12:44.843536 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter
May 14 18:12:44.843543 kernel: clocksource: Switched to clocksource kvm-clock
May 14 18:12:44.843550 kernel: VFS: Disk quotas dquot_6.6.0
May 14 18:12:44.843558 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 14 18:12:44.843566 kernel: pnp: PnP ACPI init
May 14 18:12:44.843701 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved
May 14 18:12:44.843717 kernel: pnp: PnP ACPI: found 6 devices
May 14 18:12:44.843725 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 14 18:12:44.843732 kernel: NET: Registered PF_INET protocol family
May 14 18:12:44.843740 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
May 14 18:12:44.843748 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
May 14 18:12:44.843756 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 14 18:12:44.843764 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 14 18:12:44.843772 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
May 14 18:12:44.843780 kernel: TCP: Hash tables configured (established 32768 bind 32768)
May 14 18:12:44.843789 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 14 18:12:44.843797 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 14 18:12:44.843805 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 14 18:12:44.843813 kernel: NET: Registered PF_XDP protocol family
May 14 18:12:44.843929 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window
May 14 18:12:44.844045 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned
May 14 18:12:44.844150 kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
May 14 18:12:44.844257 kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
May 14 18:12:44.844392 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
May 14 18:12:44.844503 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window]
May 14 18:12:44.844606 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window]
May 14 18:12:44.844711 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window]
May 14 18:12:44.844721 kernel: PCI: CLS 0 bytes, default 64
May 14 18:12:44.844730 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns
May 14 18:12:44.844738 kernel: Initialise system trusted keyrings
May 14 18:12:44.844749 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
May 14 18:12:44.844757 kernel: Key type asymmetric registered
May 14 18:12:44.844785 kernel: Asymmetric key parser 'x509' registered
May 14 18:12:44.844793 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
May 14 18:12:44.844803 kernel: io scheduler mq-deadline registered
May 14 18:12:44.844811 kernel: io scheduler kyber registered
May 14 18:12:44.844819 kernel: io scheduler bfq registered
May 14 18:12:44.844828 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
May 14 18:12:44.844837 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22
May 14 18:12:44.844845 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23
May 14 18:12:44.844853 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20
May 14 18:12:44.844861 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 14 18:12:44.844868 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 14 18:12:44.844876 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
May 14 18:12:44.844884 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
May 14 18:12:44.844892 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
May 14 18:12:44.845015 kernel: rtc_cmos 00:04: RTC can wake from S4
May 14 18:12:44.845027 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
May 14 18:12:44.845136 kernel: rtc_cmos 00:04: registered as rtc0
May 14 18:12:44.845243 kernel: rtc_cmos 00:04: setting system clock to 2025-05-14T18:12:44 UTC (1747246364)
May 14 18:12:44.845382 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram
May 14 18:12:44.845393 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
May 14 18:12:44.845401 kernel: efifb: probing for efifb
May 14 18:12:44.845409 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k
May 14 18:12:44.845420 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1
May 14 18:12:44.845428 kernel: efifb: scrolling: redraw
May 14 18:12:44.845436 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
May 14 18:12:44.845444 kernel: Console: switching to colour frame buffer device 160x50
May 14 18:12:44.845452 kernel: fb0: EFI VGA frame buffer device
May 14 18:12:44.845460 kernel: pstore: Using crash dump compression: deflate
May 14 18:12:44.845468 kernel: pstore: Registered efi_pstore as persistent store backend
May 14 18:12:44.845475 kernel: NET: Registered PF_INET6 protocol family
May 14 18:12:44.845483 kernel: Segment Routing with IPv6
May 14 18:12:44.845493 kernel: In-situ OAM (IOAM) with IPv6
May 14 18:12:44.845501 kernel: NET: Registered PF_PACKET protocol family
May 14 18:12:44.845508 kernel: Key type dns_resolver registered
May 14 18:12:44.845516 kernel: IPI shorthand broadcast: enabled
May 14 18:12:44.845524 kernel: sched_clock: Marking stable (2831002732, 161000855)->(3007471034, -15467447)
May 14 18:12:44.845532 kernel: registered taskstats version 1
May 14 18:12:44.845540 kernel: Loading compiled-in X.509 certificates
May 14 18:12:44.845548 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.20-flatcar: 41e2a150aa08ec2528be2394819b3db677e5f4ef'
May 14 18:12:44.845556 kernel: Demotion targets for Node 0: null
May 14 18:12:44.845563 kernel: Key type .fscrypt registered
May 14 18:12:44.845573 kernel: Key type fscrypt-provisioning registered
May 14 18:12:44.845580 kernel: ima: No TPM chip found, activating TPM-bypass!
May 14 18:12:44.845588 kernel: ima: Allocated hash algorithm: sha1
May 14 18:12:44.845596 kernel: ima: No architecture policies found
May 14 18:12:44.845604 kernel: clk: Disabling unused clocks
May 14 18:12:44.845611 kernel: Warning: unable to open an initial console.
May 14 18:12:44.845619 kernel: Freeing unused kernel image (initmem) memory: 54424K
May 14 18:12:44.845627 kernel: Write protecting the kernel read-only data: 24576k
May 14 18:12:44.845637 kernel: Freeing unused kernel image (rodata/data gap) memory: 296K
May 14 18:12:44.845645 kernel: Run /init as init process
May 14 18:12:44.845652 kernel:   with arguments:
May 14 18:12:44.845660 kernel:     /init
May 14 18:12:44.845668 kernel:   with environment:
May 14 18:12:44.845675 kernel:     HOME=/
May 14 18:12:44.845683 kernel:     TERM=linux
May 14 18:12:44.845691 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 14 18:12:44.845699 systemd[1]: Successfully made /usr/ read-only.
May 14 18:12:44.845712 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE)
May 14 18:12:44.845721 systemd[1]: Detected virtualization kvm.
May 14 18:12:44.845729 systemd[1]: Detected architecture x86-64.
May 14 18:12:44.845737 systemd[1]: Running in initrd.
May 14 18:12:44.845745 systemd[1]: No hostname configured, using default hostname.
May 14 18:12:44.845754 systemd[1]: Hostname set to <localhost>.
May 14 18:12:44.845762 systemd[1]: Initializing machine ID from VM UUID.
May 14 18:12:44.845777 systemd[1]: Queued start job for default target initrd.target.
May 14 18:12:44.845785 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 14 18:12:44.845794 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 14 18:12:44.845803 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 14 18:12:44.845811 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 14 18:12:44.845820 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 14 18:12:44.845829 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 14 18:12:44.845840 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
May 14 18:12:44.845849 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 14 18:12:44.845857 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 14 18:12:44.845866 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 14 18:12:44.845874 systemd[1]: Reached target paths.target - Path Units.
May 14 18:12:44.845882 systemd[1]: Reached target slices.target - Slice Units.
May 14 18:12:44.845890 systemd[1]: Reached target swap.target - Swaps.
May 14 18:12:44.845899 systemd[1]: Reached target timers.target - Timer Units.
May 14 18:12:44.845909 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 14 18:12:44.845917 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 14 18:12:44.845926 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 14 18:12:44.845934 systemd[1]: Listening on systemd-journald.socket - Journal Sockets.
May 14 18:12:44.845942 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 14 18:12:44.845950 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 14 18:12:44.845959 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 14 18:12:44.845967 systemd[1]: Reached target sockets.target - Socket Units.
May 14 18:12:44.845975 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 14 18:12:44.845985 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 14 18:12:44.845994 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 14 18:12:44.846003 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).
May 14 18:12:44.846011 systemd[1]: Starting systemd-fsck-usr.service...
May 14 18:12:44.846019 systemd[1]: Starting systemd-journald.service - Journal Service...
May 14 18:12:44.846027 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 14 18:12:44.846036 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:44.846044 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 14 18:12:44.846054 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 14 18:12:44.846063 systemd[1]: Finished systemd-fsck-usr.service.
May 14 18:12:44.846090 systemd-journald[220]: Collecting audit messages is disabled.
May 14 18:12:44.846111 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 14 18:12:44.846120 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:44.846128 systemd-journald[220]: Journal started
May 14 18:12:44.846146 systemd-journald[220]: Runtime Journal (/run/log/journal/1a2fbc9d492b4a5e8cc44bd4a499f317) is 6M, max 48.5M, 42.4M free.
May 14 18:12:44.840965 systemd-modules-load[223]: Inserted module 'overlay'
May 14 18:12:44.848550 systemd[1]: Started systemd-journald.service - Journal Service.
May 14 18:12:44.853421 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 14 18:12:44.856450 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 14 18:12:44.857835 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 14 18:12:44.860131 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 14 18:12:44.873329 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
May 14 18:12:44.875247 systemd-modules-load[223]: Inserted module 'br_netfilter'
May 14 18:12:44.876422 kernel: Bridge firewalling registered
May 14 18:12:44.876676 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 14 18:12:44.879251 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 14 18:12:44.881475 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 14 18:12:44.881516 systemd-tmpfiles[238]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring.
May 14 18:12:44.886194 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 14 18:12:44.889444 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 14 18:12:44.890674 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 14 18:12:44.902540 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 14 18:12:44.906780 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 14 18:12:44.916201 dracut-cmdline[259]: 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=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0
May 14 18:12:44.952911 systemd-resolved[266]: Positive Trust Anchors:
May 14 18:12:44.952925 systemd-resolved[266]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 14 18:12:44.952956 systemd-resolved[266]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
May 14 18:12:44.955373 systemd-resolved[266]: Defaulting to hostname 'linux'.
May 14 18:12:44.956392 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 14 18:12:44.963023 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 14 18:12:45.030321 kernel: SCSI subsystem initialized
May 14 18:12:45.039320 kernel: Loading iSCSI transport class v2.0-870.
May 14 18:12:45.050324 kernel: iscsi: registered transport (tcp)
May 14 18:12:45.073422 kernel: iscsi: registered transport (qla4xxx)
May 14 18:12:45.073509 kernel: QLogic iSCSI HBA Driver
May 14 18:12:45.094961 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 14 18:12:45.124730 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 14 18:12:45.125902 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 14 18:12:45.173969 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 14 18:12:45.176750 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 14 18:12:45.234354 kernel: raid6: avx2x4   gen() 30225 MB/s
May 14 18:12:45.251321 kernel: raid6: avx2x2   gen() 31123 MB/s
May 14 18:12:45.268415 kernel: raid6: avx2x1   gen() 25766 MB/s
May 14 18:12:45.268431 kernel: raid6: using algorithm avx2x2 gen() 31123 MB/s
May 14 18:12:45.286450 kernel: raid6: .... xor() 19679 MB/s, rmw enabled
May 14 18:12:45.286474 kernel: raid6: using avx2x2 recovery algorithm
May 14 18:12:45.306324 kernel: xor: automatically using best checksumming function   avx       
May 14 18:12:45.468334 kernel: Btrfs loaded, zoned=no, fsverity=no
May 14 18:12:45.475746 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 14 18:12:45.478552 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 14 18:12:45.506174 systemd-udevd[473]: Using default interface naming scheme 'v255'.
May 14 18:12:45.511652 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 14 18:12:45.515148 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 14 18:12:45.539364 dracut-pre-trigger[482]: rd.md=0: removing MD RAID activation
May 14 18:12:45.567039 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 14 18:12:45.568504 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 14 18:12:45.640079 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 14 18:12:45.643355 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 14 18:12:45.677331 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues
May 14 18:12:45.685936 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB)
May 14 18:12:45.695762 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 18:12:45.695780 kernel: cryptd: max_cpu_qlen set to 1000
May 14 18:12:45.705347 kernel: AES CTR mode by8 optimization enabled
May 14 18:12:45.705402 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2
May 14 18:12:45.711317 kernel: libata version 3.00 loaded.
May 14 18:12:45.728359 kernel: ahci 0000:00:1f.2: version 3.0
May 14 18:12:45.766378 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16
May 14 18:12:45.766399 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode
May 14 18:12:45.766580 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)
May 14 18:12:45.766749 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only 
May 14 18:12:45.766882 kernel: scsi host0: ahci
May 14 18:12:45.767023 kernel: scsi host1: ahci
May 14 18:12:45.767158 kernel: scsi host2: ahci
May 14 18:12:45.767349 kernel: scsi host3: ahci
May 14 18:12:45.767515 kernel: scsi host4: ahci
May 14 18:12:45.767692 kernel: scsi host5: ahci
May 14 18:12:45.767865 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 0
May 14 18:12:45.767881 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 0
May 14 18:12:45.767894 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 0
May 14 18:12:45.767907 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 0
May 14 18:12:45.767924 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 0
May 14 18:12:45.767934 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 0
May 14 18:12:45.730715 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 18:12:45.730880 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:45.733703 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:45.737513 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:45.760675 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
May 14 18:12:45.780666 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
May 14 18:12:45.813161 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 14 18:12:45.822238 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
May 14 18:12:45.825580 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
May 14 18:12:45.829559 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 14 18:12:45.829641 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 18:12:45.829691 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:45.833117 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:45.837320 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:45.838591 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 14 18:12:45.852339 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 18:12:45.858330 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 18:12:45.860854 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:46.073544 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
May 14 18:12:46.073601 kernel: ata6: SATA link down (SStatus 0 SControl 300)
May 14 18:12:46.075126 kernel: ata1: SATA link down (SStatus 0 SControl 300)
May 14 18:12:46.075220 kernel: ata4: SATA link down (SStatus 0 SControl 300)
May 14 18:12:46.075231 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
May 14 18:12:46.076325 kernel: ata3.00: applying bridge limits
May 14 18:12:46.076352 kernel: ata2: SATA link down (SStatus 0 SControl 300)
May 14 18:12:46.077324 kernel: ata5: SATA link down (SStatus 0 SControl 300)
May 14 18:12:46.078329 kernel: ata3.00: configured for UDMA/100
May 14 18:12:46.079329 kernel: scsi 2:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
May 14 18:12:46.127328 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
May 14 18:12:46.153028 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
May 14 18:12:46.153042 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0
May 14 18:12:46.543244 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 14 18:12:46.545401 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 14 18:12:46.547271 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 14 18:12:46.548705 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 14 18:12:46.551869 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 14 18:12:46.584322 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 14 18:12:46.865278 disk-uuid[641]: The operation has completed successfully.
May 14 18:12:46.867567 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 14 18:12:46.896449 systemd[1]: disk-uuid.service: Deactivated successfully.
May 14 18:12:46.896564 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 14 18:12:46.928667 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 14 18:12:46.950503 sh[672]: Success
May 14 18:12:46.967711 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 14 18:12:46.967742 kernel: device-mapper: uevent: version 1.0.3
May 14 18:12:46.968853 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
May 14 18:12:46.977321 kernel: device-mapper: verity: sha256 using shash "sha256-ni"
May 14 18:12:47.007381 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 14 18:12:47.010209 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 14 18:12:47.024381 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 14 18:12:47.032768 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay'
May 14 18:12:47.032798 kernel: BTRFS: device fsid dedcf745-d4ff-44ac-b61c-5ec1bad114c7 devid 1 transid 39 /dev/mapper/usr (253:0) scanned by mount (684)
May 14 18:12:47.034057 kernel: BTRFS info (device dm-0): first mount of filesystem dedcf745-d4ff-44ac-b61c-5ec1bad114c7
May 14 18:12:47.034076 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
May 14 18:12:47.035568 kernel: BTRFS info (device dm-0): using free-space-tree
May 14 18:12:47.039628 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 14 18:12:47.041939 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System.
May 14 18:12:47.044102 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 14 18:12:47.046181 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 14 18:12:47.048640 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 14 18:12:47.080792 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (716)
May 14 18:12:47.080833 kernel: BTRFS info (device vda6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 18:12:47.080843 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 14 18:12:47.082376 kernel: BTRFS info (device vda6): using free-space-tree
May 14 18:12:47.089316 kernel: BTRFS info (device vda6): last unmount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 18:12:47.090003 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 14 18:12:47.093813 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 14 18:12:47.169049 ignition[762]: Ignition 2.21.0
May 14 18:12:47.169062 ignition[762]: Stage: fetch-offline
May 14 18:12:47.169089 ignition[762]: no configs at "/usr/lib/ignition/base.d"
May 14 18:12:47.169100 ignition[762]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 14 18:12:47.169176 ignition[762]: parsed url from cmdline: ""
May 14 18:12:47.169179 ignition[762]: no config URL provided
May 14 18:12:47.169184 ignition[762]: reading system config file "/usr/lib/ignition/user.ign"
May 14 18:12:47.169191 ignition[762]: no config at "/usr/lib/ignition/user.ign"
May 14 18:12:47.169210 ignition[762]: op(1): [started]  loading QEMU firmware config module
May 14 18:12:47.169215 ignition[762]: op(1): executing: "modprobe" "qemu_fw_cfg"
May 14 18:12:47.176940 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 14 18:12:47.180124 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 14 18:12:47.186661 ignition[762]: op(1): [finished] loading QEMU firmware config module
May 14 18:12:47.188006 ignition[762]: parsing config with SHA512: 0d12c6538e004e0d5335d129e36d82ad9047363443a715788e5097f216b296c89d3b83b3bb9ca836d79136138da2274aa81a16307033721e44d13a82bc5ab2d2
May 14 18:12:47.192654 unknown[762]: fetched base config from "system"
May 14 18:12:47.192766 unknown[762]: fetched user config from "qemu"
May 14 18:12:47.192922 ignition[762]: fetch-offline: fetch-offline passed
May 14 18:12:47.192999 ignition[762]: Ignition finished successfully
May 14 18:12:47.195545 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 14 18:12:47.222521 systemd-networkd[863]: lo: Link UP
May 14 18:12:47.222535 systemd-networkd[863]: lo: Gained carrier
May 14 18:12:47.224258 systemd-networkd[863]: Enumeration completed
May 14 18:12:47.224377 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 14 18:12:47.224600 systemd-networkd[863]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 18:12:47.224604 systemd-networkd[863]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 14 18:12:47.225444 systemd-networkd[863]: eth0: Link UP
May 14 18:12:47.225448 systemd-networkd[863]: eth0: Gained carrier
May 14 18:12:47.225456 systemd-networkd[863]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 18:12:47.226770 systemd[1]: Reached target network.target - Network.
May 14 18:12:47.229872 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json).
May 14 18:12:47.232013 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 14 18:12:47.251339 systemd-networkd[863]: eth0: DHCPv4 address 10.0.0.142/16, gateway 10.0.0.1 acquired from 10.0.0.1
May 14 18:12:47.272691 ignition[867]: Ignition 2.21.0
May 14 18:12:47.272702 ignition[867]: Stage: kargs
May 14 18:12:47.272883 ignition[867]: no configs at "/usr/lib/ignition/base.d"
May 14 18:12:47.272896 ignition[867]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 14 18:12:47.275635 ignition[867]: kargs: kargs passed
May 14 18:12:47.275714 ignition[867]: Ignition finished successfully
May 14 18:12:47.280273 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 14 18:12:47.281335 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 14 18:12:47.313742 ignition[876]: Ignition 2.21.0
May 14 18:12:47.313754 ignition[876]: Stage: disks
May 14 18:12:47.313868 ignition[876]: no configs at "/usr/lib/ignition/base.d"
May 14 18:12:47.313877 ignition[876]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 14 18:12:47.316271 ignition[876]: disks: disks passed
May 14 18:12:47.316352 ignition[876]: Ignition finished successfully
May 14 18:12:47.320878 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 14 18:12:47.322183 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 14 18:12:47.322957 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 14 18:12:47.323322 systemd[1]: Reached target local-fs.target - Local File Systems.
May 14 18:12:47.323796 systemd[1]: Reached target sysinit.target - System Initialization.
May 14 18:12:47.324124 systemd[1]: Reached target basic.target - Basic System.
May 14 18:12:47.332822 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 14 18:12:47.356743 systemd-fsck[886]: ROOT: clean, 15/553520 files, 52789/553472 blocks
May 14 18:12:47.364827 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 14 18:12:47.369706 systemd[1]: Mounting sysroot.mount - /sysroot...
May 14 18:12:47.480330 kernel: EXT4-fs (vda9): mounted filesystem d6072e19-4548-4806-a012-87bb17c59f4c r/w with ordered data mode. Quota mode: none.
May 14 18:12:47.481364 systemd[1]: Mounted sysroot.mount - /sysroot.
May 14 18:12:47.481964 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 14 18:12:47.485416 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 14 18:12:47.488018 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 14 18:12:47.489112 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
May 14 18:12:47.489156 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 14 18:12:47.489183 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 14 18:12:47.499528 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 14 18:12:47.501822 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 14 18:12:47.507871 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (895)
May 14 18:12:47.507893 kernel: BTRFS info (device vda6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 18:12:47.507903 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 14 18:12:47.507913 kernel: BTRFS info (device vda6): using free-space-tree
May 14 18:12:47.512161 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 14 18:12:47.546399 initrd-setup-root[919]: cut: /sysroot/etc/passwd: No such file or directory
May 14 18:12:47.551935 initrd-setup-root[926]: cut: /sysroot/etc/group: No such file or directory
May 14 18:12:47.556006 initrd-setup-root[933]: cut: /sysroot/etc/shadow: No such file or directory
May 14 18:12:47.561239 initrd-setup-root[940]: cut: /sysroot/etc/gshadow: No such file or directory
May 14 18:12:47.654127 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 14 18:12:47.656794 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 14 18:12:47.659581 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 14 18:12:47.676328 kernel: BTRFS info (device vda6): last unmount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 18:12:47.692454 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 14 18:12:47.707202 ignition[1009]: INFO     : Ignition 2.21.0
May 14 18:12:47.707202 ignition[1009]: INFO     : Stage: mount
May 14 18:12:47.709014 ignition[1009]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 14 18:12:47.709014 ignition[1009]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 14 18:12:47.709014 ignition[1009]: INFO     : mount: mount passed
May 14 18:12:47.709014 ignition[1009]: INFO     : Ignition finished successfully
May 14 18:12:47.716401 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 14 18:12:47.719873 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 14 18:12:48.032069 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 14 18:12:48.033779 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 14 18:12:48.067842 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (1021)
May 14 18:12:48.067873 kernel: BTRFS info (device vda6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998
May 14 18:12:48.067884 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm
May 14 18:12:48.068715 kernel: BTRFS info (device vda6): using free-space-tree
May 14 18:12:48.072656 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 14 18:12:48.106129 ignition[1038]: INFO     : Ignition 2.21.0
May 14 18:12:48.106129 ignition[1038]: INFO     : Stage: files
May 14 18:12:48.108118 ignition[1038]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 14 18:12:48.108118 ignition[1038]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 14 18:12:48.108118 ignition[1038]: DEBUG    : files: compiled without relabeling support, skipping
May 14 18:12:48.108118 ignition[1038]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 14 18:12:48.108118 ignition[1038]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 14 18:12:48.114962 ignition[1038]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 14 18:12:48.114962 ignition[1038]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 14 18:12:48.114962 ignition[1038]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 14 18:12:48.110428 unknown[1038]: wrote ssh authorized keys file for user: core
May 14 18:12:48.158239 ignition[1038]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 14 18:12:48.177271 ignition[1038]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 14 18:12:48.177271 ignition[1038]: INFO     : files: op(4): [started]  processing unit "coreos-metadata.service"
May 14 18:12:48.177271 ignition[1038]: INFO     : files: op(4): op(5): [started]  writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
May 14 18:12:48.249674 ignition[1038]: INFO     : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
May 14 18:12:48.249674 ignition[1038]: INFO     : files: op(4): [finished] processing unit "coreos-metadata.service"
May 14 18:12:48.249674 ignition[1038]: INFO     : files: op(6): [started]  processing unit "docker.service"
May 14 18:12:48.249674 ignition[1038]: INFO     : files: op(6): [finished] processing unit "docker.service"
May 14 18:12:48.249674 ignition[1038]: INFO     : files: op(7): [started]  setting preset to disabled for "coreos-metadata.service"
May 14 18:12:48.272425 ignition[1038]: INFO     : files: op(7): op(8): [started]  removing enablement symlink(s) for "coreos-metadata.service"
May 14 18:12:48.278903 ignition[1038]: INFO     : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service"
May 14 18:12:48.280693 ignition[1038]: INFO     : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service"
May 14 18:12:48.280693 ignition[1038]: INFO     : files: op(9): [started]  setting preset to enabled for "docker.service"
May 14 18:12:48.280693 ignition[1038]: INFO     : files: op(9): [finished] setting preset to enabled for "docker.service"
May 14 18:12:48.280693 ignition[1038]: INFO     : files: createResultFile: createFiles: op(a): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 14 18:12:48.280693 ignition[1038]: INFO     : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 14 18:12:48.280693 ignition[1038]: INFO     : files: files passed
May 14 18:12:48.280693 ignition[1038]: INFO     : Ignition finished successfully
May 14 18:12:48.286403 systemd[1]: Finished ignition-files.service - Ignition (files).
May 14 18:12:48.288921 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 14 18:12:48.294687 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 14 18:12:48.308953 systemd[1]: ignition-quench.service: Deactivated successfully.
May 14 18:12:48.309095 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 14 18:12:48.314660 initrd-setup-root-after-ignition[1067]: grep: /sysroot/oem/oem-release: No such file or directory
May 14 18:12:48.316234 initrd-setup-root-after-ignition[1069]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 14 18:12:48.316234 initrd-setup-root-after-ignition[1069]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 14 18:12:48.320494 initrd-setup-root-after-ignition[1073]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 14 18:12:48.324811 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 14 18:12:48.328210 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 14 18:12:48.330578 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 14 18:12:48.383476 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 14 18:12:48.383618 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 14 18:12:48.385948 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 14 18:12:48.388098 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 14 18:12:48.390191 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 14 18:12:48.392847 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 14 18:12:48.438225 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 14 18:12:48.451920 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 14 18:12:48.478097 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 14 18:12:48.478414 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 14 18:12:48.481916 systemd[1]: Stopped target timers.target - Timer Units.
May 14 18:12:48.483941 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 14 18:12:48.484123 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 14 18:12:48.488143 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 14 18:12:48.488383 systemd[1]: Stopped target basic.target - Basic System.
May 14 18:12:48.491206 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 14 18:12:48.493205 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 14 18:12:48.495477 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 14 18:12:48.497699 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System.
May 14 18:12:48.499953 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 14 18:12:48.502055 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 14 18:12:48.504392 systemd[1]: Stopped target sysinit.target - System Initialization.
May 14 18:12:48.504817 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 14 18:12:48.505142 systemd[1]: Stopped target swap.target - Swaps.
May 14 18:12:48.505634 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 14 18:12:48.505813 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 14 18:12:48.513665 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 14 18:12:48.513858 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 14 18:12:48.514143 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 14 18:12:48.514499 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 14 18:12:48.518064 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 14 18:12:48.518195 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 14 18:12:48.525121 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 14 18:12:48.525281 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 14 18:12:48.527945 systemd[1]: Stopped target paths.target - Path Units.
May 14 18:12:48.530166 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 14 18:12:48.533362 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 14 18:12:48.533536 systemd[1]: Stopped target slices.target - Slice Units.
May 14 18:12:48.536609 systemd[1]: Stopped target sockets.target - Socket Units.
May 14 18:12:48.538583 systemd[1]: iscsid.socket: Deactivated successfully.
May 14 18:12:48.538686 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 14 18:12:48.540436 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 14 18:12:48.540524 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 14 18:12:48.543226 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 14 18:12:48.543371 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 14 18:12:48.544232 systemd[1]: ignition-files.service: Deactivated successfully.
May 14 18:12:48.544351 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 14 18:12:48.550606 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 14 18:12:48.554236 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 14 18:12:48.555178 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 14 18:12:48.555370 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 14 18:12:48.559538 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 14 18:12:48.559672 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 14 18:12:48.566845 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 14 18:12:48.566965 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 14 18:12:48.582090 ignition[1093]: INFO     : Ignition 2.21.0
May 14 18:12:48.582090 ignition[1093]: INFO     : Stage: umount
May 14 18:12:48.584192 ignition[1093]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 14 18:12:48.584192 ignition[1093]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 14 18:12:48.584192 ignition[1093]: INFO     : umount: umount passed
May 14 18:12:48.584192 ignition[1093]: INFO     : Ignition finished successfully
May 14 18:12:48.589287 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 14 18:12:48.590098 systemd[1]: ignition-mount.service: Deactivated successfully.
May 14 18:12:48.590271 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 14 18:12:48.592094 systemd[1]: Stopped target network.target - Network.
May 14 18:12:48.592525 systemd[1]: ignition-disks.service: Deactivated successfully.
May 14 18:12:48.592612 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 14 18:12:48.592876 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 14 18:12:48.592922 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 14 18:12:48.593217 systemd[1]: ignition-setup.service: Deactivated successfully.
May 14 18:12:48.593266 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 14 18:12:48.593724 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 14 18:12:48.593763 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 14 18:12:48.594216 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 14 18:12:48.601340 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 14 18:12:48.604491 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 14 18:12:48.604606 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 14 18:12:48.606167 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 14 18:12:48.606268 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 14 18:12:48.608436 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 14 18:12:48.608552 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 14 18:12:48.612503 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
May 14 18:12:48.612767 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 14 18:12:48.612914 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 14 18:12:48.616969 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
May 14 18:12:48.617992 systemd[1]: Stopped target network-pre.target - Preparation for Network.
May 14 18:12:48.619306 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 14 18:12:48.619346 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 14 18:12:48.624689 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 14 18:12:48.627405 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 14 18:12:48.627456 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 14 18:12:48.628756 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 14 18:12:48.628800 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 14 18:12:48.632744 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 14 18:12:48.632790 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 14 18:12:48.633274 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 14 18:12:48.633332 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 14 18:12:48.639082 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 14 18:12:48.655125 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 14 18:12:48.655348 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 14 18:12:48.656503 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 14 18:12:48.656548 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 14 18:12:48.659685 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 14 18:12:48.659720 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 14 18:12:48.661798 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 14 18:12:48.661846 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 14 18:12:48.664834 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 14 18:12:48.664880 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 14 18:12:48.667650 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 14 18:12:48.667703 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 14 18:12:48.672512 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 14 18:12:48.672699 systemd[1]: systemd-network-generator.service: Deactivated successfully.
May 14 18:12:48.672752 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line.
May 14 18:12:48.677162 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 14 18:12:48.677228 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 14 18:12:48.681538 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
May 14 18:12:48.681585 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 14 18:12:48.686395 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 14 18:12:48.686446 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 14 18:12:48.689846 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 18:12:48.689921 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:48.692783 systemd[1]: network-cleanup.service: Deactivated successfully.
May 14 18:12:48.696526 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 14 18:12:48.705730 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 14 18:12:48.705860 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 14 18:12:48.707165 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 14 18:12:48.710045 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 14 18:12:48.736363 systemd[1]: Switching root.
May 14 18:12:48.775482 systemd-journald[220]: Journal stopped
May 14 18:12:49.696018 systemd-journald[220]: Received SIGTERM from PID 1 (systemd).
May 14 18:12:49.696102 kernel: SELinux:  policy capability network_peer_controls=1
May 14 18:12:49.696117 kernel: SELinux:  policy capability open_perms=1
May 14 18:12:49.696128 kernel: SELinux:  policy capability extended_socket_class=1
May 14 18:12:49.696143 kernel: SELinux:  policy capability always_check_network=0
May 14 18:12:49.696154 kernel: SELinux:  policy capability cgroup_seclabel=1
May 14 18:12:49.696166 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 14 18:12:49.696176 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 14 18:12:49.696194 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 14 18:12:49.696206 kernel: SELinux:  policy capability userspace_initial_context=0
May 14 18:12:49.696217 kernel: audit: type=1403 audit(1747246368.878:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 14 18:12:49.696230 systemd[1]: Successfully loaded SELinux policy in 51.598ms.
May 14 18:12:49.696252 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 14.887ms.
May 14 18:12:49.696267 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE)
May 14 18:12:49.696280 systemd[1]: Detected virtualization kvm.
May 14 18:12:49.696304 systemd[1]: Detected architecture x86-64.
May 14 18:12:49.696323 systemd[1]: Detected first boot.
May 14 18:12:49.696335 systemd[1]: Initializing machine ID from VM UUID.
May 14 18:12:49.696347 zram_generator::config[1138]: No configuration found.
May 14 18:12:49.696362 kernel: Guest personality initialized and is inactive
May 14 18:12:49.696374 kernel: VMCI host device registered (name=vmci, major=10, minor=125)
May 14 18:12:49.696385 kernel: Initialized host personality
May 14 18:12:49.696396 kernel: NET: Registered PF_VSOCK protocol family
May 14 18:12:49.696408 systemd[1]: Populated /etc with preset unit settings.
May 14 18:12:49.696420 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully.
May 14 18:12:49.696432 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 14 18:12:49.696444 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 14 18:12:49.696458 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 14 18:12:49.696471 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 14 18:12:49.696482 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 14 18:12:49.696494 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 14 18:12:49.696506 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 14 18:12:49.696518 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 14 18:12:49.696530 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 14 18:12:49.696546 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 14 18:12:49.696558 systemd[1]: Created slice user.slice - User and Session Slice.
May 14 18:12:49.696573 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 14 18:12:49.696585 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 14 18:12:49.696597 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 14 18:12:49.696609 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 14 18:12:49.696621 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 14 18:12:49.696635 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 14 18:12:49.696648 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
May 14 18:12:49.696664 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 14 18:12:49.696676 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 14 18:12:49.696688 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 14 18:12:49.696700 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 14 18:12:49.696712 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 14 18:12:49.696724 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 14 18:12:49.696735 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 14 18:12:49.696748 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 14 18:12:49.696760 systemd[1]: Reached target slices.target - Slice Units.
May 14 18:12:49.696771 systemd[1]: Reached target swap.target - Swaps.
May 14 18:12:49.696785 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 14 18:12:49.696797 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 14 18:12:49.696809 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption.
May 14 18:12:49.696821 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 14 18:12:49.696834 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 14 18:12:49.696846 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 14 18:12:49.696857 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 14 18:12:49.696869 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 14 18:12:49.696881 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 14 18:12:49.696895 systemd[1]: Mounting media.mount - External Media Directory...
May 14 18:12:49.696907 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 18:12:49.696919 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 14 18:12:49.696931 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 14 18:12:49.696943 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 14 18:12:49.696955 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
May 14 18:12:49.696967 systemd[1]: Reached target machines.target - Containers.
May 14 18:12:49.696979 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 14 18:12:49.696994 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 18:12:49.697006 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 14 18:12:49.697018 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 14 18:12:49.697030 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 14 18:12:49.697041 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 14 18:12:49.697054 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 14 18:12:49.697066 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 14 18:12:49.697078 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 14 18:12:49.697094 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 14 18:12:49.697105 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 14 18:12:49.697117 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 14 18:12:49.697129 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 14 18:12:49.697141 systemd[1]: Stopped systemd-fsck-usr.service.
May 14 18:12:49.697153 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
May 14 18:12:49.697165 systemd[1]: Starting systemd-journald.service - Journal Service...
May 14 18:12:49.697177 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 14 18:12:49.697197 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 14 18:12:49.697211 kernel: loop: module loaded
May 14 18:12:49.697223 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 14 18:12:49.697236 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials...
May 14 18:12:49.697247 kernel: fuse: init (API version 7.41)
May 14 18:12:49.697259 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 14 18:12:49.697273 systemd[1]: verity-setup.service: Deactivated successfully.
May 14 18:12:49.697285 systemd[1]: Stopped verity-setup.service.
May 14 18:12:49.697344 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 18:12:49.697358 kernel: ACPI: bus type drm_connector registered
May 14 18:12:49.697369 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 14 18:12:49.697381 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 14 18:12:49.697396 systemd[1]: Mounted media.mount - External Media Directory.
May 14 18:12:49.697408 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 14 18:12:49.697420 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 14 18:12:49.697432 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 14 18:12:49.697444 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 14 18:12:49.697479 systemd-journald[1213]: Collecting audit messages is disabled.
May 14 18:12:49.697501 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 14 18:12:49.697515 systemd-journald[1213]: Journal started
May 14 18:12:49.697538 systemd-journald[1213]: Runtime Journal (/run/log/journal/1a2fbc9d492b4a5e8cc44bd4a499f317) is 6M, max 48.5M, 42.4M free.
May 14 18:12:49.418134 systemd[1]: Queued start job for default target multi-user.target.
May 14 18:12:49.436224 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
May 14 18:12:49.436666 systemd[1]: systemd-journald.service: Deactivated successfully.
May 14 18:12:49.699341 systemd[1]: Started systemd-journald.service - Journal Service.
May 14 18:12:49.701065 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 14 18:12:49.701289 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 14 18:12:49.702937 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 14 18:12:49.703149 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 14 18:12:49.704606 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 14 18:12:49.704808 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 14 18:12:49.706167 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 14 18:12:49.706401 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 14 18:12:49.707945 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 14 18:12:49.708150 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 14 18:12:49.709572 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 14 18:12:49.709791 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 14 18:12:49.711210 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 14 18:12:49.712757 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 14 18:12:49.714389 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 14 18:12:49.715954 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials.
May 14 18:12:49.730612 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 14 18:12:49.733205 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 14 18:12:49.735348 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 14 18:12:49.736492 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 14 18:12:49.736519 systemd[1]: Reached target local-fs.target - Local File Systems.
May 14 18:12:49.738527 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management.
May 14 18:12:49.743415 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 14 18:12:49.744650 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 18:12:49.745770 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 14 18:12:49.748561 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 14 18:12:49.749813 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 14 18:12:49.750773 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 14 18:12:49.752149 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 14 18:12:49.754414 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 14 18:12:49.757003 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 14 18:12:49.765410 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 14 18:12:49.768646 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 14 18:12:49.770079 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 14 18:12:49.771354 systemd-journald[1213]: Time spent on flushing to /var/log/journal/1a2fbc9d492b4a5e8cc44bd4a499f317 is 22.538ms for 1037 entries.
May 14 18:12:49.771354 systemd-journald[1213]: System Journal (/var/log/journal/1a2fbc9d492b4a5e8cc44bd4a499f317) is 8M, max 195.6M, 187.6M free.
May 14 18:12:49.811778 systemd-journald[1213]: Received client request to flush runtime journal.
May 14 18:12:49.811833 kernel: loop0: detected capacity change from 0 to 113872
May 14 18:12:49.811858 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 14 18:12:49.772511 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 14 18:12:49.781521 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 14 18:12:49.784164 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 14 18:12:49.787482 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk...
May 14 18:12:49.797400 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 14 18:12:49.814640 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 14 18:12:49.821838 systemd-tmpfiles[1258]: ACLs are not supported, ignoring.
May 14 18:12:49.821855 systemd-tmpfiles[1258]: ACLs are not supported, ignoring.
May 14 18:12:49.828937 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 14 18:12:49.832527 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 14 18:12:49.834022 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk.
May 14 18:12:49.838326 kernel: loop1: detected capacity change from 0 to 146240
May 14 18:12:49.866517 kernel: loop2: detected capacity change from 0 to 113872
May 14 18:12:49.874289 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 14 18:12:49.876325 kernel: loop3: detected capacity change from 0 to 146240
May 14 18:12:49.877810 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 14 18:12:49.896706 (sd-merge)[1278]: Using extensions 'containerd-flatcar', 'docker-flatcar'.
May 14 18:12:49.897198 (sd-merge)[1278]: Merged extensions into '/usr'.
May 14 18:12:49.902115 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 14 18:12:49.903898 systemd-tmpfiles[1280]: ACLs are not supported, ignoring.
May 14 18:12:49.903918 systemd-tmpfiles[1280]: ACLs are not supported, ignoring.
May 14 18:12:49.906005 systemd[1]: Starting ensure-sysext.service...
May 14 18:12:49.908526 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 14 18:12:49.910254 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 14 18:12:49.929964 systemd[1]: Reload requested from client PID 1283 ('systemctl') (unit ensure-sysext.service)...
May 14 18:12:49.930103 systemd[1]: Reloading...
May 14 18:12:49.940577 systemd-tmpfiles[1284]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring.
May 14 18:12:49.940620 systemd-tmpfiles[1284]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring.
May 14 18:12:49.940856 systemd-tmpfiles[1284]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 14 18:12:49.941052 systemd-tmpfiles[1284]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 14 18:12:49.941839 systemd-tmpfiles[1284]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 14 18:12:49.942068 systemd-tmpfiles[1284]: ACLs are not supported, ignoring.
May 14 18:12:49.942136 systemd-tmpfiles[1284]: ACLs are not supported, ignoring.
May 14 18:12:49.946897 systemd-tmpfiles[1284]: Detected autofs mount point /boot during canonicalization of boot.
May 14 18:12:49.946985 systemd-tmpfiles[1284]: Skipping /boot
May 14 18:12:49.959480 systemd-tmpfiles[1284]: Detected autofs mount point /boot during canonicalization of boot.
May 14 18:12:49.959615 systemd-tmpfiles[1284]: Skipping /boot
May 14 18:12:50.001329 zram_generator::config[1319]: No configuration found.
May 14 18:12:50.106702 ldconfig[1252]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 14 18:12:50.111380 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
May 14 18:12:50.198573 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 14 18:12:50.198926 systemd[1]: Reloading finished in 268 ms.
May 14 18:12:50.229252 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 14 18:12:50.247844 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 14 18:12:50.258327 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 14 18:12:50.261105 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 14 18:12:50.268392 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 14 18:12:50.274521 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 14 18:12:50.279500 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 14 18:12:50.283698 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 18:12:50.290274 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 14 18:12:50.294511 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 14 18:12:50.298357 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 14 18:12:50.299654 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 18:12:50.300018 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
May 14 18:12:50.302214 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 14 18:12:50.310602 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 14 18:12:50.313103 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 14 18:12:50.313504 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 14 18:12:50.315193 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 14 18:12:50.315417 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 14 18:12:50.316984 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 14 18:12:50.317209 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 14 18:12:50.327249 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 18:12:50.330164 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 14 18:12:50.334136 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 14 18:12:50.340616 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 14 18:12:50.341864 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 18:12:50.342048 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
May 14 18:12:50.344318 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 14 18:12:50.347131 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 14 18:12:50.347400 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 14 18:12:50.350623 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 14 18:12:50.350769 augenrules[1387]: No rules
May 14 18:12:50.351315 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 14 18:12:50.353357 systemd[1]: audit-rules.service: Deactivated successfully.
May 14 18:12:50.353669 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 14 18:12:50.356484 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 14 18:12:50.356943 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 14 18:12:50.369364 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 14 18:12:50.370824 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 14 18:12:50.372455 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 14 18:12:50.379164 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 14 18:12:50.383471 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 14 18:12:50.385755 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 14 18:12:50.388468 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 14 18:12:50.388587 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
May 14 18:12:50.389769 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 14 18:12:50.391644 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 14 18:12:50.393872 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 14 18:12:50.395881 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 14 18:12:50.396112 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 14 18:12:50.397855 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 14 18:12:50.398068 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 14 18:12:50.400031 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 14 18:12:50.400327 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 14 18:12:50.401575 augenrules[1397]: /sbin/augenrules: No change
May 14 18:12:50.401956 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 14 18:12:50.402162 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 14 18:12:50.410661 augenrules[1429]: No rules
May 14 18:12:50.410690 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 14 18:12:50.410795 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 14 18:12:50.412532 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 14 18:12:50.416393 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 14 18:12:50.417540 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
May 14 18:12:50.418039 systemd[1]: Finished ensure-sysext.service.
May 14 18:12:50.419383 systemd[1]: audit-rules.service: Deactivated successfully.
May 14 18:12:50.426506 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 14 18:12:50.433392 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
May 14 18:12:50.438539 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 18:12:50.438552 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 14 18:12:50.440036 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 14 18:12:50.451965 systemd-resolved[1355]: Positive Trust Anchors:
May 14 18:12:50.451982 systemd-resolved[1355]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 14 18:12:50.452015 systemd-resolved[1355]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
May 14 18:12:50.456005 systemd-resolved[1355]: Defaulting to hostname 'linux'.
May 14 18:12:50.457825 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 14 18:12:50.459072 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 14 18:12:50.462746 systemd-udevd[1434]: Using default interface naming scheme 'v255'.
May 14 18:12:50.480312 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 14 18:12:50.486955 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 14 18:12:50.537191 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
May 14 18:12:50.538997 systemd[1]: Reached target sysinit.target - System Initialization.
May 14 18:12:50.540354 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 14 18:12:50.541712 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
May 14 18:12:50.543023 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer.
May 14 18:12:50.544254 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 14 18:12:50.545596 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 14 18:12:50.545627 systemd[1]: Reached target paths.target - Path Units.
May 14 18:12:50.546609 systemd[1]: Reached target time-set.target - System Time Set.
May 14 18:12:50.547847 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 14 18:12:50.549078 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 14 18:12:50.550424 systemd[1]: Reached target timers.target - Timer Units.
May 14 18:12:50.552079 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 14 18:12:50.554954 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 14 18:12:50.560698 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
May 14 18:12:50.563461 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
May 14 18:12:50.565001 systemd[1]: Reached target ssh-access.target - SSH Access Available.
May 14 18:12:50.579286 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 14 18:12:50.581056 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket.
May 14 18:12:50.582979 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 14 18:12:50.591680 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 14 18:12:50.599407 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
May 14 18:12:50.606509 systemd-networkd[1446]: lo: Link UP
May 14 18:12:50.606524 systemd-networkd[1446]: lo: Gained carrier
May 14 18:12:50.608273 systemd[1]: Reached target sockets.target - Socket Units.
May 14 18:12:50.609316 systemd[1]: Reached target basic.target - Basic System.
May 14 18:12:50.610385 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 14 18:12:50.610413 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 14 18:12:50.610811 systemd-networkd[1446]: Enumeration completed
May 14 18:12:50.612351 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 14 18:12:50.614649 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 14 18:12:50.617327 kernel: mousedev: PS/2 mouse device common for all mice
May 14 18:12:50.617289 systemd-networkd[1446]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 18:12:50.617317 systemd-networkd[1446]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 14 18:12:50.617490 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 14 18:12:50.619536 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 14 18:12:50.620583 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment).
May 14 18:12:50.621841 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh...
May 14 18:12:50.628328 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
May 14 18:12:50.628571 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 14 18:12:50.630728 systemd-networkd[1446]: eth0: Link UP
May 14 18:12:50.630880 systemd-networkd[1446]: eth0: Gained carrier
May 14 18:12:50.630907 systemd-networkd[1446]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 14 18:12:50.631212 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 14 18:12:50.631468 jq[1484]: false
May 14 18:12:50.633564 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 14 18:12:50.638903 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 14 18:12:50.643355 systemd-networkd[1446]: eth0: DHCPv4 address 10.0.0.142/16, gateway 10.0.0.1 acquired from 10.0.0.1
May 14 18:12:50.644914 systemd-timesyncd[1438]: Network configuration changed, trying to establish connection.
May 14 18:12:51.466076 systemd-timesyncd[1438]: Contacted time server 10.0.0.1:123 (10.0.0.1).
May 14 18:12:51.466125 systemd-timesyncd[1438]: Initial clock synchronization to Wed 2025-05-14 18:12:51.466007 UTC.
May 14 18:12:51.466154 systemd-resolved[1355]: Clock change detected. Flushing caches.
May 14 18:12:51.469213 systemd[1]: Starting systemd-logind.service - User Login Management...
May 14 18:12:51.472836 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 14 18:12:51.473386 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 14 18:12:51.475008 systemd[1]: Starting update-engine.service - Update Engine...
May 14 18:12:51.477946 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 14 18:12:51.483870 kernel: ACPI: button: Power Button [PWRF]
May 14 18:12:51.480696 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 14 18:12:51.481600 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 14 18:12:51.482197 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 14 18:12:51.482455 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 14 18:12:51.485536 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 14 18:12:51.486950 google_oslogin_nss_cache[1486]: oslogin_cache_refresh[1486]: Refreshing passwd entry cache
May 14 18:12:51.487932 oslogin_cache_refresh[1486]: Refreshing passwd entry cache
May 14 18:12:51.490175 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 14 18:12:51.492119 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 14 18:12:51.498210 jq[1495]: true
May 14 18:12:51.501091 systemd[1]: motdgen.service: Deactivated successfully.
May 14 18:12:51.501419 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 14 18:12:51.504268 extend-filesystems[1485]: Found loop2
May 14 18:12:51.504268 extend-filesystems[1485]: Found loop3
May 14 18:12:51.504268 extend-filesystems[1485]: Found sr0
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda1
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda2
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda3
May 14 18:12:51.504268 extend-filesystems[1485]: Found usr
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda4
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda6
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda7
May 14 18:12:51.504268 extend-filesystems[1485]: Found vda9
May 14 18:12:51.504268 extend-filesystems[1485]: Checking size of /dev/vda9
May 14 18:12:51.506256 systemd[1]: Reached target network.target - Network.
May 14 18:12:51.528308 update_engine[1493]: I20250514 18:12:51.527556  1493 main.cc:92] Flatcar Update Engine starting
May 14 18:12:51.510253 oslogin_cache_refresh[1486]: Failure getting users, quitting
May 14 18:12:51.528543 google_oslogin_nss_cache[1486]: oslogin_cache_refresh[1486]: Failure getting users, quitting
May 14 18:12:51.528543 google_oslogin_nss_cache[1486]: oslogin_cache_refresh[1486]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 14 18:12:51.528543 google_oslogin_nss_cache[1486]: oslogin_cache_refresh[1486]: Refreshing group entry cache
May 14 18:12:51.511968 systemd[1]: Starting containerd.service - containerd container runtime...
May 14 18:12:51.528637 jq[1507]: true
May 14 18:12:51.510275 oslogin_cache_refresh[1486]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 14 18:12:51.514427 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd...
May 14 18:12:51.510331 oslogin_cache_refresh[1486]: Refreshing group entry cache
May 14 18:12:51.517011 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 14 18:12:51.535272 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device
May 14 18:12:51.535480 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
May 14 18:12:51.535636 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
May 14 18:12:51.542478 extend-filesystems[1485]: Old size kept for /dev/vda9
May 14 18:12:51.543575 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 14 18:12:51.544380 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 14 18:12:51.552160 google_oslogin_nss_cache[1486]: oslogin_cache_refresh[1486]: Failure getting groups, quitting
May 14 18:12:51.552160 google_oslogin_nss_cache[1486]: oslogin_cache_refresh[1486]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 14 18:12:51.552152 oslogin_cache_refresh[1486]: Failure getting groups, quitting
May 14 18:12:51.552168 oslogin_cache_refresh[1486]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 14 18:12:51.554950 systemd[1]: google-oslogin-cache.service: Deactivated successfully.
May 14 18:12:51.555255 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh.
May 14 18:12:51.568926 dbus-daemon[1482]: [system] SELinux support is enabled
May 14 18:12:51.569309 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 14 18:12:51.574180 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml).
May 14 18:12:51.579990 update_engine[1493]: I20250514 18:12:51.575023  1493 update_check_scheduler.cc:74] Next update check in 6m31s
May 14 18:12:51.574204 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 14 18:12:51.575560 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
May 14 18:12:51.575576 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 14 18:12:51.577548 systemd[1]: Started update-engine.service - Update Engine.
May 14 18:12:51.581082 (ntainerd)[1529]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 14 18:12:51.582602 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 14 18:12:51.590488 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd.
May 14 18:12:51.604540 systemd-logind[1492]: New seat seat0.
May 14 18:12:51.606532 systemd[1]: Started systemd-logind.service - User Login Management.
May 14 18:12:51.611498 bash[1547]: Updated "/home/core/.ssh/authorized_keys"
May 14 18:12:51.613466 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 14 18:12:51.617759 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
May 14 18:12:51.676774 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:51.696682 systemd-logind[1492]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
May 14 18:12:51.757367 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 14 18:12:51.759116 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:51.768270 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 14 18:12:51.774022 locksmithd[1540]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 14 18:12:51.783634 systemd-logind[1492]: Watching system buttons on /dev/input/event2 (Power Button)
May 14 18:12:51.812966 kernel: kvm_amd: TSC scaling supported
May 14 18:12:51.813056 kernel: kvm_amd: Nested Virtualization enabled
May 14 18:12:51.813070 kernel: kvm_amd: Nested Paging enabled
May 14 18:12:51.813082 kernel: kvm_amd: LBR virtualization supported
May 14 18:12:51.814153 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported
May 14 18:12:51.814173 kernel: kvm_amd: Virtual GIF supported
May 14 18:12:51.836578 containerd[1529]: time="2025-05-14T18:12:51Z" 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
May 14 18:12:51.838437 containerd[1529]: time="2025-05-14T18:12:51.838409097Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4
May 14 18:12:51.855251 containerd[1529]: time="2025-05-14T18:12:51.855210344Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="102.653µs"
May 14 18:12:51.855251 containerd[1529]: time="2025-05-14T18:12:51.855246692Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
May 14 18:12:51.855310 containerd[1529]: time="2025-05-14T18:12:51.855263934Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
May 14 18:12:51.855448 containerd[1529]: time="2025-05-14T18:12:51.855424997Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
May 14 18:12:51.855485 containerd[1529]: time="2025-05-14T18:12:51.855446787Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
May 14 18:12:51.855485 containerd[1529]: time="2025-05-14T18:12:51.855470191Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 18:12:51.855553 containerd[1529]: time="2025-05-14T18:12:51.855530845Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 18:12:51.855553 containerd[1529]: time="2025-05-14T18:12:51.855548739Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1
May 14 18:12:51.855807 containerd[1529]: time="2025-05-14T18:12:51.855784201Z" 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
May 14 18:12:51.855807 containerd[1529]: time="2025-05-14T18:12:51.855803617Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 18:12:51.855859 containerd[1529]: time="2025-05-14T18:12:51.855813335Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 18:12:51.855859 containerd[1529]: time="2025-05-14T18:12:51.855821450Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1
May 14 18:12:51.856289 containerd[1529]: time="2025-05-14T18:12:51.856262879Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1
May 14 18:12:51.856790 containerd[1529]: time="2025-05-14T18:12:51.856761715Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1
May 14 18:12:51.857019 containerd[1529]: time="2025-05-14T18:12:51.856860450Z" 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
May 14 18:12:51.857053 containerd[1529]: time="2025-05-14T18:12:51.857021512Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
May 14 18:12:51.857540 containerd[1529]: time="2025-05-14T18:12:51.857133412Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1
May 14 18:12:51.857879 containerd[1529]: time="2025-05-14T18:12:51.857841271Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
May 14 18:12:51.857972 containerd[1529]: time="2025-05-14T18:12:51.857947600Z" level=info msg="metadata content store policy set" policy=shared
May 14 18:12:51.865826 containerd[1529]: time="2025-05-14T18:12:51.865792220Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
May 14 18:12:51.865930 containerd[1529]: time="2025-05-14T18:12:51.865910071Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1
May 14 18:12:51.865955 containerd[1529]: time="2025-05-14T18:12:51.865932012Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
May 14 18:12:51.865955 containerd[1529]: time="2025-05-14T18:12:51.865943614Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
May 14 18:12:51.865992 containerd[1529]: time="2025-05-14T18:12:51.865955336Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
May 14 18:12:51.865992 containerd[1529]: time="2025-05-14T18:12:51.865965936Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
May 14 18:12:51.865992 containerd[1529]: time="2025-05-14T18:12:51.865976616Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
May 14 18:12:51.865992 containerd[1529]: time="2025-05-14T18:12:51.865986765Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
May 14 18:12:51.866064 containerd[1529]: time="2025-05-14T18:12:51.865999108Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
May 14 18:12:51.866064 containerd[1529]: time="2025-05-14T18:12:51.866014968Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
May 14 18:12:51.866064 containerd[1529]: time="2025-05-14T18:12:51.866023684Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
May 14 18:12:51.866064 containerd[1529]: time="2025-05-14T18:12:51.866034775Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
May 14 18:12:51.866183 containerd[1529]: time="2025-05-14T18:12:51.866162064Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
May 14 18:12:51.866207 containerd[1529]: time="2025-05-14T18:12:51.866196478Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
May 14 18:12:51.866231 containerd[1529]: time="2025-05-14T18:12:51.866210565Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
May 14 18:12:51.866231 containerd[1529]: time="2025-05-14T18:12:51.866221365Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
May 14 18:12:51.866267 containerd[1529]: time="2025-05-14T18:12:51.866231494Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
May 14 18:12:51.866267 containerd[1529]: time="2025-05-14T18:12:51.866242815Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
May 14 18:12:51.866267 containerd[1529]: time="2025-05-14T18:12:51.866253816Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
May 14 18:12:51.866329 containerd[1529]: time="2025-05-14T18:12:51.866267201Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
May 14 18:12:51.866329 containerd[1529]: time="2025-05-14T18:12:51.866285566Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
May 14 18:12:51.866329 containerd[1529]: time="2025-05-14T18:12:51.866295384Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
May 14 18:12:51.866329 containerd[1529]: time="2025-05-14T18:12:51.866304962Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
May 14 18:12:51.866403 containerd[1529]: time="2025-05-14T18:12:51.866364644Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""
May 14 18:12:51.866403 containerd[1529]: time="2025-05-14T18:12:51.866380885Z" level=info msg="Start snapshots syncer"
May 14 18:12:51.866439 containerd[1529]: time="2025-05-14T18:12:51.866412113Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
May 14 18:12:51.866789 containerd[1529]: time="2025-05-14T18:12:51.866673854Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}"
May 14 18:12:51.866901 containerd[1529]: time="2025-05-14T18:12:51.866799791Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
May 14 18:12:51.870657 containerd[1529]: time="2025-05-14T18:12:51.870625820Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
May 14 18:12:51.870804 containerd[1529]: time="2025-05-14T18:12:51.870781251Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
May 14 18:12:51.870871 containerd[1529]: time="2025-05-14T18:12:51.870809344Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
May 14 18:12:51.870896 containerd[1529]: time="2025-05-14T18:12:51.870871801Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
May 14 18:12:51.870896 containerd[1529]: time="2025-05-14T18:12:51.870882962Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
May 14 18:12:51.870941 containerd[1529]: time="2025-05-14T18:12:51.870896868Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
May 14 18:12:51.870941 containerd[1529]: time="2025-05-14T18:12:51.870908039Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
May 14 18:12:51.870941 containerd[1529]: time="2025-05-14T18:12:51.870918800Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
May 14 18:12:51.870941 containerd[1529]: time="2025-05-14T18:12:51.870940069Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
May 14 18:12:51.871010 containerd[1529]: time="2025-05-14T18:12:51.870950509Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
May 14 18:12:51.871010 containerd[1529]: time="2025-05-14T18:12:51.870960257Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
May 14 18:12:51.871545 containerd[1529]: time="2025-05-14T18:12:51.871525238Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
May 14 18:12:51.871576 containerd[1529]: time="2025-05-14T18:12:51.871546858Z" 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
May 14 18:12:51.871576 containerd[1529]: time="2025-05-14T18:12:51.871555374Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 18:12:51.871961 containerd[1529]: time="2025-05-14T18:12:51.871935046Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 18:12:51.871961 containerd[1529]: time="2025-05-14T18:12:51.871959292Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
May 14 18:12:51.872008 containerd[1529]: time="2025-05-14T18:12:51.871970603Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
May 14 18:12:51.872008 containerd[1529]: time="2025-05-14T18:12:51.871980983Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
May 14 18:12:51.872008 containerd[1529]: time="2025-05-14T18:12:51.872000139Z" level=info msg="runtime interface created"
May 14 18:12:51.872008 containerd[1529]: time="2025-05-14T18:12:51.872005639Z" level=info msg="created NRI interface"
May 14 18:12:51.872093 containerd[1529]: time="2025-05-14T18:12:51.872024414Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1
May 14 18:12:51.872093 containerd[1529]: time="2025-05-14T18:12:51.872036437Z" level=info msg="Connect containerd service"
May 14 18:12:51.872093 containerd[1529]: time="2025-05-14T18:12:51.872063978Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 14 18:12:51.878375 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 14 18:12:51.882301 containerd[1529]: time="2025-05-14T18:12:51.882269118Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
May 14 18:12:51.912916 kernel: EDAC MC: Ver: 3.0.0
May 14 18:12:51.973877 sshd_keygen[1511]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 14 18:12:51.983407 containerd[1529]: time="2025-05-14T18:12:51.983337145Z" level=info msg="Start subscribing containerd event"
May 14 18:12:51.983518 containerd[1529]: time="2025-05-14T18:12:51.983482728Z" level=info msg="Start recovering state"
May 14 18:12:51.983604 containerd[1529]: time="2025-05-14T18:12:51.983575983Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 14 18:12:51.983696 containerd[1529]: time="2025-05-14T18:12:51.983600228Z" level=info msg="Start event monitor"
May 14 18:12:51.983759 containerd[1529]: time="2025-05-14T18:12:51.983686811Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 14 18:12:51.983898 containerd[1529]: time="2025-05-14T18:12:51.983877529Z" level=info msg="Start cni network conf syncer for default"
May 14 18:12:51.983898 containerd[1529]: time="2025-05-14T18:12:51.983894621Z" level=info msg="Start streaming server"
May 14 18:12:51.983945 containerd[1529]: time="2025-05-14T18:12:51.983904760Z" level=info msg="Registered namespace \"k8s.io\" with NRI"
May 14 18:12:51.983945 containerd[1529]: time="2025-05-14T18:12:51.983912554Z" level=info msg="runtime interface starting up..."
May 14 18:12:51.983945 containerd[1529]: time="2025-05-14T18:12:51.983918616Z" level=info msg="starting plugins..."
May 14 18:12:51.984111 containerd[1529]: time="2025-05-14T18:12:51.984090508Z" level=info msg="Synchronizing NRI (plugin) with current runtime state"
May 14 18:12:51.984601 systemd[1]: Started containerd.service - containerd container runtime.
May 14 18:12:51.985805 containerd[1529]: time="2025-05-14T18:12:51.984709981Z" level=info msg="containerd successfully booted in 0.148340s"
May 14 18:12:51.996116 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 14 18:12:51.998991 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 14 18:12:52.028643 systemd[1]: issuegen.service: Deactivated successfully.
May 14 18:12:52.028916 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 14 18:12:52.031438 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 14 18:12:52.051759 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 14 18:12:52.054523 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 14 18:12:52.056593 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
May 14 18:12:52.057880 systemd[1]: Reached target getty.target - Login Prompts.
May 14 18:12:52.623025 systemd-networkd[1446]: eth0: Gained IPv6LL
May 14 18:12:52.626072 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 14 18:12:52.627943 systemd[1]: Reached target network-online.target - Network is Online.
May 14 18:12:52.630900 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent...
May 14 18:12:52.632990 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 14 18:12:52.672023 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 14 18:12:52.673684 systemd[1]: coreos-metadata.service: Deactivated successfully.
May 14 18:12:52.674003 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent.
May 14 18:12:52.676497 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 14 18:12:52.676798 systemd[1]: Reached target multi-user.target - Multi-User System.
May 14 18:12:52.680004 systemd[1]: Startup finished in 2.908s (kernel) + 4.230s (initrd) + 3.031s (userspace) = 10.171s.
May 14 18:12:58.584995 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 14 18:12:58.586349 systemd[1]: Started sshd@0-10.0.0.142:22-10.0.0.1:58824.service - OpenSSH per-connection server daemon (10.0.0.1:58824).
May 14 18:12:58.658299 sshd[1633]: Accepted publickey for core from 10.0.0.1 port 58824 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:58.660513 sshd-session[1633]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:58.667284 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 14 18:12:58.668485 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 14 18:12:58.675348 systemd-logind[1492]: New session 1 of user core.
May 14 18:12:58.693994 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 14 18:12:58.697636 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 14 18:12:58.720807 (systemd)[1637]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 14 18:12:58.723460 systemd-logind[1492]: New session c1 of user core.
May 14 18:12:58.885705 systemd[1637]: Queued start job for default target default.target.
May 14 18:12:58.905322 systemd[1637]: Created slice app.slice - User Application Slice.
May 14 18:12:58.905355 systemd[1637]: Reached target paths.target - Paths.
May 14 18:12:58.905407 systemd[1637]: Reached target timers.target - Timers.
May 14 18:12:58.907222 systemd[1637]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 14 18:12:58.919481 systemd[1637]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 14 18:12:58.919631 systemd[1637]: Reached target sockets.target - Sockets.
May 14 18:12:58.919674 systemd[1637]: Reached target basic.target - Basic System.
May 14 18:12:58.919715 systemd[1637]: Reached target default.target - Main User Target.
May 14 18:12:58.919747 systemd[1637]: Startup finished in 188ms.
May 14 18:12:58.920266 systemd[1]: Started user@500.service - User Manager for UID 500.
May 14 18:12:58.922210 systemd[1]: Started session-1.scope - Session 1 of User core.
May 14 18:12:58.987079 systemd[1]: Started sshd@1-10.0.0.142:22-10.0.0.1:58832.service - OpenSSH per-connection server daemon (10.0.0.1:58832).
May 14 18:12:59.032193 sshd[1648]: Accepted publickey for core from 10.0.0.1 port 58832 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:59.033876 sshd-session[1648]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:59.038371 systemd-logind[1492]: New session 2 of user core.
May 14 18:12:59.049004 systemd[1]: Started session-2.scope - Session 2 of User core.
May 14 18:12:59.100872 sshd[1650]: Connection closed by 10.0.0.1 port 58832
May 14 18:12:59.101154 sshd-session[1648]: pam_unix(sshd:session): session closed for user core
May 14 18:12:59.114491 systemd[1]: sshd@1-10.0.0.142:22-10.0.0.1:58832.service: Deactivated successfully.
May 14 18:12:59.116177 systemd[1]: session-2.scope: Deactivated successfully.
May 14 18:12:59.116951 systemd-logind[1492]: Session 2 logged out. Waiting for processes to exit.
May 14 18:12:59.119923 systemd[1]: Started sshd@2-10.0.0.142:22-10.0.0.1:58836.service - OpenSSH per-connection server daemon (10.0.0.1:58836).
May 14 18:12:59.120621 systemd-logind[1492]: Removed session 2.
May 14 18:12:59.182570 sshd[1656]: Accepted publickey for core from 10.0.0.1 port 58836 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:59.184070 sshd-session[1656]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:59.189370 systemd-logind[1492]: New session 3 of user core.
May 14 18:12:59.195981 systemd[1]: Started session-3.scope - Session 3 of User core.
May 14 18:12:59.245654 sshd[1658]: Connection closed by 10.0.0.1 port 58836
May 14 18:12:59.245993 sshd-session[1656]: pam_unix(sshd:session): session closed for user core
May 14 18:12:59.260587 systemd[1]: sshd@2-10.0.0.142:22-10.0.0.1:58836.service: Deactivated successfully.
May 14 18:12:59.262501 systemd[1]: session-3.scope: Deactivated successfully.
May 14 18:12:59.263299 systemd-logind[1492]: Session 3 logged out. Waiting for processes to exit.
May 14 18:12:59.265887 systemd[1]: Started sshd@3-10.0.0.142:22-10.0.0.1:58846.service - OpenSSH per-connection server daemon (10.0.0.1:58846).
May 14 18:12:59.266567 systemd-logind[1492]: Removed session 3.
May 14 18:12:59.327327 sshd[1664]: Accepted publickey for core from 10.0.0.1 port 58846 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:59.329295 sshd-session[1664]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:59.334512 systemd-logind[1492]: New session 4 of user core.
May 14 18:12:59.347080 systemd[1]: Started session-4.scope - Session 4 of User core.
May 14 18:12:59.399897 sshd[1666]: Connection closed by 10.0.0.1 port 58846
May 14 18:12:59.400223 sshd-session[1664]: pam_unix(sshd:session): session closed for user core
May 14 18:12:59.412601 systemd[1]: sshd@3-10.0.0.142:22-10.0.0.1:58846.service: Deactivated successfully.
May 14 18:12:59.414296 systemd[1]: session-4.scope: Deactivated successfully.
May 14 18:12:59.414957 systemd-logind[1492]: Session 4 logged out. Waiting for processes to exit.
May 14 18:12:59.417465 systemd[1]: Started sshd@4-10.0.0.142:22-10.0.0.1:58858.service - OpenSSH per-connection server daemon (10.0.0.1:58858).
May 14 18:12:59.417971 systemd-logind[1492]: Removed session 4.
May 14 18:12:59.466103 sshd[1672]: Accepted publickey for core from 10.0.0.1 port 58858 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:59.467735 sshd-session[1672]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:59.472191 systemd-logind[1492]: New session 5 of user core.
May 14 18:12:59.481962 systemd[1]: Started session-5.scope - Session 5 of User core.
May 14 18:12:59.539108 sudo[1676]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
May 14 18:12:59.539410 sudo[1676]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 14 18:12:59.555950 sudo[1676]: pam_unix(sudo:session): session closed for user root
May 14 18:12:59.557886 sshd[1675]: Connection closed by 10.0.0.1 port 58858
May 14 18:12:59.558311 sshd-session[1672]: pam_unix(sshd:session): session closed for user core
May 14 18:12:59.571362 systemd[1]: sshd@4-10.0.0.142:22-10.0.0.1:58858.service: Deactivated successfully.
May 14 18:12:59.573077 systemd[1]: session-5.scope: Deactivated successfully.
May 14 18:12:59.573779 systemd-logind[1492]: Session 5 logged out. Waiting for processes to exit.
May 14 18:12:59.576540 systemd[1]: Started sshd@5-10.0.0.142:22-10.0.0.1:58866.service - OpenSSH per-connection server daemon (10.0.0.1:58866).
May 14 18:12:59.577136 systemd-logind[1492]: Removed session 5.
May 14 18:12:59.640914 sshd[1682]: Accepted publickey for core from 10.0.0.1 port 58866 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:59.642224 sshd-session[1682]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:59.646757 systemd-logind[1492]: New session 6 of user core.
May 14 18:12:59.655999 systemd[1]: Started session-6.scope - Session 6 of User core.
May 14 18:12:59.709385 sudo[1686]:     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
May 14 18:12:59.709769 sudo[1686]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 14 18:12:59.716471 sudo[1686]: pam_unix(sudo:session): session closed for user root
May 14 18:12:59.722604 sudo[1685]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules
May 14 18:12:59.722949 sudo[1685]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 14 18:12:59.732955 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 14 18:12:59.780914 augenrules[1708]: No rules
May 14 18:12:59.781773 systemd[1]: audit-rules.service: Deactivated successfully.
May 14 18:12:59.782128 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 14 18:12:59.783311 sudo[1685]: pam_unix(sudo:session): session closed for user root
May 14 18:12:59.784807 sshd[1684]: Connection closed by 10.0.0.1 port 58866
May 14 18:12:59.785138 sshd-session[1682]: pam_unix(sshd:session): session closed for user core
May 14 18:12:59.797732 systemd[1]: sshd@5-10.0.0.142:22-10.0.0.1:58866.service: Deactivated successfully.
May 14 18:12:59.799585 systemd[1]: session-6.scope: Deactivated successfully.
May 14 18:12:59.800407 systemd-logind[1492]: Session 6 logged out. Waiting for processes to exit.
May 14 18:12:59.803024 systemd[1]: Started sshd@6-10.0.0.142:22-10.0.0.1:58878.service - OpenSSH per-connection server daemon (10.0.0.1:58878).
May 14 18:12:59.803722 systemd-logind[1492]: Removed session 6.
May 14 18:12:59.862971 sshd[1717]: Accepted publickey for core from 10.0.0.1 port 58878 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:12:59.864955 sshd-session[1717]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:12:59.870110 systemd-logind[1492]: New session 7 of user core.
May 14 18:12:59.877002 systemd[1]: Started session-7.scope - Session 7 of User core.
May 14 18:12:59.934511 systemd[1]: Starting docker.service - Docker Application Container Engine...
May 14 18:12:59.955205 (dockerd)[1721]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU
May 14 18:13:00.197617 dockerd[1721]: time="2025-05-14T18:13:00.197469615Z" level=info msg="Starting up"
May 14 18:13:00.198913 dockerd[1721]: time="2025-05-14T18:13:00.198892846Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"
May 14 18:13:00.409262 dockerd[1721]: time="2025-05-14T18:13:00.409179333Z" level=info msg="Loading containers: start."
May 14 18:13:00.420880 kernel: Initializing XFRM netlink socket
May 14 18:13:00.681654 systemd-networkd[1446]: docker0: Link UP
May 14 18:13:00.686387 dockerd[1721]: time="2025-05-14T18:13:00.686336729Z" level=info msg="Loading containers: done."
May 14 18:13:00.702054 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1003606164-merged.mount: Deactivated successfully.
May 14 18:13:00.703133 dockerd[1721]: time="2025-05-14T18:13:00.703086278Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2
May 14 18:13:00.703195 dockerd[1721]: time="2025-05-14T18:13:00.703179473Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1
May 14 18:13:00.703355 dockerd[1721]: time="2025-05-14T18:13:00.703328523Z" level=info msg="Initializing buildkit"
May 14 18:13:00.735674 dockerd[1721]: time="2025-05-14T18:13:00.735604226Z" level=info msg="Completed buildkit initialization"
May 14 18:13:00.742501 dockerd[1721]: time="2025-05-14T18:13:00.742446796Z" level=info msg="Daemon has completed initialization"
May 14 18:13:00.742627 dockerd[1721]: time="2025-05-14T18:13:00.742527287Z" level=info msg="API listen on /run/docker.sock"
May 14 18:13:00.742781 systemd[1]: Started docker.service - Docker Application Container Engine.
May 14 18:13:00.752145 sshd[1719]: Connection closed by 10.0.0.1 port 58878
May 14 18:13:00.752473 sshd-session[1717]: pam_unix(sshd:session): session closed for user core
May 14 18:13:00.771448 systemd[1]: sshd@6-10.0.0.142:22-10.0.0.1:58878.service: Deactivated successfully.
May 14 18:13:00.773291 systemd[1]: session-7.scope: Deactivated successfully.
May 14 18:13:00.774137 systemd-logind[1492]: Session 7 logged out. Waiting for processes to exit.
May 14 18:13:00.777097 systemd[1]: Started sshd@7-10.0.0.142:22-10.0.0.1:58888.service - OpenSSH per-connection server daemon (10.0.0.1:58888).
May 14 18:13:00.777636 systemd-logind[1492]: Removed session 7.
May 14 18:13:00.844575 sshd[1925]: Accepted publickey for core from 10.0.0.1 port 58888 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:00.846015 sshd-session[1925]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:00.850263 systemd-logind[1492]: New session 8 of user core.
May 14 18:13:00.860060 systemd[1]: Started session-8.scope - Session 8 of User core.
May 14 18:13:02.180320 systemd[1]: var-lib-docker-overlay2-c3b81bdf63b891641aee803c3da0e8b6e4e32411906c7969507bf68360ce644a\x2dinit-merged.mount: Deactivated successfully.
May 14 18:13:02.232805 containerd[1529]: time="2025-05-14T18:13:02.232755693Z" level=info msg="connecting to shim c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47" address="unix:///run/containerd/s/3f74bb1c13f056ea867d9b58f2af5286777c8debe965f82357403701f29867a2" namespace=moby protocol=ttrpc version=3
May 14 18:13:02.262982 systemd[1]: Started docker-c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47.scope - libcontainer container c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47.
May 14 18:13:02.276388 systemd-resolved[1355]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
May 14 18:13:02.304481 kernel: docker0: port 1(vethd735113) entered blocking state
May 14 18:13:02.304564 kernel: docker0: port 1(vethd735113) entered disabled state
May 14 18:13:02.304580 kernel: vethd735113: entered allmulticast mode
May 14 18:13:02.305910 kernel: vethd735113: entered promiscuous mode
May 14 18:13:02.306083 systemd-networkd[1446]: vethd735113: Link UP
May 14 18:13:02.317876 kernel: eth0: renamed from veth89cf50b
May 14 18:13:02.319442 kernel: docker0: port 1(vethd735113) entered blocking state
May 14 18:13:02.319470 kernel: docker0: port 1(vethd735113) entered forwarding state
May 14 18:13:02.319545 systemd-networkd[1446]: vethd735113: Gained carrier
May 14 18:13:02.319990 systemd-networkd[1446]: docker0: Gained carrier
May 14 18:13:02.355218 sshd[1927]: Connection closed by 10.0.0.1 port 58888
May 14 18:13:02.355545 sshd-session[1925]: pam_unix(sshd:session): session closed for user core
May 14 18:13:02.366489 systemd[1]: sshd@7-10.0.0.142:22-10.0.0.1:58888.service: Deactivated successfully.
May 14 18:13:02.368226 systemd[1]: session-8.scope: Deactivated successfully.
May 14 18:13:02.368989 systemd-logind[1492]: Session 8 logged out. Waiting for processes to exit.
May 14 18:13:02.371784 systemd[1]: Started sshd@8-10.0.0.142:22-10.0.0.1:58900.service - OpenSSH per-connection server daemon (10.0.0.1:58900).
May 14 18:13:02.372335 systemd-logind[1492]: Removed session 8.
May 14 18:13:02.422424 sshd[2001]: Accepted publickey for core from 10.0.0.1 port 58900 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:02.423876 sshd-session[2001]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:02.428355 systemd-logind[1492]: New session 9 of user core.
May 14 18:13:02.438072 systemd[1]: Started session-9.scope - Session 9 of User core.
May 14 18:13:02.495535 sshd[2003]: Connection closed by 10.0.0.1 port 58900
May 14 18:13:02.495827 sshd-session[2001]: pam_unix(sshd:session): session closed for user core
May 14 18:13:02.508494 systemd[1]: sshd@8-10.0.0.142:22-10.0.0.1:58900.service: Deactivated successfully.
May 14 18:13:02.510368 systemd[1]: session-9.scope: Deactivated successfully.
May 14 18:13:02.511105 systemd-logind[1492]: Session 9 logged out. Waiting for processes to exit.
May 14 18:13:02.513867 systemd[1]: Started sshd@9-10.0.0.142:22-10.0.0.1:58914.service - OpenSSH per-connection server daemon (10.0.0.1:58914).
May 14 18:13:02.514393 systemd-logind[1492]: Removed session 9.
May 14 18:13:02.565394 sshd[2009]: Accepted publickey for core from 10.0.0.1 port 58914 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:02.566752 sshd-session[2009]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:02.571269 systemd-logind[1492]: New session 10 of user core.
May 14 18:13:02.592052 systemd[1]: Started session-10.scope - Session 10 of User core.
May 14 18:13:02.644664 sudo[2012]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1529
May 14 18:13:02.644979 sudo[2012]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 14 18:13:02.649028 sudo[2012]: pam_unix(sudo:session): session closed for user root
May 14 18:13:02.650572 containerd[1529]: time="2025-05-14T18:13:02.650534565Z" level=info msg="Stop CRI service"
May 14 18:13:02.650632 sshd[2011]: Connection closed by 10.0.0.1 port 58914
May 14 18:13:02.651361 dockerd[1721]: time="2025-05-14T18:13:02.650768524Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby
May 14 18:13:02.651361 dockerd[1721]: time="2025-05-14T18:13:02.650798831Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby
May 14 18:13:02.651361 dockerd[1721]: time="2025-05-14T18:13:02.650929707Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby
May 14 18:13:02.651361 dockerd[1721]: time="2025-05-14T18:13:02.650961697Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby
May 14 18:13:02.651229 sshd-session[2009]: pam_unix(sshd:session): session closed for user core
May 14 18:13:02.672319 systemd[1]: containerd.service: Deactivated successfully.
May 14 18:13:02.672470 systemd[1]: containerd.service: Unit process 1952 (containerd-shim) remains running after unit stopped.
May 14 18:13:02.672834 systemd[1]: containerd.service: Consumed 319ms CPU time, 136.2M memory peak.
May 14 18:13:02.673424 systemd[1]: sshd@9-10.0.0.142:22-10.0.0.1:58914.service: Deactivated successfully.
May 14 18:13:02.675769 systemd[1]: session-10.scope: Deactivated successfully.
May 14 18:13:02.676633 systemd-logind[1492]: Session 10 logged out. Waiting for processes to exit.
May 14 18:13:02.681737 systemd[1]: Started sshd@10-10.0.0.142:22-10.0.0.1:58924.service - OpenSSH per-connection server daemon (10.0.0.1:58924).
May 14 18:13:02.682339 systemd-logind[1492]: Removed session 10.
May 14 18:13:02.734788 sshd[2019]: Accepted publickey for core from 10.0.0.1 port 58924 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:02.736361 sshd-session[2019]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:02.741015 systemd-logind[1492]: New session 11 of user core.
May 14 18:13:02.748033 systemd[1]: Started session-11.scope - Session 11 of User core.
May 14 18:13:02.806475 sshd[2021]: Connection closed by 10.0.0.1 port 58924
May 14 18:13:02.806795 sshd-session[2019]: pam_unix(sshd:session): session closed for user core
May 14 18:13:02.810074 systemd[1]: sshd@10-10.0.0.142:22-10.0.0.1:58924.service: Deactivated successfully.
May 14 18:13:02.812351 systemd[1]: session-11.scope: Deactivated successfully.
May 14 18:13:02.814186 systemd-logind[1492]: Session 11 logged out. Waiting for processes to exit.
May 14 18:13:02.816156 systemd-logind[1492]: Removed session 11.
May 14 18:13:03.375028 systemd-networkd[1446]: docker0: Gained IPv6LL
May 14 18:13:03.759061 systemd-networkd[1446]: vethd735113: Gained IPv6LL
May 14 18:13:07.923052 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1.
May 14 18:13:07.923429 systemd[1]: Stopping docker.service - Docker Application Container Engine...
May 14 18:13:07.923583 dockerd[1721]: time="2025-05-14T18:13:07.923459781Z" level=info msg="Processing signal 'terminated'"
May 14 18:13:08.819982 systemd[1]: Started sshd@11-10.0.0.142:22-10.0.0.1:54074.service - OpenSSH per-connection server daemon (10.0.0.1:54074).
May 14 18:13:08.875050 sshd[2027]: Accepted publickey for core from 10.0.0.1 port 54074 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:08.876875 sshd-session[2027]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:08.882020 systemd-logind[1492]: New session 12 of user core.
May 14 18:13:08.896189 systemd[1]: Started session-12.scope - Session 12 of User core.
May 14 18:13:08.951834 sshd[2029]: Connection closed by 10.0.0.1 port 54074
May 14 18:13:08.952141 sshd-session[2027]: pam_unix(sshd:session): session closed for user core
May 14 18:13:08.955928 systemd[1]: sshd@11-10.0.0.142:22-10.0.0.1:54074.service: Deactivated successfully.
May 14 18:13:08.957773 systemd[1]: session-12.scope: Deactivated successfully.
May 14 18:13:08.958557 systemd-logind[1492]: Session 12 logged out. Waiting for processes to exit.
May 14 18:13:08.959776 systemd-logind[1492]: Removed session 12.
May 14 18:13:09.924556 dockerd[1721]: time="2025-05-14T18:13:09.924479401Z" level=error msg="Error sending stop (signal 15) to container" container=c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47 error="Cannot kill container c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\""
May 14 18:13:09.924556 dockerd[1721]: time="2025-05-14T18:13:09.924527101Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47
May 14 18:13:14.966114 systemd[1]: Started sshd@12-10.0.0.142:22-10.0.0.1:54076.service - OpenSSH per-connection server daemon (10.0.0.1:54076).
May 14 18:13:15.027780 sshd[2035]: Accepted publickey for core from 10.0.0.1 port 54076 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:15.029471 sshd-session[2035]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:15.034232 systemd-logind[1492]: New session 13 of user core.
May 14 18:13:15.051013 systemd[1]: Started session-13.scope - Session 13 of User core.
May 14 18:13:15.107374 sshd[2037]: Connection closed by 10.0.0.1 port 54076
May 14 18:13:15.107703 sshd-session[2035]: pam_unix(sshd:session): session closed for user core
May 14 18:13:15.111630 systemd[1]: sshd@12-10.0.0.142:22-10.0.0.1:54076.service: Deactivated successfully.
May 14 18:13:15.113713 systemd[1]: session-13.scope: Deactivated successfully.
May 14 18:13:15.115585 systemd-logind[1492]: Session 13 logged out. Waiting for processes to exit.
May 14 18:13:15.117186 systemd-logind[1492]: Removed session 13.
May 14 18:13:19.925276 dockerd[1721]: time="2025-05-14T18:13:19.924884574Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47 error="context deadline exceeded"
May 14 18:13:19.927117 systemd[1]: docker-c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47.scope: Deactivated successfully.
May 14 18:13:21.123353 systemd[1]: Started sshd@13-10.0.0.142:22-10.0.0.1:57682.service - OpenSSH per-connection server daemon (10.0.0.1:57682).
May 14 18:13:21.164548 sshd[2043]: Accepted publickey for core from 10.0.0.1 port 57682 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:21.166116 sshd-session[2043]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:21.170429 systemd-logind[1492]: New session 14 of user core.
May 14 18:13:21.182155 systemd[1]: Started session-14.scope - Session 14 of User core.
May 14 18:13:21.238182 sshd[2045]: Connection closed by 10.0.0.1 port 57682
May 14 18:13:21.238494 sshd-session[2043]: pam_unix(sshd:session): session closed for user core
May 14 18:13:21.242987 systemd[1]: sshd@13-10.0.0.142:22-10.0.0.1:57682.service: Deactivated successfully.
May 14 18:13:21.245388 systemd[1]: session-14.scope: Deactivated successfully.
May 14 18:13:21.246229 systemd-logind[1492]: Session 14 logged out. Waiting for processes to exit.
May 14 18:13:21.247498 systemd-logind[1492]: Removed session 14.
May 14 18:13:22.924719 dockerd[1721]: time="2025-05-14T18:13:22.924661390Z" level=error msg="Force shutdown daemon"
May 14 18:13:22.925121 dockerd[1721]: time="2025-05-14T18:13:22.924819918Z" level=info msg="Daemon shutdown complete"
May 14 18:13:22.929412 systemd[1]: docker.service: Deactivated successfully.
May 14 18:13:22.929812 systemd[1]: Stopped docker.service - Docker Application Container Engine.
May 14 18:13:22.929891 systemd[1]: docker.service: Consumed 1.000s CPU time, 125M memory peak.
May 14 18:13:22.930409 systemd[1]: docker.socket: Deactivated successfully.
May 14 18:13:22.930808 systemd[1]: Closed docker.socket - Docker Socket for the API.
May 14 18:13:22.930864 systemd[1]: Stopping docker.socket - Docker Socket for the API...
May 14 18:13:22.932790 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 14 18:13:22.933011 systemd[1]: containerd.service: Found left-over process 1952 (containerd-shim) in control group while starting unit. Ignoring.
May 14 18:13:22.933020 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
May 14 18:13:22.940307 systemd[1]: Starting containerd.service - containerd container runtime...
May 14 18:13:22.941008 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 14 18:13:22.953707 systemd[1]: containerd.service: Found left-over process 1952 (containerd-shim) in control group while starting unit. Ignoring.
May 14 18:13:22.953720 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
May 14 18:13:22.958326 (ntainerd)[2056]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 14 18:13:22.972769 containerd[2056]: time="2025-05-14T18:13:22Z" 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
May 14 18:13:22.973388 containerd[2056]: time="2025-05-14T18:13:22.973357154Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4
May 14 18:13:22.980407 containerd[2056]: time="2025-05-14T18:13:22.980378199Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="6.693µs"
May 14 18:13:22.980407 containerd[2056]: time="2025-05-14T18:13:22.980400400Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
May 14 18:13:22.980464 containerd[2056]: time="2025-05-14T18:13:22.980415689Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
May 14 18:13:22.981150 containerd[2056]: time="2025-05-14T18:13:22.981027136Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
May 14 18:13:22.981183 containerd[2056]: time="2025-05-14T18:13:22.981169223Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
May 14 18:13:22.981391 containerd[2056]: time="2025-05-14T18:13:22.981370010Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 18:13:22.981412 containerd[2056]: time="2025-05-14T18:13:22.981396770Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 18:13:22.981412 containerd[2056]: time="2025-05-14T18:13:22.981405557Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1
May 14 18:13:22.981631 containerd[2056]: time="2025-05-14T18:13:22.981610110Z" 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
May 14 18:13:22.981631 containerd[2056]: time="2025-05-14T18:13:22.981624838Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 18:13:22.981676 containerd[2056]: time="2025-05-14T18:13:22.981634175Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 18:13:22.981676 containerd[2056]: time="2025-05-14T18:13:22.981641629Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1
May 14 18:13:22.981676 containerd[2056]: time="2025-05-14T18:13:22.981659433Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1
May 14 18:13:22.981754 containerd[2056]: time="2025-05-14T18:13:22.981739583Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1
May 14 18:13:22.981862 containerd[2056]: time="2025-05-14T18:13:22.981763608Z" 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
May 14 18:13:22.981862 containerd[2056]: time="2025-05-14T18:13:22.981771964Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
May 14 18:13:22.981862 containerd[2056]: time="2025-05-14T18:13:22.981802561Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1
May 14 18:13:22.982057 containerd[2056]: time="2025-05-14T18:13:22.982028956Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
May 14 18:13:22.982082 containerd[2056]: time="2025-05-14T18:13:22.982058552Z" level=info msg="metadata content store policy set" policy=shared
May 14 18:13:22.982229 containerd[2056]: time="2025-05-14T18:13:22.982205958Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
May 14 18:13:22.982251 containerd[2056]: time="2025-05-14T18:13:22.982238269Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1
May 14 18:13:22.982270 containerd[2056]: time="2025-05-14T18:13:22.982254560Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
May 14 18:13:22.982292 containerd[2056]: time="2025-05-14T18:13:22.982269848Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
May 14 18:13:22.982292 containerd[2056]: time="2025-05-14T18:13:22.982282843Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
May 14 18:13:22.982332 containerd[2056]: time="2025-05-14T18:13:22.982295637Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
May 14 18:13:22.982332 containerd[2056]: time="2025-05-14T18:13:22.982308531Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
May 14 18:13:22.982332 containerd[2056]: time="2025-05-14T18:13:22.982322086Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
May 14 18:13:22.982388 containerd[2056]: time="2025-05-14T18:13:22.982334119Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
May 14 18:13:22.982388 containerd[2056]: time="2025-05-14T18:13:22.982345811Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
May 14 18:13:22.982388 containerd[2056]: time="2025-05-14T18:13:22.982356862Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
May 14 18:13:22.982388 containerd[2056]: time="2025-05-14T18:13:22.982370317Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
May 14 18:13:22.982615 containerd[2056]: time="2025-05-14T18:13:22.982590821Z" level=info msg="connecting to shim c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47" address="unix:///run/containerd/s/3f74bb1c13f056ea867d9b58f2af5286777c8debe965f82357403701f29867a2" namespace=moby protocol=ttrpc version=3
May 14 18:13:22.990407 containerd[2056]: time="2025-05-14T18:13:22.990369557Z" level=info msg="cleaning leaked shim process" id=c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47 namespace=moby
May 14 18:13:23.000214 containerd[2056]: time="2025-05-14T18:13:23.000140261Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused"
May 14 18:13:23.000488 containerd[2056]: time="2025-05-14T18:13:23.000462355Z" level=info msg="shim disconnected" id=c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47 namespace=moby
May 14 18:13:23.000488 containerd[2056]: time="2025-05-14T18:13:23.000489376Z" level=warning msg="cleaning up after shim disconnected" id=c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47 namespace=moby
May 14 18:13:23.000564 containerd[2056]: time="2025-05-14T18:13:23.000497281Z" level=info msg="cleaning up dead shim" namespace=moby
May 14 18:13:23.012074 containerd[2056]: time="2025-05-14T18:13:23.012011516Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby
May 14 18:13:23.012187 containerd[2056]: time="2025-05-14T18:13:23.012144306Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
May 14 18:13:23.012187 containerd[2056]: time="2025-05-14T18:13:23.012168150Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
May 14 18:13:23.012187 containerd[2056]: time="2025-05-14T18:13:23.012182447Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012193057Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012203547Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012213115Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012224216Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012236979Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012254763Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
May 14 18:13:23.012271 containerd[2056]: time="2025-05-14T18:13:23.012268990Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
May 14 18:13:23.012410 containerd[2056]: time="2025-05-14T18:13:23.012278968Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
May 14 18:13:23.012410 containerd[2056]: time="2025-05-14T18:13:23.012339141Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""
May 14 18:13:23.012410 containerd[2056]: time="2025-05-14T18:13:23.012352065Z" level=info msg="Start snapshots syncer"
May 14 18:13:23.012410 containerd[2056]: time="2025-05-14T18:13:23.012382262Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
May 14 18:13:23.012609 containerd[2056]: time="2025-05-14T18:13:23.012568512Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}"
May 14 18:13:23.012722 containerd[2056]: time="2025-05-14T18:13:23.012617544Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
May 14 18:13:23.012722 containerd[2056]: time="2025-05-14T18:13:23.012681123Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
May 14 18:13:23.012722 containerd[2056]: time="2025-05-14T18:13:23.012719876Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
May 14 18:13:23.012805 containerd[2056]: time="2025-05-14T18:13:23.012735405Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
May 14 18:13:23.012805 containerd[2056]: time="2025-05-14T18:13:23.012745083Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
May 14 18:13:23.012805 containerd[2056]: time="2025-05-14T18:13:23.012778035Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
May 14 18:13:23.012805 containerd[2056]: time="2025-05-14T18:13:23.012788875Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
May 14 18:13:23.012805 containerd[2056]: time="2025-05-14T18:13:23.012798613Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
May 14 18:13:23.012805 containerd[2056]: time="2025-05-14T18:13:23.012808342Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012830453Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012841895Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012869727Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012897880Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012911255Z" 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
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012919741Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012928206Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012935380Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012943585Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012952913Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012969895Z" level=info msg="runtime interface created"
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012975195Z" level=info msg="created NRI interface"
May 14 18:13:23.012972 containerd[2056]: time="2025-05-14T18:13:23.012983170Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1
May 14 18:13:23.013308 containerd[2056]: time="2025-05-14T18:13:23.012993689Z" level=info msg="Connect containerd service"
May 14 18:13:23.013308 containerd[2056]: time="2025-05-14T18:13:23.013014729Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 14 18:13:23.014227 containerd[2056]: time="2025-05-14T18:13:23.014089365Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
May 14 18:13:23.024803 containerd[2056]: time="2025-05-14T18:13:23.024744078Z" level=info msg="Start subscribing containerd event"
May 14 18:13:23.024938 containerd[2056]: time="2025-05-14T18:13:23.024816334Z" level=info msg="Start recovering state"
May 14 18:13:23.024938 containerd[2056]: time="2025-05-14T18:13:23.024909859Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 14 18:13:23.025029 containerd[2056]: time="2025-05-14T18:13:23.024977937Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 14 18:13:23.025029 containerd[2056]: time="2025-05-14T18:13:23.024993095Z" level=info msg="Start event monitor"
May 14 18:13:23.025029 containerd[2056]: time="2025-05-14T18:13:23.025022440Z" level=info msg="Start cni network conf syncer for default"
May 14 18:13:23.025105 containerd[2056]: time="2025-05-14T18:13:23.025033641Z" level=info msg="Start streaming server"
May 14 18:13:23.025105 containerd[2056]: time="2025-05-14T18:13:23.025054611Z" level=info msg="Registered namespace \"k8s.io\" with NRI"
May 14 18:13:23.025105 containerd[2056]: time="2025-05-14T18:13:23.025064519Z" level=info msg="runtime interface starting up..."
May 14 18:13:23.025105 containerd[2056]: time="2025-05-14T18:13:23.025077404Z" level=info msg="starting plugins..."
May 14 18:13:23.025105 containerd[2056]: time="2025-05-14T18:13:23.025094275Z" level=info msg="Synchronizing NRI (plugin) with current runtime state"
May 14 18:13:23.025370 systemd[1]: Started containerd.service - containerd container runtime.
May 14 18:13:23.026008 containerd[2056]: time="2025-05-14T18:13:23.025789169Z" level=info msg="containerd successfully booted in 0.053205s"
May 14 18:13:23.027176 systemd[1]: Starting docker.service - Docker Application Container Engine...
May 14 18:13:23.038231 (dockerd)[2105]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU
May 14 18:13:23.065772 dockerd[2105]: time="2025-05-14T18:13:23.065712553Z" level=info msg="Starting up"
May 14 18:13:23.066625 dockerd[2105]: time="2025-05-14T18:13:23.066602052Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"
May 14 18:13:23.258505 dockerd[2105]: time="2025-05-14T18:13:23.258403714Z" level=info msg="[graphdriver] using prior storage driver: overlay2"
May 14 18:13:23.283772 dockerd[2105]: time="2025-05-14T18:13:23.283705561Z" level=info msg="Loading containers: start."
May 14 18:13:23.520205 systemd[1]: var-lib-docker-overlay2-c3b81bdf63b891641aee803c3da0e8b6e4e32411906c7969507bf68360ce644a-merged.mount: Deactivated successfully.
May 14 18:13:24.134120 systemd-networkd[1446]: vethd735113: Link DOWN
May 14 18:13:24.134131 systemd-networkd[1446]: vethd735113: Lost carrier
May 14 18:13:24.136554 kernel: docker0: port 1(vethd735113) entered disabled state
May 14 18:13:24.136601 kernel: vethd735113 (unregistering): left allmulticast mode
May 14 18:13:24.136619 kernel: vethd735113 (unregistering): left promiscuous mode
May 14 18:13:24.137294 kernel: docker0: port 1(vethd735113) entered disabled state
May 14 18:13:24.140125 systemd-networkd[1446]: docker0: Lost carrier
May 14 18:13:24.140768 dockerd[2105]: time="2025-05-14T18:13:24.140719155Z" level=info msg="Removing stale sandbox 34c582d51bf5c525d210afa7ef77455e0c005671e3a14be7465ef7080ad47c6d (c93abd314c98cb0bf769b344552ed8b60bccfb8037e06ad2acb591a6c7ba6e47)"
May 14 18:13:24.146669 dockerd[2105]: time="2025-05-14T18:13:24.146630460Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory"
May 14 18:13:24.146669 dockerd[2105]: time="2025-05-14T18:13:24.146664695Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint c259b97d5bd994c9c0988fba4c1c5e78a7cd3f7afd4c87b25c275903a8a73364 6b0ff47e262671ed65c9cad953f507a2d17557745aa082cf1bf699baade08552], retrying...."
May 14 18:13:24.205615 systemd[1]: run-docker-netns-34c582d51bf5.mount: Deactivated successfully.
May 14 18:13:24.413589 dockerd[2105]: time="2025-05-14T18:13:24.413425095Z" level=warning msg="error locating sandbox id 34c582d51bf5c525d210afa7ef77455e0c005671e3a14be7465ef7080ad47c6d: sandbox 34c582d51bf5c525d210afa7ef77455e0c005671e3a14be7465ef7080ad47c6d not found"
May 14 18:13:24.413589 dockerd[2105]: time="2025-05-14T18:13:24.413558148Z" level=info msg="Loading containers: done."
May 14 18:13:24.431172 dockerd[2105]: time="2025-05-14T18:13:24.431079497Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2
May 14 18:13:24.431384 dockerd[2105]: time="2025-05-14T18:13:24.431222370Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1
May 14 18:13:24.431384 dockerd[2105]: time="2025-05-14T18:13:24.431282615Z" level=info msg="Initializing buildkit"
May 14 18:13:24.450987 dockerd[2105]: time="2025-05-14T18:13:24.450946049Z" level=info msg="Completed buildkit initialization"
May 14 18:13:24.457607 dockerd[2105]: time="2025-05-14T18:13:24.457564696Z" level=info msg="Daemon has completed initialization"
May 14 18:13:24.457704 dockerd[2105]: time="2025-05-14T18:13:24.457637005Z" level=info msg="API listen on /run/docker.sock"
May 14 18:13:24.457812 systemd[1]: Started docker.service - Docker Application Container Engine.
May 14 18:13:27.258049 systemd[1]: Started sshd@14-10.0.0.142:22-10.0.0.1:51374.service - OpenSSH per-connection server daemon (10.0.0.1:51374).
May 14 18:13:27.315256 sshd[2326]: Accepted publickey for core from 10.0.0.1 port 51374 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:27.316602 sshd-session[2326]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:27.321264 systemd-logind[1492]: New session 15 of user core.
May 14 18:13:27.330959 systemd[1]: Started session-15.scope - Session 15 of User core.
May 14 18:13:27.386939 sshd[2328]: Connection closed by 10.0.0.1 port 51374
May 14 18:13:27.387251 sshd-session[2326]: pam_unix(sshd:session): session closed for user core
May 14 18:13:27.399388 systemd[1]: sshd@14-10.0.0.142:22-10.0.0.1:51374.service: Deactivated successfully.
May 14 18:13:27.401170 systemd[1]: session-15.scope: Deactivated successfully.
May 14 18:13:27.401923 systemd-logind[1492]: Session 15 logged out. Waiting for processes to exit.
May 14 18:13:27.404828 systemd[1]: Started sshd@15-10.0.0.142:22-10.0.0.1:51386.service - OpenSSH per-connection server daemon (10.0.0.1:51386).
May 14 18:13:27.405522 systemd-logind[1492]: Removed session 15.
May 14 18:13:27.455879 sshd[2334]: Accepted publickey for core from 10.0.0.1 port 51386 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:27.457375 sshd-session[2334]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:27.462296 systemd-logind[1492]: New session 16 of user core.
May 14 18:13:27.476035 systemd[1]: Started session-16.scope - Session 16 of User core.
May 14 18:13:27.533645 sshd[2336]: Connection closed by 10.0.0.1 port 51386
May 14 18:13:27.533962 sshd-session[2334]: pam_unix(sshd:session): session closed for user core
May 14 18:13:27.546884 systemd[1]: sshd@15-10.0.0.142:22-10.0.0.1:51386.service: Deactivated successfully.
May 14 18:13:27.548616 systemd[1]: session-16.scope: Deactivated successfully.
May 14 18:13:27.549417 systemd-logind[1492]: Session 16 logged out. Waiting for processes to exit.
May 14 18:13:27.552776 systemd[1]: Started sshd@16-10.0.0.142:22-10.0.0.1:51394.service - OpenSSH per-connection server daemon (10.0.0.1:51394).
May 14 18:13:27.553353 systemd-logind[1492]: Removed session 16.
May 14 18:13:27.618691 sshd[2342]: Accepted publickey for core from 10.0.0.1 port 51394 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:27.620143 sshd-session[2342]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:27.624815 systemd-logind[1492]: New session 17 of user core.
May 14 18:13:27.633978 systemd[1]: Started session-17.scope - Session 17 of User core.
May 14 18:13:27.696353 sshd[2344]: Connection closed by 10.0.0.1 port 51394
May 14 18:13:27.696649 sshd-session[2342]: pam_unix(sshd:session): session closed for user core
May 14 18:13:27.706259 systemd[1]: sshd@16-10.0.0.142:22-10.0.0.1:51394.service: Deactivated successfully.
May 14 18:13:27.708368 systemd[1]: session-17.scope: Deactivated successfully.
May 14 18:13:27.709246 systemd-logind[1492]: Session 17 logged out. Waiting for processes to exit.
May 14 18:13:27.713299 systemd[1]: Started sshd@17-10.0.0.142:22-10.0.0.1:51404.service - OpenSSH per-connection server daemon (10.0.0.1:51404).
May 14 18:13:27.714040 systemd-logind[1492]: Removed session 17.
May 14 18:13:27.759676 sshd[2357]: Accepted publickey for core from 10.0.0.1 port 51404 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:27.761453 sshd-session[2357]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:27.766001 systemd-logind[1492]: New session 18 of user core.
May 14 18:13:27.775977 systemd[1]: Started session-18.scope - Session 18 of User core.
May 14 18:13:27.851922 systemd[1]: var-lib-docker-overlay2-a90715e150fe31c0ec216ca56fd1a93ee49dca2f933346ecee375ab279620f58\x2dinit-merged.mount: Deactivated successfully.
May 14 18:13:27.894889 containerd[2056]: time="2025-05-14T18:13:27.894805475Z" level=info msg="connecting to shim d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431" address="unix:///run/containerd/s/b0692fd828ff5f47adc9752e4c3c7c9b2fc3b2da897f0202c065ebc2752ee52a" namespace=moby protocol=ttrpc version=3
May 14 18:13:27.920087 systemd[1]: Started docker-d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431.scope - libcontainer container d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431.
May 14 18:13:27.933187 systemd-resolved[1355]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
May 14 18:13:27.958322 kernel: docker0: port 1(veth9fdab36) entered blocking state
May 14 18:13:27.958418 kernel: docker0: port 1(veth9fdab36) entered disabled state
May 14 18:13:27.958441 kernel: veth9fdab36: entered allmulticast mode
May 14 18:13:27.959141 kernel: veth9fdab36: entered promiscuous mode
May 14 18:13:27.959470 systemd-networkd[1446]: veth9fdab36: Link UP
May 14 18:13:27.967154 kernel: eth0: renamed from veth949317e
May 14 18:13:27.969910 kernel: docker0: port 1(veth9fdab36) entered blocking state
May 14 18:13:27.969956 kernel: docker0: port 1(veth9fdab36) entered forwarding state
May 14 18:13:27.970039 systemd-networkd[1446]: veth9fdab36: Gained carrier
May 14 18:13:27.970997 systemd-networkd[1446]: docker0: Gained carrier
May 14 18:13:28.000125 sshd[2359]: Connection closed by 10.0.0.1 port 51404
May 14 18:13:28.000585 sshd-session[2357]: pam_unix(sshd:session): session closed for user core
May 14 18:13:28.015618 systemd[1]: sshd@17-10.0.0.142:22-10.0.0.1:51404.service: Deactivated successfully.
May 14 18:13:28.017434 systemd[1]: session-18.scope: Deactivated successfully.
May 14 18:13:28.018304 systemd-logind[1492]: Session 18 logged out. Waiting for processes to exit.
May 14 18:13:28.021254 systemd[1]: Started sshd@18-10.0.0.142:22-10.0.0.1:51406.service - OpenSSH per-connection server daemon (10.0.0.1:51406).
May 14 18:13:28.021949 systemd-logind[1492]: Removed session 18.
May 14 18:13:28.078119 sshd[2428]: Accepted publickey for core from 10.0.0.1 port 51406 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:28.080112 sshd-session[2428]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:28.085764 systemd-logind[1492]: New session 19 of user core.
May 14 18:13:28.095011 systemd[1]: Started session-19.scope - Session 19 of User core.
May 14 18:13:28.153458 sshd[2430]: Connection closed by 10.0.0.1 port 51406
May 14 18:13:28.153834 sshd-session[2428]: pam_unix(sshd:session): session closed for user core
May 14 18:13:28.163535 systemd[1]: sshd@18-10.0.0.142:22-10.0.0.1:51406.service: Deactivated successfully.
May 14 18:13:28.165602 systemd[1]: session-19.scope: Deactivated successfully.
May 14 18:13:28.166454 systemd-logind[1492]: Session 19 logged out. Waiting for processes to exit.
May 14 18:13:28.170642 systemd[1]: Started sshd@19-10.0.0.142:22-10.0.0.1:51420.service - OpenSSH per-connection server daemon (10.0.0.1:51420).
May 14 18:13:28.171262 systemd-logind[1492]: Removed session 19.
May 14 18:13:28.235716 sshd[2436]: Accepted publickey for core from 10.0.0.1 port 51420 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:28.237493 sshd-session[2436]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:28.242249 systemd-logind[1492]: New session 20 of user core.
May 14 18:13:28.251984 systemd[1]: Started session-20.scope - Session 20 of User core.
May 14 18:13:28.306203 sudo[2439]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2056
May 14 18:13:28.306549 sudo[2439]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 14 18:13:28.310363 sudo[2439]: pam_unix(sudo:session): session closed for user root
May 14 18:13:28.311804 sshd[2438]: Connection closed by 10.0.0.1 port 51420
May 14 18:13:28.312181 sshd-session[2436]: pam_unix(sshd:session): session closed for user core
May 14 18:13:28.315014 dockerd[2105]: time="2025-05-14T18:13:28.314805709Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby
May 14 18:13:28.315014 dockerd[2105]: time="2025-05-14T18:13:28.314867065Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby
May 14 18:13:28.315014 dockerd[2105]: time="2025-05-14T18:13:28.314916500Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby
May 14 18:13:28.315014 dockerd[2105]: time="2025-05-14T18:13:28.314938421Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby
May 14 18:13:28.323229 systemd[1]: containerd.service: Deactivated successfully.
May 14 18:13:28.323368 systemd[1]: containerd.service: Unit process 2376 (containerd-shim) remains running after unit stopped.
May 14 18:13:28.323682 systemd[1]: containerd.service: Consumed 175ms CPU time, 136.3M memory peak.
May 14 18:13:28.324263 systemd[1]: sshd@19-10.0.0.142:22-10.0.0.1:51420.service: Deactivated successfully.
May 14 18:13:28.325959 systemd[1]: session-20.scope: Deactivated successfully.
May 14 18:13:28.327588 systemd-logind[1492]: Session 20 logged out. Waiting for processes to exit.
May 14 18:13:28.331293 systemd[1]: Started sshd@20-10.0.0.142:22-10.0.0.1:51424.service - OpenSSH per-connection server daemon (10.0.0.1:51424).
May 14 18:13:28.332122 systemd-logind[1492]: Removed session 20.
May 14 18:13:28.388975 sshd[2446]: Accepted publickey for core from 10.0.0.1 port 51424 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:28.391362 sshd-session[2446]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:28.396678 systemd-logind[1492]: New session 21 of user core.
May 14 18:13:28.417087 systemd[1]: Started session-21.scope - Session 21 of User core.
May 14 18:13:28.474257 sshd[2448]: Connection closed by 10.0.0.1 port 51424
May 14 18:13:28.474603 sshd-session[2446]: pam_unix(sshd:session): session closed for user core
May 14 18:13:28.478185 systemd[1]: sshd@20-10.0.0.142:22-10.0.0.1:51424.service: Deactivated successfully.
May 14 18:13:28.480370 systemd[1]: session-21.scope: Deactivated successfully.
May 14 18:13:28.482714 systemd-logind[1492]: Session 21 logged out. Waiting for processes to exit.
May 14 18:13:28.483717 systemd-logind[1492]: Removed session 21.
May 14 18:13:29.743134 systemd-networkd[1446]: veth9fdab36: Gained IPv6LL
May 14 18:13:33.397887 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2.
May 14 18:13:33.398252 systemd[1]: Stopping docker.service - Docker Application Container Engine...
May 14 18:13:33.398388 dockerd[2105]: time="2025-05-14T18:13:33.398340795Z" level=info msg="Processing signal 'terminated'"
May 14 18:13:34.487206 systemd[1]: Started sshd@21-10.0.0.142:22-10.0.0.1:51426.service - OpenSSH per-connection server daemon (10.0.0.1:51426).
May 14 18:13:34.543485 sshd[2454]: Accepted publickey for core from 10.0.0.1 port 51426 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:34.544737 sshd-session[2454]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:34.548798 systemd-logind[1492]: New session 22 of user core.
May 14 18:13:34.558971 systemd[1]: Started session-22.scope - Session 22 of User core.
May 14 18:13:34.614810 sshd[2456]: Connection closed by 10.0.0.1 port 51426
May 14 18:13:34.615072 sshd-session[2454]: pam_unix(sshd:session): session closed for user core
May 14 18:13:34.620024 systemd[1]: sshd@21-10.0.0.142:22-10.0.0.1:51426.service: Deactivated successfully.
May 14 18:13:34.621786 systemd[1]: session-22.scope: Deactivated successfully.
May 14 18:13:34.622581 systemd-logind[1492]: Session 22 logged out. Waiting for processes to exit.
May 14 18:13:34.623923 systemd-logind[1492]: Removed session 22.
May 14 18:13:35.399301 dockerd[2105]: time="2025-05-14T18:13:35.399207569Z" level=error msg="Error sending stop (signal 15) to container" container=d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431 error="Cannot kill container d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\""
May 14 18:13:35.399301 dockerd[2105]: time="2025-05-14T18:13:35.399272151Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431
May 14 18:13:36.511000 update_engine[1493]: I20250514 18:13:36.510831  1493 update_attempter.cc:509] Updating boot flags...
May 14 18:13:40.633033 systemd[1]: Started sshd@22-10.0.0.142:22-10.0.0.1:52888.service - OpenSSH per-connection server daemon (10.0.0.1:52888).
May 14 18:13:40.687969 sshd[2480]: Accepted publickey for core from 10.0.0.1 port 52888 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:40.689377 sshd-session[2480]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:40.693686 systemd-logind[1492]: New session 23 of user core.
May 14 18:13:40.707016 systemd[1]: Started session-23.scope - Session 23 of User core.
May 14 18:13:40.765311 sshd[2482]: Connection closed by 10.0.0.1 port 52888
May 14 18:13:40.765638 sshd-session[2480]: pam_unix(sshd:session): session closed for user core
May 14 18:13:40.769321 systemd[1]: sshd@22-10.0.0.142:22-10.0.0.1:52888.service: Deactivated successfully.
May 14 18:13:40.771071 systemd[1]: session-23.scope: Deactivated successfully.
May 14 18:13:40.771825 systemd-logind[1492]: Session 23 logged out. Waiting for processes to exit.
May 14 18:13:40.773625 systemd-logind[1492]: Removed session 23.
May 14 18:13:45.400479 dockerd[2105]: time="2025-05-14T18:13:45.400401178Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431 error="context deadline exceeded"
May 14 18:13:45.401299 systemd[1]: docker-d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431.scope: Deactivated successfully.
May 14 18:13:46.781696 systemd[1]: Started sshd@23-10.0.0.142:22-10.0.0.1:40626.service - OpenSSH per-connection server daemon (10.0.0.1:40626).
May 14 18:13:46.822643 sshd[2488]: Accepted publickey for core from 10.0.0.1 port 40626 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:46.824301 sshd-session[2488]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:46.828809 systemd-logind[1492]: New session 24 of user core.
May 14 18:13:46.836016 systemd[1]: Started session-24.scope - Session 24 of User core.
May 14 18:13:46.894593 sshd[2490]: Connection closed by 10.0.0.1 port 40626
May 14 18:13:46.894936 sshd-session[2488]: pam_unix(sshd:session): session closed for user core
May 14 18:13:46.898829 systemd[1]: sshd@23-10.0.0.142:22-10.0.0.1:40626.service: Deactivated successfully.
May 14 18:13:46.900504 systemd[1]: session-24.scope: Deactivated successfully.
May 14 18:13:46.901278 systemd-logind[1492]: Session 24 logged out. Waiting for processes to exit.
May 14 18:13:46.902448 systemd-logind[1492]: Removed session 24.
May 14 18:13:48.398829 dockerd[2105]: time="2025-05-14T18:13:48.398738196Z" level=error msg="Force shutdown daemon"
May 14 18:13:48.399265 dockerd[2105]: time="2025-05-14T18:13:48.398926080Z" level=info msg="Daemon shutdown complete"
May 14 18:13:48.406030 systemd[1]: docker.service: Deactivated successfully.
May 14 18:13:48.406410 systemd[1]: Stopped docker.service - Docker Application Container Engine.
May 14 18:13:48.406926 systemd[1]: docker.socket: Deactivated successfully.
May 14 18:13:48.407252 systemd[1]: Closed docker.socket - Docker Socket for the API.
May 14 18:13:48.407290 systemd[1]: Stopping docker.socket - Docker Socket for the API...
May 14 18:13:48.409037 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 14 18:13:48.409230 systemd[1]: containerd.service: Found left-over process 2376 (containerd-shim) in control group while starting unit. Ignoring.
May 14 18:13:48.409239 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
May 14 18:13:48.422494 systemd[1]: Starting containerd.service - containerd container runtime...
May 14 18:13:48.423278 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 14 18:13:48.436465 systemd[1]: containerd.service: Found left-over process 2376 (containerd-shim) in control group while starting unit. Ignoring.
May 14 18:13:48.436477 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
May 14 18:13:48.454251 (ntainerd)[2501]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 14 18:13:48.469974 containerd[2501]: time="2025-05-14T18:13:48Z" 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
May 14 18:13:48.470508 containerd[2501]: time="2025-05-14T18:13:48.470472790Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4
May 14 18:13:48.478011 containerd[2501]: time="2025-05-14T18:13:48.477960557Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.499µs"
May 14 18:13:48.478011 containerd[2501]: time="2025-05-14T18:13:48.477999661Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
May 14 18:13:48.478085 containerd[2501]: time="2025-05-14T18:13:48.478021703Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
May 14 18:13:48.478085 containerd[2501]: time="2025-05-14T18:13:48.478053853Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
May 14 18:13:48.478085 containerd[2501]: time="2025-05-14T18:13:48.478072648Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
May 14 18:13:48.478316 containerd[2501]: time="2025-05-14T18:13:48.478285510Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 18:13:48.478346 containerd[2501]: time="2025-05-14T18:13:48.478317079Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 14 18:13:48.478346 containerd[2501]: time="2025-05-14T18:13:48.478326707Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1
May 14 18:13:48.478648 containerd[2501]: time="2025-05-14T18:13:48.478622504Z" 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
May 14 18:13:48.478648 containerd[2501]: time="2025-05-14T18:13:48.478637864Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 18:13:48.478694 containerd[2501]: time="2025-05-14T18:13:48.478648063Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 14 18:13:48.478694 containerd[2501]: time="2025-05-14T18:13:48.478655557Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1
May 14 18:13:48.478694 containerd[2501]: time="2025-05-14T18:13:48.478674573Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1
May 14 18:13:48.478774 containerd[2501]: time="2025-05-14T18:13:48.478753781Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1
May 14 18:13:48.478800 containerd[2501]: time="2025-05-14T18:13:48.478779180Z" 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
May 14 18:13:48.478800 containerd[2501]: time="2025-05-14T18:13:48.478787876Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
May 14 18:13:48.478842 containerd[2501]: time="2025-05-14T18:13:48.478819516Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1
May 14 18:13:48.479091 containerd[2501]: time="2025-05-14T18:13:48.479065319Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
May 14 18:13:48.479133 containerd[2501]: time="2025-05-14T18:13:48.479088382Z" level=info msg="metadata content store policy set" policy=shared
May 14 18:13:48.479262 containerd[2501]: time="2025-05-14T18:13:48.479238595Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
May 14 18:13:48.479288 containerd[2501]: time="2025-05-14T18:13:48.479264694Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1
May 14 18:13:48.479307 containerd[2501]: time="2025-05-14T18:13:48.479296605Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
May 14 18:13:48.479511 containerd[2501]: time="2025-05-14T18:13:48.479307826Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
May 14 18:13:48.479607 containerd[2501]: time="2025-05-14T18:13:48.479557597Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
May 14 18:13:48.479607 containerd[2501]: time="2025-05-14T18:13:48.479585579Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
May 14 18:13:48.479661 containerd[2501]: time="2025-05-14T18:13:48.479615405Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
May 14 18:13:48.479661 containerd[2501]: time="2025-05-14T18:13:48.479629442Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
May 14 18:13:48.479661 containerd[2501]: time="2025-05-14T18:13:48.479646884Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
May 14 18:13:48.479720 containerd[2501]: time="2025-05-14T18:13:48.479661492Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
May 14 18:13:48.479720 containerd[2501]: time="2025-05-14T18:13:48.479678925Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
May 14 18:13:48.479720 containerd[2501]: time="2025-05-14T18:13:48.479699544Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
May 14 18:13:48.480061 containerd[2501]: time="2025-05-14T18:13:48.480028563Z" level=info msg="connecting to shim d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431" address="unix:///run/containerd/s/b0692fd828ff5f47adc9752e4c3c7c9b2fc3b2da897f0202c065ebc2752ee52a" namespace=moby protocol=ttrpc version=3
May 14 18:13:48.489294 containerd[2501]: time="2025-05-14T18:13:48.489240269Z" level=info msg="cleaning leaked shim process" id=d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431 namespace=moby
May 14 18:13:48.500199 containerd[2501]: time="2025-05-14T18:13:48.500084972Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused"
May 14 18:13:48.500538 containerd[2501]: time="2025-05-14T18:13:48.500497729Z" level=info msg="shim disconnected" id=d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431 namespace=moby
May 14 18:13:48.500569 containerd[2501]: time="2025-05-14T18:13:48.500535340Z" level=warning msg="cleaning up after shim disconnected" id=d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431 namespace=moby
May 14 18:13:48.500590 containerd[2501]: time="2025-05-14T18:13:48.500546721Z" level=info msg="cleaning up dead shim" namespace=moby
May 14 18:13:48.511550 containerd[2501]: time="2025-05-14T18:13:48.511485190Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby
May 14 18:13:48.511639 containerd[2501]: time="2025-05-14T18:13:48.511605467Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
May 14 18:13:48.511639 containerd[2501]: time="2025-05-14T18:13:48.511630644Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
May 14 18:13:48.511679 containerd[2501]: time="2025-05-14T18:13:48.511644851Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
May 14 18:13:48.511679 containerd[2501]: time="2025-05-14T18:13:48.511656342Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
May 14 18:13:48.511679 containerd[2501]: time="2025-05-14T18:13:48.511666842Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
May 14 18:13:48.511679 containerd[2501]: time="2025-05-14T18:13:48.511676891Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
May 14 18:13:48.511775 containerd[2501]: time="2025-05-14T18:13:48.511688824Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
May 14 18:13:48.511775 containerd[2501]: time="2025-05-14T18:13:48.511699003Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
May 14 18:13:48.511775 containerd[2501]: time="2025-05-14T18:13:48.511709072Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
May 14 18:13:48.511775 containerd[2501]: time="2025-05-14T18:13:48.511719422Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
May 14 18:13:48.511775 containerd[2501]: time="2025-05-14T18:13:48.511730472Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
May 14 18:13:48.511893 containerd[2501]: time="2025-05-14T18:13:48.511806976Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""
May 14 18:13:48.511893 containerd[2501]: time="2025-05-14T18:13:48.511820532Z" level=info msg="Start snapshots syncer"
May 14 18:13:48.511893 containerd[2501]: time="2025-05-14T18:13:48.511885644Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
May 14 18:13:48.512170 containerd[2501]: time="2025-05-14T18:13:48.512117592Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}"
May 14 18:13:48.512255 containerd[2501]: time="2025-05-14T18:13:48.512183796Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
May 14 18:13:48.512278 containerd[2501]: time="2025-05-14T18:13:48.512257285Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
May 14 18:13:48.512316 containerd[2501]: time="2025-05-14T18:13:48.512298071Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
May 14 18:13:48.512339 containerd[2501]: time="2025-05-14T18:13:48.512320183Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
May 14 18:13:48.512339 containerd[2501]: time="2025-05-14T18:13:48.512332706Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
May 14 18:13:48.512377 containerd[2501]: time="2025-05-14T18:13:48.512343958Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
May 14 18:13:48.512377 containerd[2501]: time="2025-05-14T18:13:48.512356322Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
May 14 18:13:48.512377 containerd[2501]: time="2025-05-14T18:13:48.512369336Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
May 14 18:13:48.512496 containerd[2501]: time="2025-05-14T18:13:48.512383723Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
May 14 18:13:48.512496 containerd[2501]: time="2025-05-14T18:13:48.512410093Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
May 14 18:13:48.512496 containerd[2501]: time="2025-05-14T18:13:48.512422356Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
May 14 18:13:48.512496 containerd[2501]: time="2025-05-14T18:13:48.512433987Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
May 14 18:13:48.512496 containerd[2501]: time="2025-05-14T18:13:48.512470567Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
May 14 18:13:48.512496 containerd[2501]: time="2025-05-14T18:13:48.512485495Z" 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
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512496195Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512512866Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512523136Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512539717Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512551539Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512571226Z" level=info msg="runtime interface created"
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512577898Z" level=info msg="created NRI interface"
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512587617Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1
May 14 18:13:48.512609 containerd[2501]: time="2025-05-14T18:13:48.512599530Z" level=info msg="Connect containerd service"
May 14 18:13:48.512769 containerd[2501]: time="2025-05-14T18:13:48.512623295Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 14 18:13:48.513169 containerd[2501]: time="2025-05-14T18:13:48.513136502Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
May 14 18:13:48.523633 containerd[2501]: time="2025-05-14T18:13:48.523594756Z" level=info msg="Start subscribing containerd event"
May 14 18:13:48.523633 containerd[2501]: time="2025-05-14T18:13:48.523633879Z" level=info msg="Start recovering state"
May 14 18:13:48.523787 containerd[2501]: time="2025-05-14T18:13:48.523734870Z" level=info msg="Start event monitor"
May 14 18:13:48.523787 containerd[2501]: time="2025-05-14T18:13:48.523747864Z" level=info msg="Start cni network conf syncer for default"
May 14 18:13:48.523787 containerd[2501]: time="2025-05-14T18:13:48.523746832Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 14 18:13:48.523844 containerd[2501]: time="2025-05-14T18:13:48.523824539Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 14 18:13:48.523844 containerd[2501]: time="2025-05-14T18:13:48.523755438Z" level=info msg="Start streaming server"
May 14 18:13:48.523896 containerd[2501]: time="2025-05-14T18:13:48.523872349Z" level=info msg="Registered namespace \"k8s.io\" with NRI"
May 14 18:13:48.523896 containerd[2501]: time="2025-05-14T18:13:48.523881375Z" level=info msg="runtime interface starting up..."
May 14 18:13:48.523896 containerd[2501]: time="2025-05-14T18:13:48.523886846Z" level=info msg="starting plugins..."
May 14 18:13:48.523959 containerd[2501]: time="2025-05-14T18:13:48.523905861Z" level=info msg="Synchronizing NRI (plugin) with current runtime state"
May 14 18:13:48.524129 systemd[1]: Started containerd.service - containerd container runtime.
May 14 18:13:48.525745 containerd[2501]: time="2025-05-14T18:13:48.525664485Z" level=info msg="containerd successfully booted in 0.055876s"
May 14 18:13:48.526644 systemd[1]: Starting docker.service - Docker Application Container Engine...
May 14 18:13:48.543170 (dockerd)[2550]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU
May 14 18:13:48.571570 dockerd[2550]: time="2025-05-14T18:13:48.571499771Z" level=info msg="Starting up"
May 14 18:13:48.572348 dockerd[2550]: time="2025-05-14T18:13:48.572306773Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"
May 14 18:13:48.628334 dockerd[2550]: time="2025-05-14T18:13:48.628293996Z" level=info msg="[graphdriver] using prior storage driver: overlay2"
May 14 18:13:48.651296 dockerd[2550]: time="2025-05-14T18:13:48.651209901Z" level=info msg="Loading containers: start."
May 14 18:13:48.668897 systemd[1]: var-lib-docker-overlay2-a90715e150fe31c0ec216ca56fd1a93ee49dca2f933346ecee375ab279620f58-merged.mount: Deactivated successfully.
May 14 18:13:49.078528 systemd-networkd[1446]: veth9fdab36: Link DOWN
May 14 18:13:49.078538 systemd-networkd[1446]: veth9fdab36: Lost carrier
May 14 18:13:49.080342 kernel: docker0: port 1(veth9fdab36) entered disabled state
May 14 18:13:49.080385 kernel: veth9fdab36 (unregistering): left allmulticast mode
May 14 18:13:49.080404 kernel: veth9fdab36 (unregistering): left promiscuous mode
May 14 18:13:49.081906 kernel: docker0: port 1(veth9fdab36) entered disabled state
May 14 18:13:49.083114 systemd-networkd[1446]: docker0: Lost carrier
May 14 18:13:49.084404 dockerd[2550]: time="2025-05-14T18:13:49.084366018Z" level=info msg="Removing stale sandbox c48ad01e3eaf85dc843e8f6bdd41cff767f06f850fad037657bfced5805f5eeb (d1f37f765093c6ee0fe58adc38a0a830527e7f6138259c9d67cb05e761004431)"
May 14 18:13:49.090567 dockerd[2550]: time="2025-05-14T18:13:49.090514198Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory"
May 14 18:13:49.090567 dockerd[2550]: time="2025-05-14T18:13:49.090565214Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 231ec68fc9daf486d4eb53d41e2d74645482719740c1553e5102bb4857e81a49 f5cb222a4bdc1f988f5899c2a4c8f890ea00ba8166c512c565d9b30a85735285], retrying...."
May 14 18:13:49.282372 dockerd[2550]: time="2025-05-14T18:13:49.282286980Z" level=warning msg="error locating sandbox id c48ad01e3eaf85dc843e8f6bdd41cff767f06f850fad037657bfced5805f5eeb: sandbox c48ad01e3eaf85dc843e8f6bdd41cff767f06f850fad037657bfced5805f5eeb not found"
May 14 18:13:49.282372 dockerd[2550]: time="2025-05-14T18:13:49.282340521Z" level=warning msg="error locating sandbox id 34c582d51bf5c525d210afa7ef77455e0c005671e3a14be7465ef7080ad47c6d: sandbox 34c582d51bf5c525d210afa7ef77455e0c005671e3a14be7465ef7080ad47c6d not found"
May 14 18:13:49.282594 dockerd[2550]: time="2025-05-14T18:13:49.282500172Z" level=info msg="Loading containers: done."
May 14 18:13:49.299545 dockerd[2550]: time="2025-05-14T18:13:49.299455659Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2
May 14 18:13:49.299817 dockerd[2550]: time="2025-05-14T18:13:49.299573490Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1
May 14 18:13:49.299817 dockerd[2550]: time="2025-05-14T18:13:49.299645035Z" level=info msg="Initializing buildkit"
May 14 18:13:49.318677 dockerd[2550]: time="2025-05-14T18:13:49.318598807Z" level=info msg="Completed buildkit initialization"
May 14 18:13:49.325044 dockerd[2550]: time="2025-05-14T18:13:49.324991117Z" level=info msg="Daemon has completed initialization"
May 14 18:13:49.325175 dockerd[2550]: time="2025-05-14T18:13:49.325060167Z" level=info msg="API listen on /run/docker.sock"
May 14 18:13:49.325336 systemd[1]: Started docker.service - Docker Application Container Engine.
May 14 18:13:49.621664 systemd[1]: run-docker-netns-c48ad01e3eaf.mount: Deactivated successfully.
May 14 18:13:52.907857 systemd[1]: Started sshd@24-10.0.0.142:22-10.0.0.1:40634.service - OpenSSH per-connection server daemon (10.0.0.1:40634).
May 14 18:13:52.955991 sshd[2771]: Accepted publickey for core from 10.0.0.1 port 40634 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:52.957807 sshd-session[2771]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:52.962842 systemd-logind[1492]: New session 25 of user core.
May 14 18:13:52.978128 systemd[1]: Started session-25.scope - Session 25 of User core.
May 14 18:13:53.034478 sshd[2773]: Connection closed by 10.0.0.1 port 40634
May 14 18:13:53.034957 sshd-session[2771]: pam_unix(sshd:session): session closed for user core
May 14 18:13:53.051691 systemd[1]: sshd@24-10.0.0.142:22-10.0.0.1:40634.service: Deactivated successfully.
May 14 18:13:53.053472 systemd[1]: session-25.scope: Deactivated successfully.
May 14 18:13:53.054281 systemd-logind[1492]: Session 25 logged out. Waiting for processes to exit.
May 14 18:13:53.057394 systemd[1]: Started sshd@25-10.0.0.142:22-10.0.0.1:40646.service - OpenSSH per-connection server daemon (10.0.0.1:40646).
May 14 18:13:53.058151 systemd-logind[1492]: Removed session 25.
May 14 18:13:53.108824 sshd[2779]: Accepted publickey for core from 10.0.0.1 port 40646 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:53.110410 sshd-session[2779]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:53.114997 systemd-logind[1492]: New session 26 of user core.
May 14 18:13:53.121986 systemd[1]: Started session-26.scope - Session 26 of User core.
May 14 18:13:53.180021 sshd[2781]: Connection closed by 10.0.0.1 port 40646
May 14 18:13:53.180369 sshd-session[2779]: pam_unix(sshd:session): session closed for user core
May 14 18:13:53.197792 systemd[1]: sshd@25-10.0.0.142:22-10.0.0.1:40646.service: Deactivated successfully.
May 14 18:13:53.199741 systemd[1]: session-26.scope: Deactivated successfully.
May 14 18:13:53.200586 systemd-logind[1492]: Session 26 logged out. Waiting for processes to exit.
May 14 18:13:53.203702 systemd[1]: Started sshd@26-10.0.0.142:22-10.0.0.1:40654.service - OpenSSH per-connection server daemon (10.0.0.1:40654).
May 14 18:13:53.204497 systemd-logind[1492]: Removed session 26.
May 14 18:13:53.260164 sshd[2787]: Accepted publickey for core from 10.0.0.1 port 40654 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:53.261817 sshd-session[2787]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:53.266548 systemd-logind[1492]: New session 27 of user core.
May 14 18:13:53.276199 systemd[1]: Started session-27.scope - Session 27 of User core.
May 14 18:13:53.339926 sshd[2789]: Connection closed by 10.0.0.1 port 40654
May 14 18:13:53.340250 sshd-session[2787]: pam_unix(sshd:session): session closed for user core
May 14 18:13:53.353895 systemd[1]: sshd@26-10.0.0.142:22-10.0.0.1:40654.service: Deactivated successfully.
May 14 18:13:53.356336 systemd[1]: session-27.scope: Deactivated successfully.
May 14 18:13:53.357199 systemd-logind[1492]: Session 27 logged out. Waiting for processes to exit.
May 14 18:13:53.360903 systemd[1]: Started sshd@27-10.0.0.142:22-10.0.0.1:40668.service - OpenSSH per-connection server daemon (10.0.0.1:40668).
May 14 18:13:53.361543 systemd-logind[1492]: Removed session 27.
May 14 18:13:53.422262 sshd[2802]: Accepted publickey for core from 10.0.0.1 port 40668 ssh2: RSA SHA256:AQRdwKZnQU0/9TofE96iRt4qC1i2gX6nnZ/OI0eW5lM
May 14 18:13:53.423970 sshd-session[2802]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 14 18:13:53.428501 systemd-logind[1492]: New session 28 of user core.
May 14 18:13:53.438009 systemd[1]: Started session-28.scope - Session 28 of User core.
May 14 18:13:53.516526 systemd[1]: var-lib-docker-overlay2-1fa75e94f21beabc77c620605ba5d79ebc8d5690b38d722678dfee8a7408f8b8\x2dinit-merged.mount: Deactivated successfully.
May 14 18:13:53.567362 containerd[2501]: time="2025-05-14T18:13:53.567307190Z" level=info msg="connecting to shim 7bcedef417a257eaa72548ddc15eef39e05c06b1a5351d19606e8f5aa9ca18d1" address="unix:///run/containerd/s/93a5d9693a7174636c08d87b23b6e0f5870c67cdbf2336ed99eddeac4cb643f4" namespace=moby protocol=ttrpc version=3
May 14 18:13:53.593988 systemd[1]: Started docker-7bcedef417a257eaa72548ddc15eef39e05c06b1a5351d19606e8f5aa9ca18d1.scope - libcontainer container 7bcedef417a257eaa72548ddc15eef39e05c06b1a5351d19606e8f5aa9ca18d1.
May 14 18:13:53.606787 systemd-resolved[1355]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
May 14 18:13:53.631513 kernel: docker0: port 1(veth6a86c51) entered blocking state
May 14 18:13:53.631613 kernel: docker0: port 1(veth6a86c51) entered disabled state
May 14 18:13:53.631636 kernel: veth6a86c51: entered allmulticast mode
May 14 18:13:53.632877 kernel: veth6a86c51: entered promiscuous mode
May 14 18:13:53.632887 systemd-networkd[1446]: veth6a86c51: Link UP
May 14 18:13:53.640908 kernel: eth0: renamed from veth8ebf92a
May 14 18:13:53.644786 systemd-networkd[1446]: veth6a86c51: Gained carrier
May 14 18:13:53.644928 kernel: docker0: port 1(veth6a86c51) entered blocking state
May 14 18:13:53.644954 kernel: docker0: port 1(veth6a86c51) entered forwarding state
May 14 18:13:53.645245 systemd-networkd[1446]: docker0: Gained carrier
May 14 18:13:53.673048 sshd[2804]: Connection closed by 10.0.0.1 port 40668
May 14 18:13:53.673340 sshd-session[2802]: pam_unix(sshd:session): session closed for user core
May 14 18:13:53.677090 systemd[1]: sshd@27-10.0.0.142:22-10.0.0.1:40668.service: Deactivated successfully.
May 14 18:13:53.678793 systemd[1]: session-28.scope: Deactivated successfully.
May 14 18:13:53.679531 systemd-logind[1492]: Session 28 logged out. Waiting for processes to exit.
May 14 18:13:53.680873 systemd-logind[1492]: Removed session 28.
May 14 18:13:54.703179 systemd-networkd[1446]: veth6a86c51: Gained IPv6LL