May 14 05:08:08.866253 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 03:42:56 -00 2025 May 14 05:08:08.866273 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=bd5d20a479abde3485dc2e7b97a54e804895b9926289ae86f84794bef32a40f3 May 14 05:08:08.866284 kernel: BIOS-provided physical RAM map: May 14 05:08:08.866290 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable May 14 05:08:08.866296 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable May 14 05:08:08.866302 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS May 14 05:08:08.866310 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable May 14 05:08:08.866316 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS May 14 05:08:08.866324 kernel: BIOS-e820: [mem 0x000000000080c000-0x0000000000810fff] usable May 14 05:08:08.866331 kernel: BIOS-e820: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS May 14 05:08:08.866337 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009bd3efff] usable May 14 05:08:08.866343 kernel: BIOS-e820: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved May 14 05:08:08.866349 kernel: BIOS-e820: [mem 0x000000009be00000-0x000000009c8ecfff] usable May 14 05:08:08.866356 kernel: BIOS-e820: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved May 14 05:08:08.866365 kernel: BIOS-e820: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data May 14 05:08:08.866372 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS May 14 05:08:08.866379 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009ce90fff] usable May 14 05:08:08.866386 kernel: BIOS-e820: [mem 0x000000009ce91000-0x000000009ce94fff] reserved May 14 05:08:08.866392 kernel: BIOS-e820: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS May 14 05:08:08.866399 kernel: BIOS-e820: [mem 0x000000009ce97000-0x000000009cedbfff] usable May 14 05:08:08.866406 kernel: BIOS-e820: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved May 14 05:08:08.866412 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS May 14 05:08:08.866419 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved May 14 05:08:08.866426 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 14 05:08:08.866433 kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved May 14 05:08:08.866441 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 14 05:08:08.866448 kernel: NX (Execute Disable) protection: active May 14 05:08:08.866455 kernel: APIC: Static calls initialized May 14 05:08:08.866462 kernel: e820: update [mem 0x9b320018-0x9b329c57] usable ==> usable May 14 05:08:08.866469 kernel: e820: update [mem 0x9b2e3018-0x9b31fe57] usable ==> usable May 14 05:08:08.866475 kernel: extended physical RAM map: May 14 05:08:08.866482 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable May 14 05:08:08.866489 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable May 14 05:08:08.866496 kernel: reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS May 14 05:08:08.866503 kernel: reserve setup_data: [mem 0x0000000000808000-0x000000000080afff] usable May 14 05:08:08.866509 kernel: reserve setup_data: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS May 14 05:08:08.866518 kernel: reserve setup_data: [mem 0x000000000080c000-0x0000000000810fff] usable May 14 05:08:08.866525 kernel: reserve setup_data: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS May 14 05:08:08.866532 kernel: reserve setup_data: [mem 0x0000000000900000-0x000000009b2e3017] usable May 14 05:08:08.866538 kernel: reserve setup_data: [mem 0x000000009b2e3018-0x000000009b31fe57] usable May 14 05:08:08.866548 kernel: reserve setup_data: [mem 0x000000009b31fe58-0x000000009b320017] usable May 14 05:08:08.866555 kernel: reserve setup_data: [mem 0x000000009b320018-0x000000009b329c57] usable May 14 05:08:08.866564 kernel: reserve setup_data: [mem 0x000000009b329c58-0x000000009bd3efff] usable May 14 05:08:08.866571 kernel: reserve setup_data: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved May 14 05:08:08.866578 kernel: reserve setup_data: [mem 0x000000009be00000-0x000000009c8ecfff] usable May 14 05:08:08.866585 kernel: reserve setup_data: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved May 14 05:08:08.866592 kernel: reserve setup_data: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data May 14 05:08:08.866599 kernel: reserve setup_data: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS May 14 05:08:08.866606 kernel: reserve setup_data: [mem 0x000000009cbff000-0x000000009ce90fff] usable May 14 05:08:08.866613 kernel: reserve setup_data: [mem 0x000000009ce91000-0x000000009ce94fff] reserved May 14 05:08:08.866620 kernel: reserve setup_data: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS May 14 05:08:08.866629 kernel: reserve setup_data: [mem 0x000000009ce97000-0x000000009cedbfff] usable May 14 05:08:08.866636 kernel: reserve setup_data: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved May 14 05:08:08.866643 kernel: reserve setup_data: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS May 14 05:08:08.866650 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved May 14 05:08:08.866657 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 14 05:08:08.866664 kernel: reserve setup_data: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved May 14 05:08:08.866671 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 14 05:08:08.866678 kernel: efi: EFI v2.7 by EDK II May 14 05:08:08.866685 kernel: efi: SMBIOS=0x9c988000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b9e4198 RNG=0x9cb73018 May 14 05:08:08.866692 kernel: random: crng init done May 14 05:08:08.866699 kernel: efi: Remove mem149: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map May 14 05:08:08.866706 kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved May 14 05:08:08.866727 kernel: secureboot: Secure boot disabled May 14 05:08:08.866748 kernel: SMBIOS 2.8 present. May 14 05:08:08.866755 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 May 14 05:08:08.866762 kernel: DMI: Memory slots populated: 1/1 May 14 05:08:08.866769 kernel: Hypervisor detected: KVM May 14 05:08:08.866776 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 May 14 05:08:08.866783 kernel: kvm-clock: using sched offset of 3614608662 cycles May 14 05:08:08.866791 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns May 14 05:08:08.866798 kernel: tsc: Detected 2794.748 MHz processor May 14 05:08:08.866806 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 14 05:08:08.866813 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 14 05:08:08.866823 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 May 14 05:08:08.866830 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs May 14 05:08:08.866837 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 14 05:08:08.866844 kernel: Using GB pages for direct mapping May 14 05:08:08.866852 kernel: ACPI: Early table checksum verification disabled May 14 05:08:08.866859 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) May 14 05:08:08.866866 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) May 14 05:08:08.866874 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 14 05:08:08.866881 kernel: ACPI: DSDT 0x000000009CB7A000 0021A8 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 14 05:08:08.866890 kernel: ACPI: FACS 0x000000009CBDD000 000040 May 14 05:08:08.866897 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 14 05:08:08.866904 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 14 05:08:08.866911 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 14 05:08:08.866919 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 14 05:08:08.866926 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) May 14 05:08:08.866933 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] May 14 05:08:08.866940 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1a7] May 14 05:08:08.866949 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] May 14 05:08:08.866956 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] May 14 05:08:08.866963 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] May 14 05:08:08.866970 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] May 14 05:08:08.866978 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] May 14 05:08:08.866985 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] May 14 05:08:08.866992 kernel: No NUMA configuration found May 14 05:08:08.866999 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cedbfff] May 14 05:08:08.867006 kernel: NODE_DATA(0) allocated [mem 0x9ce36dc0-0x9ce3dfff] May 14 05:08:08.867013 kernel: Zone ranges: May 14 05:08:08.867022 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 14 05:08:08.867029 kernel: DMA32 [mem 0x0000000001000000-0x000000009cedbfff] May 14 05:08:08.867036 kernel: Normal empty May 14 05:08:08.867043 kernel: Device empty May 14 05:08:08.867051 kernel: Movable zone start for each node May 14 05:08:08.867057 kernel: Early memory node ranges May 14 05:08:08.867065 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] May 14 05:08:08.867072 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] May 14 05:08:08.867079 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] May 14 05:08:08.867088 kernel: node 0: [mem 0x000000000080c000-0x0000000000810fff] May 14 05:08:08.867095 kernel: node 0: [mem 0x0000000000900000-0x000000009bd3efff] May 14 05:08:08.867102 kernel: node 0: [mem 0x000000009be00000-0x000000009c8ecfff] May 14 05:08:08.867109 kernel: node 0: [mem 0x000000009cbff000-0x000000009ce90fff] May 14 05:08:08.867116 kernel: node 0: [mem 0x000000009ce97000-0x000000009cedbfff] May 14 05:08:08.867123 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cedbfff] May 14 05:08:08.867130 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 14 05:08:08.867137 kernel: On node 0, zone DMA: 96 pages in unavailable ranges May 14 05:08:08.867161 kernel: On node 0, zone DMA: 8 pages in unavailable ranges May 14 05:08:08.867168 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 14 05:08:08.867175 kernel: On node 0, zone DMA: 239 pages in unavailable ranges May 14 05:08:08.867183 kernel: On node 0, zone DMA32: 193 pages in unavailable ranges May 14 05:08:08.867193 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges May 14 05:08:08.867200 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges May 14 05:08:08.867208 kernel: On node 0, zone DMA32: 12580 pages in unavailable ranges May 14 05:08:08.867215 kernel: ACPI: PM-Timer IO Port: 0x608 May 14 05:08:08.867222 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) May 14 05:08:08.867232 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 14 05:08:08.867239 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) May 14 05:08:08.867247 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) May 14 05:08:08.867254 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 14 05:08:08.867262 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) May 14 05:08:08.867269 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) May 14 05:08:08.867277 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 14 05:08:08.867284 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 May 14 05:08:08.867292 kernel: TSC deadline timer available May 14 05:08:08.867301 kernel: CPU topo: Max. logical packages: 1 May 14 05:08:08.867308 kernel: CPU topo: Max. logical dies: 1 May 14 05:08:08.867316 kernel: CPU topo: Max. dies per package: 1 May 14 05:08:08.867323 kernel: CPU topo: Max. threads per core: 1 May 14 05:08:08.867330 kernel: CPU topo: Num. cores per package: 4 May 14 05:08:08.867337 kernel: CPU topo: Num. threads per package: 4 May 14 05:08:08.867345 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs May 14 05:08:08.867352 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() May 14 05:08:08.867359 kernel: kvm-guest: KVM setup pv remote TLB flush May 14 05:08:08.867367 kernel: kvm-guest: setup PV sched yield May 14 05:08:08.867376 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices May 14 05:08:08.867383 kernel: Booting paravirtualized kernel on KVM May 14 05:08:08.867391 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 14 05:08:08.867399 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 May 14 05:08:08.867406 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 May 14 05:08:08.867414 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 May 14 05:08:08.867421 kernel: pcpu-alloc: [0] 0 1 2 3 May 14 05:08:08.867428 kernel: kvm-guest: PV spinlocks enabled May 14 05:08:08.867436 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 14 05:08:08.867447 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=bd5d20a479abde3485dc2e7b97a54e804895b9926289ae86f84794bef32a40f3 May 14 05:08:08.867455 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 14 05:08:08.867462 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 14 05:08:08.867470 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 14 05:08:08.867477 kernel: Fallback order for Node 0: 0 May 14 05:08:08.867484 kernel: Built 1 zonelists, mobility grouping on. Total pages: 641450 May 14 05:08:08.867492 kernel: Policy zone: DMA32 May 14 05:08:08.867499 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 14 05:08:08.867508 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 14 05:08:08.867516 kernel: ftrace: allocating 40065 entries in 157 pages May 14 05:08:08.867523 kernel: ftrace: allocated 157 pages with 5 groups May 14 05:08:08.867530 kernel: Dynamic Preempt: voluntary May 14 05:08:08.867538 kernel: rcu: Preemptible hierarchical RCU implementation. May 14 05:08:08.867546 kernel: rcu: RCU event tracing is enabled. May 14 05:08:08.867554 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 14 05:08:08.867561 kernel: Trampoline variant of Tasks RCU enabled. May 14 05:08:08.867569 kernel: Rude variant of Tasks RCU enabled. May 14 05:08:08.867578 kernel: Tracing variant of Tasks RCU enabled. May 14 05:08:08.867586 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 14 05:08:08.867593 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 14 05:08:08.867601 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 14 05:08:08.867608 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 14 05:08:08.867616 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 14 05:08:08.867623 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 May 14 05:08:08.867631 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 14 05:08:08.867638 kernel: Console: colour dummy device 80x25 May 14 05:08:08.867648 kernel: printk: legacy console [ttyS0] enabled May 14 05:08:08.867655 kernel: ACPI: Core revision 20240827 May 14 05:08:08.867664 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns May 14 05:08:08.867673 kernel: APIC: Switch to symmetric I/O mode setup May 14 05:08:08.867681 kernel: x2apic enabled May 14 05:08:08.867690 kernel: APIC: Switched APIC routing to: physical x2apic May 14 05:08:08.867698 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() May 14 05:08:08.867705 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() May 14 05:08:08.867713 kernel: kvm-guest: setup PV IPIs May 14 05:08:08.867790 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 May 14 05:08:08.867798 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns May 14 05:08:08.867806 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) May 14 05:08:08.867813 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 14 05:08:08.867820 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 May 14 05:08:08.867828 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 May 14 05:08:08.867835 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 14 05:08:08.867843 kernel: Spectre V2 : Mitigation: Retpolines May 14 05:08:08.867850 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch May 14 05:08:08.867860 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT May 14 05:08:08.867867 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls May 14 05:08:08.867875 kernel: RETBleed: Mitigation: untrained return thunk May 14 05:08:08.867882 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier May 14 05:08:08.867890 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl May 14 05:08:08.867897 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! May 14 05:08:08.867905 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. May 14 05:08:08.867913 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode May 14 05:08:08.867922 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 14 05:08:08.867930 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 14 05:08:08.867937 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 14 05:08:08.867945 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 14 05:08:08.867952 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. May 14 05:08:08.867960 kernel: Freeing SMP alternatives memory: 32K May 14 05:08:08.867967 kernel: pid_max: default: 32768 minimum: 301 May 14 05:08:08.867975 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 14 05:08:08.867982 kernel: landlock: Up and running. May 14 05:08:08.867991 kernel: SELinux: Initializing. May 14 05:08:08.867999 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 14 05:08:08.868006 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 14 05:08:08.868014 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) May 14 05:08:08.868022 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. May 14 05:08:08.868029 kernel: ... version: 0 May 14 05:08:08.868036 kernel: ... bit width: 48 May 14 05:08:08.868043 kernel: ... generic registers: 6 May 14 05:08:08.868051 kernel: ... value mask: 0000ffffffffffff May 14 05:08:08.868060 kernel: ... max period: 00007fffffffffff May 14 05:08:08.868068 kernel: ... fixed-purpose events: 0 May 14 05:08:08.868075 kernel: ... event mask: 000000000000003f May 14 05:08:08.868082 kernel: signal: max sigframe size: 1776 May 14 05:08:08.868090 kernel: rcu: Hierarchical SRCU implementation. May 14 05:08:08.868097 kernel: rcu: Max phase no-delay instances is 400. May 14 05:08:08.868105 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 14 05:08:08.868112 kernel: smp: Bringing up secondary CPUs ... May 14 05:08:08.868120 kernel: smpboot: x86: Booting SMP configuration: May 14 05:08:08.868127 kernel: .... node #0, CPUs: #1 #2 #3 May 14 05:08:08.868136 kernel: smp: Brought up 1 node, 4 CPUs May 14 05:08:08.868144 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) May 14 05:08:08.868159 kernel: Memory: 2422664K/2565800K available (14336K kernel code, 2438K rwdata, 9944K rodata, 54416K init, 2544K bss, 137196K reserved, 0K cma-reserved) May 14 05:08:08.868166 kernel: devtmpfs: initialized May 14 05:08:08.868174 kernel: x86/mm: Memory block size: 128MB May 14 05:08:08.868181 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) May 14 05:08:08.868189 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) May 14 05:08:08.868197 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00811000-0x008fffff] (978944 bytes) May 14 05:08:08.868207 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) May 14 05:08:08.868214 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9ce95000-0x9ce96fff] (8192 bytes) May 14 05:08:08.868222 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) May 14 05:08:08.868230 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 14 05:08:08.868237 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 14 05:08:08.868244 kernel: pinctrl core: initialized pinctrl subsystem May 14 05:08:08.868252 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 14 05:08:08.868259 kernel: audit: initializing netlink subsys (disabled) May 14 05:08:08.868267 kernel: audit: type=2000 audit(1747199287.294:1): state=initialized audit_enabled=0 res=1 May 14 05:08:08.868276 kernel: thermal_sys: Registered thermal governor 'step_wise' May 14 05:08:08.868284 kernel: thermal_sys: Registered thermal governor 'user_space' May 14 05:08:08.868291 kernel: cpuidle: using governor menu May 14 05:08:08.868298 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 14 05:08:08.868306 kernel: dca service started, version 1.12.1 May 14 05:08:08.868313 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] May 14 05:08:08.868321 kernel: PCI: Using configuration type 1 for base access May 14 05:08:08.868328 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 14 05:08:08.868336 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 14 05:08:08.868345 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 14 05:08:08.868353 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 14 05:08:08.868360 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 14 05:08:08.868367 kernel: ACPI: Added _OSI(Module Device) May 14 05:08:08.868375 kernel: ACPI: Added _OSI(Processor Device) May 14 05:08:08.868382 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 14 05:08:08.868389 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 14 05:08:08.868397 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 14 05:08:08.868404 kernel: ACPI: Interpreter enabled May 14 05:08:08.868413 kernel: ACPI: PM: (supports S0 S3 S5) May 14 05:08:08.868421 kernel: ACPI: Using IOAPIC for interrupt routing May 14 05:08:08.868428 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 14 05:08:08.868436 kernel: PCI: Using E820 reservations for host bridge windows May 14 05:08:08.868443 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F May 14 05:08:08.868451 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 14 05:08:08.868613 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 14 05:08:08.868760 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] May 14 05:08:08.868881 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] May 14 05:08:08.868891 kernel: PCI host bridge to bus 0000:00 May 14 05:08:08.869006 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 14 05:08:08.869109 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 14 05:08:08.869225 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] May 14 05:08:08.869326 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] May 14 05:08:08.869427 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] May 14 05:08:08.869530 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] May 14 05:08:08.869630 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 14 05:08:08.869781 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint May 14 05:08:08.869903 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint May 14 05:08:08.870015 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] May 14 05:08:08.870125 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] May 14 05:08:08.870249 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] May 14 05:08:08.870359 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 14 05:08:08.870478 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint May 14 05:08:08.870590 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] May 14 05:08:08.870700 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] May 14 05:08:08.870856 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] May 14 05:08:08.870979 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint May 14 05:08:08.871097 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] May 14 05:08:08.871269 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] May 14 05:08:08.871430 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] May 14 05:08:08.871558 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint May 14 05:08:08.871669 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] May 14 05:08:08.871803 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] May 14 05:08:08.871915 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] May 14 05:08:08.872031 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] May 14 05:08:08.872149 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint May 14 05:08:08.872270 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO May 14 05:08:08.872388 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint May 14 05:08:08.872532 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] May 14 05:08:08.872678 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] May 14 05:08:08.872860 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint May 14 05:08:08.872977 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] May 14 05:08:08.872987 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 May 14 05:08:08.872995 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 May 14 05:08:08.873002 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 May 14 05:08:08.873010 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 May 14 05:08:08.873017 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 May 14 05:08:08.873025 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 May 14 05:08:08.873036 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 May 14 05:08:08.873044 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 May 14 05:08:08.873051 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 May 14 05:08:08.873059 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 May 14 05:08:08.873066 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 May 14 05:08:08.873073 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 May 14 05:08:08.873081 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 May 14 05:08:08.873088 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 May 14 05:08:08.873096 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 May 14 05:08:08.873106 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 May 14 05:08:08.873114 kernel: iommu: Default domain type: Translated May 14 05:08:08.873121 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 14 05:08:08.873129 kernel: efivars: Registered efivars operations May 14 05:08:08.873136 kernel: PCI: Using ACPI for IRQ routing May 14 05:08:08.873144 kernel: PCI: pci_cache_line_size set to 64 bytes May 14 05:08:08.873159 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] May 14 05:08:08.873166 kernel: e820: reserve RAM buffer [mem 0x00811000-0x008fffff] May 14 05:08:08.873173 kernel: e820: reserve RAM buffer [mem 0x9b2e3018-0x9bffffff] May 14 05:08:08.873181 kernel: e820: reserve RAM buffer [mem 0x9b320018-0x9bffffff] May 14 05:08:08.873191 kernel: e820: reserve RAM buffer [mem 0x9bd3f000-0x9bffffff] May 14 05:08:08.873199 kernel: e820: reserve RAM buffer [mem 0x9c8ed000-0x9fffffff] May 14 05:08:08.873206 kernel: e820: reserve RAM buffer [mem 0x9ce91000-0x9fffffff] May 14 05:08:08.873214 kernel: e820: reserve RAM buffer [mem 0x9cedc000-0x9fffffff] May 14 05:08:08.873326 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device May 14 05:08:08.873436 kernel: pci 0000:00:01.0: vgaarb: bridge control possible May 14 05:08:08.873546 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 14 05:08:08.873559 kernel: vgaarb: loaded May 14 05:08:08.873566 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 May 14 05:08:08.873574 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter May 14 05:08:08.873581 kernel: clocksource: Switched to clocksource kvm-clock May 14 05:08:08.873589 kernel: VFS: Disk quotas dquot_6.6.0 May 14 05:08:08.873597 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 14 05:08:08.873604 kernel: pnp: PnP ACPI init May 14 05:08:08.873755 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved May 14 05:08:08.873772 kernel: pnp: PnP ACPI: found 6 devices May 14 05:08:08.873780 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 14 05:08:08.873788 kernel: NET: Registered PF_INET protocol family May 14 05:08:08.873796 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 14 05:08:08.873804 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 14 05:08:08.873812 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 14 05:08:08.873820 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 14 05:08:08.873828 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 14 05:08:08.873836 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 14 05:08:08.873845 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 14 05:08:08.873853 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 14 05:08:08.873861 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 14 05:08:08.873869 kernel: NET: Registered PF_XDP protocol family May 14 05:08:08.873992 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window May 14 05:08:08.874151 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned May 14 05:08:08.874267 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 14 05:08:08.874368 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 14 05:08:08.874477 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] May 14 05:08:08.874577 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] May 14 05:08:08.874678 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] May 14 05:08:08.874794 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] May 14 05:08:08.874805 kernel: PCI: CLS 0 bytes, default 64 May 14 05:08:08.874813 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns May 14 05:08:08.874821 kernel: Initialise system trusted keyrings May 14 05:08:08.874832 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 14 05:08:08.874840 kernel: Key type asymmetric registered May 14 05:08:08.874848 kernel: Asymmetric key parser 'x509' registered May 14 05:08:08.874856 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 14 05:08:08.874864 kernel: io scheduler mq-deadline registered May 14 05:08:08.874872 kernel: io scheduler kyber registered May 14 05:08:08.874880 kernel: io scheduler bfq registered May 14 05:08:08.874888 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 14 05:08:08.874908 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 May 14 05:08:08.874924 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 May 14 05:08:08.874934 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 May 14 05:08:08.874942 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 14 05:08:08.874950 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 14 05:08:08.874958 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 May 14 05:08:08.874966 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 May 14 05:08:08.874978 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 May 14 05:08:08.875098 kernel: rtc_cmos 00:04: RTC can wake from S4 May 14 05:08:08.875112 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 May 14 05:08:08.875229 kernel: rtc_cmos 00:04: registered as rtc0 May 14 05:08:08.875334 kernel: rtc_cmos 00:04: setting system clock to 2025-05-14T05:08:08 UTC (1747199288) May 14 05:08:08.875438 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram May 14 05:08:08.875448 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled May 14 05:08:08.875456 kernel: efifb: probing for efifb May 14 05:08:08.875464 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k May 14 05:08:08.875475 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 May 14 05:08:08.875483 kernel: efifb: scrolling: redraw May 14 05:08:08.875490 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 14 05:08:08.875498 kernel: Console: switching to colour frame buffer device 160x50 May 14 05:08:08.875506 kernel: fb0: EFI VGA frame buffer device May 14 05:08:08.875514 kernel: pstore: Using crash dump compression: deflate May 14 05:08:08.875522 kernel: pstore: Registered efi_pstore as persistent store backend May 14 05:08:08.875530 kernel: NET: Registered PF_INET6 protocol family May 14 05:08:08.875538 kernel: Segment Routing with IPv6 May 14 05:08:08.875545 kernel: In-situ OAM (IOAM) with IPv6 May 14 05:08:08.875555 kernel: NET: Registered PF_PACKET protocol family May 14 05:08:08.875563 kernel: Key type dns_resolver registered May 14 05:08:08.875571 kernel: IPI shorthand broadcast: enabled May 14 05:08:08.875578 kernel: sched_clock: Marking stable (2753002297, 157997873)->(2925516172, -14516002) May 14 05:08:08.875586 kernel: registered taskstats version 1 May 14 05:08:08.875594 kernel: Loading compiled-in X.509 certificates May 14 05:08:08.875602 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.20-flatcar: de56839f264dfa1264ece2be0efda2f53967cc2a' May 14 05:08:08.875610 kernel: Demotion targets for Node 0: null May 14 05:08:08.875617 kernel: Key type .fscrypt registered May 14 05:08:08.875627 kernel: Key type fscrypt-provisioning registered May 14 05:08:08.875635 kernel: ima: No TPM chip found, activating TPM-bypass! May 14 05:08:08.875642 kernel: ima: Allocated hash algorithm: sha1 May 14 05:08:08.875650 kernel: ima: No architecture policies found May 14 05:08:08.875658 kernel: clk: Disabling unused clocks May 14 05:08:08.875666 kernel: Warning: unable to open an initial console. May 14 05:08:08.875676 kernel: Freeing unused kernel image (initmem) memory: 54416K May 14 05:08:08.875685 kernel: Write protecting the kernel read-only data: 24576k May 14 05:08:08.875697 kernel: Freeing unused kernel image (rodata/data gap) memory: 296K May 14 05:08:08.875705 kernel: Run /init as init process May 14 05:08:08.875712 kernel: with arguments: May 14 05:08:08.875745 kernel: /init May 14 05:08:08.875753 kernel: with environment: May 14 05:08:08.875760 kernel: HOME=/ May 14 05:08:08.875768 kernel: TERM=linux May 14 05:08:08.875776 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 14 05:08:08.875784 systemd[1]: Successfully made /usr/ read-only. May 14 05:08:08.875798 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 05:08:08.875807 systemd[1]: Detected virtualization kvm. May 14 05:08:08.875816 systemd[1]: Detected architecture x86-64. May 14 05:08:08.875824 systemd[1]: Running in initrd. May 14 05:08:08.875832 systemd[1]: No hostname configured, using default hostname. May 14 05:08:08.875840 systemd[1]: Hostname set to . May 14 05:08:08.875848 systemd[1]: Initializing machine ID from VM UUID. May 14 05:08:08.875859 systemd[1]: Queued start job for default target initrd.target. May 14 05:08:08.875867 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 14 05:08:08.875876 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 14 05:08:08.875885 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 14 05:08:08.875894 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 14 05:08:08.875902 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 14 05:08:08.875911 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 14 05:08:08.875923 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 05:08:08.875931 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 14 05:08:08.875940 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 14 05:08:08.875948 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 14 05:08:08.875956 systemd[1]: Reached target paths.target - Path Units. May 14 05:08:08.875965 systemd[1]: Reached target slices.target - Slice Units. May 14 05:08:08.875973 systemd[1]: Reached target swap.target - Swaps. May 14 05:08:08.875981 systemd[1]: Reached target timers.target - Timer Units. May 14 05:08:08.875989 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 14 05:08:08.876000 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 14 05:08:08.876008 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 14 05:08:08.876016 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 14 05:08:08.876024 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 14 05:08:08.876033 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 14 05:08:08.876041 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 14 05:08:08.876049 systemd[1]: Reached target sockets.target - Socket Units. May 14 05:08:08.876058 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 14 05:08:08.876068 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 14 05:08:08.876076 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 14 05:08:08.876085 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 05:08:08.876093 systemd[1]: Starting systemd-fsck-usr.service... May 14 05:08:08.876102 systemd[1]: Starting systemd-journald.service - Journal Service... May 14 05:08:08.876110 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 14 05:08:08.876118 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:08.876126 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 14 05:08:08.876137 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 14 05:08:08.876146 systemd[1]: Finished systemd-fsck-usr.service. May 14 05:08:08.876182 systemd-journald[220]: Collecting audit messages is disabled. May 14 05:08:08.876206 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 14 05:08:08.876215 systemd-journald[220]: Journal started May 14 05:08:08.876233 systemd-journald[220]: Runtime Journal (/run/log/journal/17108b09879b461fbab9893825484667) is 6M, max 48.5M, 42.4M free. May 14 05:08:08.872827 systemd-modules-load[223]: Inserted module 'overlay' May 14 05:08:08.880733 systemd[1]: Started systemd-journald.service - Journal Service. May 14 05:08:08.881398 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 14 05:08:08.884669 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:08.889821 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 14 05:08:08.897030 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 14 05:08:08.898625 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 14 05:08:08.907699 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 05:08:08.907777 kernel: Bridge firewalling registered May 14 05:08:08.907811 systemd-modules-load[223]: Inserted module 'br_netfilter' May 14 05:08:08.909269 systemd-tmpfiles[236]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 14 05:08:08.909393 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 14 05:08:08.913238 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 14 05:08:08.915020 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 14 05:08:08.919243 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 14 05:08:08.921622 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 14 05:08:08.924275 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 14 05:08:08.943029 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 14 05:08:08.945856 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 14 05:08:08.951872 dracut-cmdline[258]: 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=bd5d20a479abde3485dc2e7b97a54e804895b9926289ae86f84794bef32a40f3 May 14 05:08:09.005503 systemd-resolved[271]: Positive Trust Anchors: May 14 05:08:09.005522 systemd-resolved[271]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 14 05:08:09.005566 systemd-resolved[271]: 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 05:08:09.008782 systemd-resolved[271]: Defaulting to hostname 'linux'. May 14 05:08:09.014484 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 14 05:08:09.015860 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 14 05:08:09.068762 kernel: SCSI subsystem initialized May 14 05:08:09.079750 kernel: Loading iSCSI transport class v2.0-870. May 14 05:08:09.092766 kernel: iscsi: registered transport (tcp) May 14 05:08:09.113880 kernel: iscsi: registered transport (qla4xxx) May 14 05:08:09.113984 kernel: QLogic iSCSI HBA Driver May 14 05:08:09.136089 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 14 05:08:09.153195 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 14 05:08:09.153830 systemd[1]: Reached target network-pre.target - Preparation for Network. May 14 05:08:09.212128 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 14 05:08:09.214811 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 14 05:08:09.271751 kernel: raid6: avx2x4 gen() 29975 MB/s May 14 05:08:09.288749 kernel: raid6: avx2x2 gen() 31117 MB/s May 14 05:08:09.305836 kernel: raid6: avx2x1 gen() 25741 MB/s May 14 05:08:09.305875 kernel: raid6: using algorithm avx2x2 gen() 31117 MB/s May 14 05:08:09.323847 kernel: raid6: .... xor() 19887 MB/s, rmw enabled May 14 05:08:09.323915 kernel: raid6: using avx2x2 recovery algorithm May 14 05:08:09.343745 kernel: xor: automatically using best checksumming function avx May 14 05:08:09.504760 kernel: Btrfs loaded, zoned=no, fsverity=no May 14 05:08:09.512941 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 14 05:08:09.515706 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 14 05:08:09.547555 systemd-udevd[473]: Using default interface naming scheme 'v255'. May 14 05:08:09.553608 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 14 05:08:09.555084 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 14 05:08:09.575675 dracut-pre-trigger[475]: rd.md=0: removing MD RAID activation May 14 05:08:09.603224 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 14 05:08:09.605864 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 14 05:08:09.685714 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 14 05:08:09.689965 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 14 05:08:09.724751 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues May 14 05:08:09.736974 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 14 05:08:09.737120 kernel: cryptd: max_cpu_qlen set to 1000 May 14 05:08:09.737141 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 14 05:08:09.738739 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 May 14 05:08:09.745762 kernel: libata version 3.00 loaded. May 14 05:08:09.754325 kernel: ahci 0000:00:1f.2: version 3.0 May 14 05:08:09.799295 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 May 14 05:08:09.799316 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode May 14 05:08:09.799461 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) May 14 05:08:09.799594 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only May 14 05:08:09.799739 kernel: AES CTR mode by8 optimization enabled May 14 05:08:09.799751 kernel: scsi host0: ahci May 14 05:08:09.799895 kernel: scsi host1: ahci May 14 05:08:09.800041 kernel: scsi host2: ahci May 14 05:08:09.800187 kernel: scsi host3: ahci May 14 05:08:09.800320 kernel: scsi host4: ahci May 14 05:08:09.800456 kernel: scsi host5: ahci May 14 05:08:09.800588 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 0 May 14 05:08:09.800599 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 0 May 14 05:08:09.800609 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 0 May 14 05:08:09.800623 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 0 May 14 05:08:09.800633 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 0 May 14 05:08:09.800643 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 0 May 14 05:08:09.755880 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 05:08:09.755999 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:09.759153 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:09.762174 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:09.800605 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 14 05:08:09.819997 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 14 05:08:09.843080 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 14 05:08:09.852085 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 05:08:09.855340 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 14 05:08:09.858915 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 14 05:08:09.861276 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 05:08:09.861350 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:09.864688 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:09.870251 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:09.871532 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. May 14 05:08:09.880733 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 14 05:08:09.891285 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:10.107797 kernel: ata1: SATA link down (SStatus 0 SControl 300) May 14 05:08:10.107866 kernel: ata6: SATA link down (SStatus 0 SControl 300) May 14 05:08:10.107877 kernel: ata5: SATA link down (SStatus 0 SControl 300) May 14 05:08:10.108745 kernel: ata2: SATA link down (SStatus 0 SControl 300) May 14 05:08:10.109738 kernel: ata4: SATA link down (SStatus 0 SControl 300) May 14 05:08:10.110747 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) May 14 05:08:10.111888 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 May 14 05:08:10.111899 kernel: ata3.00: applying bridge limits May 14 05:08:10.112747 kernel: ata3.00: configured for UDMA/100 May 14 05:08:10.112797 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 May 14 05:08:10.167361 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray May 14 05:08:10.187308 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 14 05:08:10.187321 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 May 14 05:08:10.610176 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 14 05:08:10.610911 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 14 05:08:10.612521 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 14 05:08:10.613022 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 14 05:08:10.614097 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 14 05:08:10.638338 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 14 05:08:10.891656 disk-uuid[638]: The operation has completed successfully. May 14 05:08:10.893026 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 14 05:08:10.915247 systemd[1]: disk-uuid.service: Deactivated successfully. May 14 05:08:10.915363 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 14 05:08:10.953387 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 14 05:08:10.969713 sh[670]: Success May 14 05:08:10.987609 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 14 05:08:10.987665 kernel: device-mapper: uevent: version 1.0.3 May 14 05:08:10.987679 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 14 05:08:10.995748 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 14 05:08:11.025101 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 14 05:08:11.027152 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 14 05:08:11.039799 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 14 05:08:11.046522 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' May 14 05:08:11.046569 kernel: BTRFS: device fsid 522ba959-9153-4a92-926e-3277bc1060e7 devid 1 transid 40 /dev/mapper/usr (253:0) scanned by mount (682) May 14 05:08:11.049319 kernel: BTRFS info (device dm-0): first mount of filesystem 522ba959-9153-4a92-926e-3277bc1060e7 May 14 05:08:11.049336 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 14 05:08:11.049352 kernel: BTRFS info (device dm-0): using free-space-tree May 14 05:08:11.053398 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 14 05:08:11.055666 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 14 05:08:11.057897 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 14 05:08:11.060592 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 14 05:08:11.062283 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 14 05:08:11.089708 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (715) May 14 05:08:11.089844 kernel: BTRFS info (device vda6): first mount of filesystem 27ac52bc-c86c-4e09-9b91-c3f9e8d3f2a0 May 14 05:08:11.089870 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 14 05:08:11.091205 kernel: BTRFS info (device vda6): using free-space-tree May 14 05:08:11.097741 kernel: BTRFS info (device vda6): last unmount of filesystem 27ac52bc-c86c-4e09-9b91-c3f9e8d3f2a0 May 14 05:08:11.098374 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 14 05:08:11.101322 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 14 05:08:11.181664 ignition[760]: Ignition 2.21.0 May 14 05:08:11.181676 ignition[760]: Stage: fetch-offline May 14 05:08:11.181705 ignition[760]: no configs at "/usr/lib/ignition/base.d" May 14 05:08:11.181771 ignition[760]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 14 05:08:11.182287 ignition[760]: parsed url from cmdline: "" May 14 05:08:11.182292 ignition[760]: no config URL provided May 14 05:08:11.182298 ignition[760]: reading system config file "/usr/lib/ignition/user.ign" May 14 05:08:11.182307 ignition[760]: no config at "/usr/lib/ignition/user.ign" May 14 05:08:11.187919 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 14 05:08:11.182328 ignition[760]: op(1): [started] loading QEMU firmware config module May 14 05:08:11.182333 ignition[760]: op(1): executing: "modprobe" "qemu_fw_cfg" May 14 05:08:11.192025 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 14 05:08:11.194003 ignition[760]: op(1): [finished] loading QEMU firmware config module May 14 05:08:11.195437 ignition[760]: parsing config with SHA512: cfc2c34789f8fc44368654c063a2a76bc5069819dfd7cd7bc7a7f81e5eb7377303f9dc7f7d0fff41aa97cf0557c9be31a512f113479a7bf18597f04aff0150aa May 14 05:08:11.199026 unknown[760]: fetched base config from "system" May 14 05:08:11.199040 unknown[760]: fetched user config from "qemu" May 14 05:08:11.199179 ignition[760]: fetch-offline: fetch-offline passed May 14 05:08:11.199246 ignition[760]: Ignition finished successfully May 14 05:08:11.211873 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 14 05:08:11.239529 systemd-networkd[859]: lo: Link UP May 14 05:08:11.239537 systemd-networkd[859]: lo: Gained carrier May 14 05:08:11.240965 systemd-networkd[859]: Enumeration completed May 14 05:08:11.241062 systemd[1]: Started systemd-networkd.service - Network Configuration. May 14 05:08:11.241302 systemd-networkd[859]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 05:08:11.241306 systemd-networkd[859]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 14 05:08:11.242223 systemd-networkd[859]: eth0: Link UP May 14 05:08:11.242226 systemd-networkd[859]: eth0: Gained carrier May 14 05:08:11.242235 systemd-networkd[859]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 05:08:11.242689 systemd[1]: Reached target network.target - Network. May 14 05:08:11.245062 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 14 05:08:11.245954 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 14 05:08:11.262763 systemd-networkd[859]: eth0: DHCPv4 address 10.0.0.69/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 14 05:08:11.273109 ignition[863]: Ignition 2.21.0 May 14 05:08:11.273121 ignition[863]: Stage: kargs May 14 05:08:11.273232 ignition[863]: no configs at "/usr/lib/ignition/base.d" May 14 05:08:11.273243 ignition[863]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 14 05:08:11.273670 ignition[863]: kargs: kargs passed May 14 05:08:11.273706 ignition[863]: Ignition finished successfully May 14 05:08:11.279134 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 14 05:08:11.282099 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 14 05:08:11.315897 ignition[872]: Ignition 2.21.0 May 14 05:08:11.315910 ignition[872]: Stage: disks May 14 05:08:11.316032 ignition[872]: no configs at "/usr/lib/ignition/base.d" May 14 05:08:11.316042 ignition[872]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 14 05:08:11.320059 ignition[872]: disks: disks passed May 14 05:08:11.320135 ignition[872]: Ignition finished successfully May 14 05:08:11.323493 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 14 05:08:11.324711 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 14 05:08:11.325173 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 14 05:08:11.325502 systemd[1]: Reached target local-fs.target - Local File Systems. May 14 05:08:11.326003 systemd[1]: Reached target sysinit.target - System Initialization. May 14 05:08:11.326345 systemd[1]: Reached target basic.target - Basic System. May 14 05:08:11.335089 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 14 05:08:11.361772 systemd-fsck[882]: ROOT: clean, 15/553520 files, 52789/553472 blocks May 14 05:08:11.369335 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 14 05:08:11.372381 systemd[1]: Mounting sysroot.mount - /sysroot... May 14 05:08:11.476742 kernel: EXT4-fs (vda9): mounted filesystem 7fda6268-ffdc-406a-8662-dffb0e9a24fa r/w with ordered data mode. Quota mode: none. May 14 05:08:11.477150 systemd[1]: Mounted sysroot.mount - /sysroot. May 14 05:08:11.477954 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 14 05:08:11.480796 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 14 05:08:11.482955 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 14 05:08:11.484035 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 14 05:08:11.484072 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 14 05:08:11.484103 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 14 05:08:11.493704 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 14 05:08:11.495888 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 14 05:08:11.500374 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (890) May 14 05:08:11.500398 kernel: BTRFS info (device vda6): first mount of filesystem 27ac52bc-c86c-4e09-9b91-c3f9e8d3f2a0 May 14 05:08:11.500409 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 14 05:08:11.501957 kernel: BTRFS info (device vda6): using free-space-tree May 14 05:08:11.505552 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 14 05:08:11.531910 initrd-setup-root[915]: cut: /sysroot/etc/passwd: No such file or directory May 14 05:08:11.536947 initrd-setup-root[922]: cut: /sysroot/etc/group: No such file or directory May 14 05:08:11.541456 initrd-setup-root[929]: cut: /sysroot/etc/shadow: No such file or directory May 14 05:08:11.545541 initrd-setup-root[936]: cut: /sysroot/etc/gshadow: No such file or directory May 14 05:08:11.626996 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 14 05:08:11.629118 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 14 05:08:11.630682 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 14 05:08:11.652753 kernel: BTRFS info (device vda6): last unmount of filesystem 27ac52bc-c86c-4e09-9b91-c3f9e8d3f2a0 May 14 05:08:11.664876 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 14 05:08:11.679011 ignition[1006]: INFO : Ignition 2.21.0 May 14 05:08:11.679011 ignition[1006]: INFO : Stage: mount May 14 05:08:11.680776 ignition[1006]: INFO : no configs at "/usr/lib/ignition/base.d" May 14 05:08:11.680776 ignition[1006]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 14 05:08:11.683255 ignition[1006]: INFO : mount: mount passed May 14 05:08:11.684036 ignition[1006]: INFO : Ignition finished successfully May 14 05:08:11.686038 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 14 05:08:11.688065 systemd[1]: Starting ignition-files.service - Ignition (files)... May 14 05:08:12.045773 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 14 05:08:12.047383 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 14 05:08:12.075429 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 (254:6) scanned by mount (1018) May 14 05:08:12.075455 kernel: BTRFS info (device vda6): first mount of filesystem 27ac52bc-c86c-4e09-9b91-c3f9e8d3f2a0 May 14 05:08:12.075466 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 14 05:08:12.076296 kernel: BTRFS info (device vda6): using free-space-tree May 14 05:08:12.080435 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 14 05:08:12.107921 ignition[1035]: INFO : Ignition 2.21.0 May 14 05:08:12.107921 ignition[1035]: INFO : Stage: files May 14 05:08:12.109883 ignition[1035]: INFO : no configs at "/usr/lib/ignition/base.d" May 14 05:08:12.109883 ignition[1035]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 14 05:08:12.109883 ignition[1035]: DEBUG : files: compiled without relabeling support, skipping May 14 05:08:12.109883 ignition[1035]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 14 05:08:12.109883 ignition[1035]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 14 05:08:12.116336 ignition[1035]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 14 05:08:12.116336 ignition[1035]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 14 05:08:12.116336 ignition[1035]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 14 05:08:12.112301 unknown[1035]: wrote ssh authorized keys file for user: core May 14 05:08:12.121904 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 14 05:08:12.121904 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 14 05:08:12.121904 ignition[1035]: INFO : files: op(4): [started] processing unit "docker.service" May 14 05:08:12.121904 ignition[1035]: INFO : files: op(4): [finished] processing unit "docker.service" May 14 05:08:12.121904 ignition[1035]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" May 14 05:08:12.121904 ignition[1035]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 14 05:08:12.131526 ignition[1035]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 14 05:08:12.131526 ignition[1035]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" May 14 05:08:12.131526 ignition[1035]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" May 14 05:08:12.142064 ignition[1035]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" May 14 05:08:12.145421 ignition[1035]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 14 05:08:12.147106 ignition[1035]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" May 14 05:08:12.147106 ignition[1035]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" May 14 05:08:12.147106 ignition[1035]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" May 14 05:08:12.147106 ignition[1035]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 14 05:08:12.147106 ignition[1035]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 14 05:08:12.147106 ignition[1035]: INFO : files: files passed May 14 05:08:12.147106 ignition[1035]: INFO : Ignition finished successfully May 14 05:08:12.152223 systemd[1]: Finished ignition-files.service - Ignition (files). May 14 05:08:12.154305 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 14 05:08:12.158066 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 14 05:08:12.170618 systemd[1]: ignition-quench.service: Deactivated successfully. May 14 05:08:12.170762 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 14 05:08:12.174048 initrd-setup-root-after-ignition[1065]: grep: /sysroot/oem/oem-release: No such file or directory May 14 05:08:12.177197 initrd-setup-root-after-ignition[1067]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 14 05:08:12.177197 initrd-setup-root-after-ignition[1067]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 14 05:08:12.180473 initrd-setup-root-after-ignition[1071]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 14 05:08:12.179663 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 14 05:08:12.181165 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 14 05:08:12.184189 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 14 05:08:12.226990 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 14 05:08:12.227126 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 14 05:08:12.228682 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 14 05:08:12.231039 systemd[1]: Reached target initrd.target - Initrd Default Target. May 14 05:08:12.231406 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 14 05:08:12.234338 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 14 05:08:12.250454 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 14 05:08:12.251915 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 14 05:08:12.270412 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 14 05:08:12.270763 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 14 05:08:12.272956 systemd[1]: Stopped target timers.target - Timer Units. May 14 05:08:12.273283 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 14 05:08:12.273390 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 14 05:08:12.277385 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 14 05:08:12.277728 systemd[1]: Stopped target basic.target - Basic System. May 14 05:08:12.278228 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 14 05:08:12.278559 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 14 05:08:12.279068 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 14 05:08:12.279396 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 14 05:08:12.279741 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 14 05:08:12.280241 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 14 05:08:12.280584 systemd[1]: Stopped target sysinit.target - System Initialization. May 14 05:08:12.281087 systemd[1]: Stopped target local-fs.target - Local File Systems. May 14 05:08:12.281414 systemd[1]: Stopped target swap.target - Swaps. May 14 05:08:12.281731 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 14 05:08:12.281834 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 14 05:08:12.282581 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 14 05:08:12.283101 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 14 05:08:12.283393 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 14 05:08:12.283484 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 14 05:08:12.283751 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 14 05:08:12.283852 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 14 05:08:12.284640 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 14 05:08:12.284752 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 14 05:08:12.311591 systemd[1]: Stopped target paths.target - Path Units. May 14 05:08:12.312004 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 14 05:08:12.317045 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 14 05:08:12.320909 systemd[1]: Stopped target slices.target - Slice Units. May 14 05:08:12.321255 systemd[1]: Stopped target sockets.target - Socket Units. May 14 05:08:12.323149 systemd[1]: iscsid.socket: Deactivated successfully. May 14 05:08:12.323254 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 14 05:08:12.324689 systemd[1]: iscsiuio.socket: Deactivated successfully. May 14 05:08:12.324792 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 14 05:08:12.326577 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 14 05:08:12.326698 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 14 05:08:12.328409 systemd[1]: ignition-files.service: Deactivated successfully. May 14 05:08:12.328509 systemd[1]: Stopped ignition-files.service - Ignition (files). May 14 05:08:12.331967 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 14 05:08:12.332849 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 14 05:08:12.335799 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 14 05:08:12.335914 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 14 05:08:12.337196 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 14 05:08:12.337299 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 14 05:08:12.343159 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 14 05:08:12.343267 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 14 05:08:12.360844 ignition[1091]: INFO : Ignition 2.21.0 May 14 05:08:12.360844 ignition[1091]: INFO : Stage: umount May 14 05:08:12.362610 ignition[1091]: INFO : no configs at "/usr/lib/ignition/base.d" May 14 05:08:12.362610 ignition[1091]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 14 05:08:12.362610 ignition[1091]: INFO : umount: umount passed May 14 05:08:12.362610 ignition[1091]: INFO : Ignition finished successfully May 14 05:08:12.365383 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 14 05:08:12.366024 systemd[1]: ignition-mount.service: Deactivated successfully. May 14 05:08:12.366148 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 14 05:08:12.369115 systemd[1]: sysroot-boot.service: Deactivated successfully. May 14 05:08:12.369225 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 14 05:08:12.370756 systemd[1]: Stopped target network.target - Network. May 14 05:08:12.372005 systemd[1]: ignition-disks.service: Deactivated successfully. May 14 05:08:12.372084 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 14 05:08:12.372354 systemd[1]: ignition-kargs.service: Deactivated successfully. May 14 05:08:12.372396 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 14 05:08:12.372675 systemd[1]: ignition-setup.service: Deactivated successfully. May 14 05:08:12.372739 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 14 05:08:12.373174 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 14 05:08:12.373213 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 14 05:08:12.373509 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 14 05:08:12.373559 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 14 05:08:12.374160 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 14 05:08:12.374442 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 14 05:08:12.385761 systemd[1]: systemd-resolved.service: Deactivated successfully. May 14 05:08:12.385890 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 14 05:08:12.389514 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 14 05:08:12.390158 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 14 05:08:12.390234 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 14 05:08:12.394227 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. May 14 05:08:12.409894 systemd[1]: systemd-networkd.service: Deactivated successfully. May 14 05:08:12.410020 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 14 05:08:12.412999 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 14 05:08:12.413461 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 14 05:08:12.413499 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 14 05:08:12.417140 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 14 05:08:12.417577 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 14 05:08:12.417621 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 14 05:08:12.418124 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 14 05:08:12.418165 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 14 05:08:12.423956 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 14 05:08:12.424000 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 14 05:08:12.424542 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 14 05:08:12.446956 systemd[1]: systemd-udevd.service: Deactivated successfully. May 14 05:08:12.447182 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 14 05:08:12.447961 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 14 05:08:12.448009 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 14 05:08:12.451152 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 14 05:08:12.451193 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 14 05:08:12.451457 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 14 05:08:12.451501 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 14 05:08:12.452310 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 14 05:08:12.452351 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 14 05:08:12.459548 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 14 05:08:12.459597 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 14 05:08:12.461190 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 14 05:08:12.463941 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 14 05:08:12.463989 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 14 05:08:12.467902 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 14 05:08:12.467947 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 14 05:08:12.471350 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 14 05:08:12.471395 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 14 05:08:12.474712 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 14 05:08:12.474767 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 14 05:08:12.475182 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 05:08:12.475222 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:12.480886 systemd[1]: network-cleanup.service: Deactivated successfully. May 14 05:08:12.480988 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 14 05:08:12.482242 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 14 05:08:12.482336 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 14 05:08:12.484710 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 14 05:08:12.486707 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 14 05:08:12.526765 systemd[1]: Switching root. May 14 05:08:12.569041 systemd-journald[220]: Journal stopped May 14 05:08:13.404284 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). May 14 05:08:13.404358 kernel: SELinux: policy capability network_peer_controls=1 May 14 05:08:13.404372 kernel: SELinux: policy capability open_perms=1 May 14 05:08:13.404383 kernel: SELinux: policy capability extended_socket_class=1 May 14 05:08:13.404398 kernel: SELinux: policy capability always_check_network=0 May 14 05:08:13.404409 kernel: SELinux: policy capability cgroup_seclabel=1 May 14 05:08:13.404424 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 14 05:08:13.404435 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 14 05:08:13.404446 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 14 05:08:13.404461 kernel: SELinux: policy capability userspace_initial_context=0 May 14 05:08:13.404472 kernel: audit: type=1403 audit(1747199292.664:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 14 05:08:13.404484 systemd[1]: Successfully loaded SELinux policy in 50.136ms. May 14 05:08:13.404510 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 12.126ms. May 14 05:08:13.404525 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 05:08:13.404537 systemd[1]: Detected virtualization kvm. May 14 05:08:13.404549 systemd[1]: Detected architecture x86-64. May 14 05:08:13.404563 systemd[1]: Detected first boot. May 14 05:08:13.404580 systemd[1]: Initializing machine ID from VM UUID. May 14 05:08:13.404593 zram_generator::config[1137]: No configuration found. May 14 05:08:13.404606 kernel: Guest personality initialized and is inactive May 14 05:08:13.404617 kernel: VMCI host device registered (name=vmci, major=10, minor=125) May 14 05:08:13.404628 kernel: Initialized host personality May 14 05:08:13.404639 kernel: NET: Registered PF_VSOCK protocol family May 14 05:08:13.404650 systemd[1]: Populated /etc with preset unit settings. May 14 05:08:13.404662 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 14 05:08:13.404675 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 14 05:08:13.404687 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 14 05:08:13.404701 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 14 05:08:13.404713 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 14 05:08:13.404738 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 14 05:08:13.404750 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 14 05:08:13.404761 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 14 05:08:13.404773 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 14 05:08:13.404785 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 14 05:08:13.404797 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 14 05:08:13.404811 systemd[1]: Created slice user.slice - User and Session Slice. May 14 05:08:13.404823 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 14 05:08:13.404835 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 14 05:08:13.404846 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 14 05:08:13.404858 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 14 05:08:13.404870 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 14 05:08:13.404882 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 14 05:08:13.404894 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 14 05:08:13.404908 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 14 05:08:13.404920 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 14 05:08:13.404931 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 14 05:08:13.404945 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 14 05:08:13.404957 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 14 05:08:13.404968 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 14 05:08:13.404980 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 14 05:08:13.404992 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 14 05:08:13.405004 systemd[1]: Reached target slices.target - Slice Units. May 14 05:08:13.405017 systemd[1]: Reached target swap.target - Swaps. May 14 05:08:13.405035 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 14 05:08:13.405047 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 14 05:08:13.405059 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 14 05:08:13.405076 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 14 05:08:13.405087 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 14 05:08:13.405099 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 14 05:08:13.405111 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 14 05:08:13.405123 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 14 05:08:13.405136 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 14 05:08:13.405148 systemd[1]: Mounting media.mount - External Media Directory... May 14 05:08:13.405160 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 05:08:13.405172 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 14 05:08:13.405184 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 14 05:08:13.405195 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 14 05:08:13.405209 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 05:08:13.405221 systemd[1]: Reached target machines.target - Containers. May 14 05:08:13.405234 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 14 05:08:13.405247 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 14 05:08:13.405259 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 14 05:08:13.405270 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 14 05:08:13.405282 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 14 05:08:13.405294 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 14 05:08:13.405305 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 14 05:08:13.405317 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 14 05:08:13.405328 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 14 05:08:13.405343 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 14 05:08:13.405355 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 14 05:08:13.405366 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 14 05:08:13.405378 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 14 05:08:13.405389 systemd[1]: Stopped systemd-fsck-usr.service. May 14 05:08:13.405402 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 05:08:13.405414 systemd[1]: Starting systemd-journald.service - Journal Service... May 14 05:08:13.405425 kernel: fuse: init (API version 7.41) May 14 05:08:13.405438 kernel: loop: module loaded May 14 05:08:13.405450 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 14 05:08:13.405463 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 14 05:08:13.405475 kernel: ACPI: bus type drm_connector registered May 14 05:08:13.405504 systemd-journald[1208]: Collecting audit messages is disabled. May 14 05:08:13.405528 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 14 05:08:13.405540 systemd-journald[1208]: Journal started May 14 05:08:13.405564 systemd-journald[1208]: Runtime Journal (/run/log/journal/17108b09879b461fbab9893825484667) is 6M, max 48.5M, 42.4M free. May 14 05:08:13.169533 systemd[1]: Queued start job for default target multi-user.target. May 14 05:08:13.190564 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 14 05:08:13.191013 systemd[1]: systemd-journald.service: Deactivated successfully. May 14 05:08:13.409003 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 14 05:08:13.413443 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 14 05:08:13.413480 systemd[1]: verity-setup.service: Deactivated successfully. May 14 05:08:13.413497 systemd[1]: Stopped verity-setup.service. May 14 05:08:13.417760 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 05:08:13.420745 systemd[1]: Started systemd-journald.service - Journal Service. May 14 05:08:13.422126 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 14 05:08:13.423372 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 14 05:08:13.424772 systemd[1]: Mounted media.mount - External Media Directory. May 14 05:08:13.425862 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 14 05:08:13.427073 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 14 05:08:13.429116 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 14 05:08:13.430521 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 14 05:08:13.432077 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 14 05:08:13.433649 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 14 05:08:13.433906 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 14 05:08:13.435431 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 14 05:08:13.435638 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 14 05:08:13.437260 systemd[1]: modprobe@drm.service: Deactivated successfully. May 14 05:08:13.437467 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 14 05:08:13.439040 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 14 05:08:13.439246 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 14 05:08:13.440783 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 14 05:08:13.440990 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 14 05:08:13.442433 systemd[1]: modprobe@loop.service: Deactivated successfully. May 14 05:08:13.442644 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 14 05:08:13.444068 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 14 05:08:13.445494 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 14 05:08:13.447064 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 14 05:08:13.448605 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 14 05:08:13.464132 systemd[1]: Reached target network-pre.target - Preparation for Network. May 14 05:08:13.466699 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 14 05:08:13.469835 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 14 05:08:13.471074 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 14 05:08:13.471115 systemd[1]: Reached target local-fs.target - Local File Systems. May 14 05:08:13.473183 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 14 05:08:13.482979 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 14 05:08:13.484159 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 14 05:08:13.486350 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 14 05:08:13.489532 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 14 05:08:13.491823 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 14 05:08:13.492706 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 14 05:08:13.494816 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 14 05:08:13.495796 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 14 05:08:13.499785 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 14 05:08:13.508512 systemd-journald[1208]: Time spent on flushing to /var/log/journal/17108b09879b461fbab9893825484667 is 30.901ms for 1033 entries. May 14 05:08:13.508512 systemd-journald[1208]: System Journal (/var/log/journal/17108b09879b461fbab9893825484667) is 8M, max 195.6M, 187.6M free. May 14 05:08:13.547439 systemd-journald[1208]: Received client request to flush runtime journal. May 14 05:08:13.547489 kernel: loop0: detected capacity change from 0 to 113872 May 14 05:08:13.502969 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 14 05:08:13.505422 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 14 05:08:13.506855 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 14 05:08:13.513104 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 14 05:08:13.515259 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 14 05:08:13.520520 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 14 05:08:13.528005 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 14 05:08:13.540577 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 14 05:08:13.550802 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 14 05:08:13.552965 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 14 05:08:13.556427 systemd-tmpfiles[1257]: ACLs are not supported, ignoring. May 14 05:08:13.556442 systemd-tmpfiles[1257]: ACLs are not supported, ignoring. May 14 05:08:13.563225 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 14 05:08:13.566922 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 14 05:08:13.576971 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 14 05:08:13.579766 kernel: loop1: detected capacity change from 0 to 146240 May 14 05:08:13.605871 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 14 05:08:13.609326 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 14 05:08:13.610038 kernel: loop2: detected capacity change from 0 to 113872 May 14 05:08:13.618770 kernel: loop3: detected capacity change from 0 to 146240 May 14 05:08:13.633268 (sd-merge)[1277]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 14 05:08:13.633757 (sd-merge)[1277]: Merged extensions into '/usr'. May 14 05:08:13.636379 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 14 05:08:13.642211 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. May 14 05:08:13.642427 systemd[1]: Starting ensure-sysext.service... May 14 05:08:13.642607 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. May 14 05:08:13.644793 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 14 05:08:13.648196 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 14 05:08:13.661290 systemd[1]: Reload requested from client PID 1281 ('systemctl') (unit ensure-sysext.service)... May 14 05:08:13.661306 systemd[1]: Reloading... May 14 05:08:13.669613 systemd-tmpfiles[1282]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 14 05:08:13.669656 systemd-tmpfiles[1282]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 14 05:08:13.670400 systemd-tmpfiles[1282]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 14 05:08:13.670592 systemd-tmpfiles[1282]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 14 05:08:13.671565 systemd-tmpfiles[1282]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 14 05:08:13.671911 systemd-tmpfiles[1282]: ACLs are not supported, ignoring. May 14 05:08:13.672125 systemd-tmpfiles[1282]: ACLs are not supported, ignoring. May 14 05:08:13.678089 systemd-tmpfiles[1282]: Detected autofs mount point /boot during canonicalization of boot. May 14 05:08:13.678106 systemd-tmpfiles[1282]: Skipping /boot May 14 05:08:13.690601 systemd-tmpfiles[1282]: Detected autofs mount point /boot during canonicalization of boot. May 14 05:08:13.690700 systemd-tmpfiles[1282]: Skipping /boot May 14 05:08:13.726745 zram_generator::config[1311]: No configuration found. May 14 05:08:13.829089 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 05:08:13.841910 ldconfig[1251]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 14 05:08:13.908753 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 14 05:08:13.909191 systemd[1]: Reloading finished in 247 ms. May 14 05:08:13.940417 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 14 05:08:13.960066 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 14 05:08:13.968937 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 14 05:08:13.971409 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 14 05:08:13.979340 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 14 05:08:13.983895 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 14 05:08:13.986034 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 14 05:08:13.990486 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 14 05:08:13.994044 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 14 05:08:13.997935 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 14 05:08:14.000652 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 14 05:08:14.002945 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 14 05:08:14.003058 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 05:08:14.010935 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 14 05:08:14.013371 systemd[1]: modprobe@loop.service: Deactivated successfully. May 14 05:08:14.013621 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 14 05:08:14.015734 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 14 05:08:14.015983 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 14 05:08:14.017797 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 14 05:08:14.017999 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 14 05:08:14.022046 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 14 05:08:14.029598 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 14 05:08:14.030982 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 14 05:08:14.033361 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 14 05:08:14.039864 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 14 05:08:14.043000 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 14 05:08:14.044631 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 14 05:08:14.044768 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 05:08:14.047127 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 14 05:08:14.049416 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 14 05:08:14.049631 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 14 05:08:14.051330 systemd[1]: modprobe@drm.service: Deactivated successfully. May 14 05:08:14.051526 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 14 05:08:14.053246 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 14 05:08:14.053450 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 14 05:08:14.059029 systemd[1]: modprobe@loop.service: Deactivated successfully. May 14 05:08:14.059357 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 14 05:08:14.061293 systemd[1]: Finished ensure-sysext.service. May 14 05:08:14.068360 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 14 05:08:14.068489 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 14 05:08:14.069037 augenrules[1392]: No rules May 14 05:08:14.071885 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 14 05:08:14.073617 systemd[1]: audit-rules.service: Deactivated successfully. May 14 05:08:14.074628 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 14 05:08:14.080651 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 14 05:08:14.082251 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 14 05:08:14.086014 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 14 05:08:14.088314 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 14 05:08:14.089429 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 05:08:14.096120 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 14 05:08:14.111590 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 14 05:08:14.130672 systemd-udevd[1401]: Using default interface naming scheme 'v255'. May 14 05:08:14.148680 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 14 05:08:14.157143 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 14 05:08:14.180469 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 14 05:08:14.183142 systemd[1]: Reached target time-set.target - System Time Set. May 14 05:08:14.186559 systemd-resolved[1353]: Positive Trust Anchors: May 14 05:08:14.186894 systemd-resolved[1353]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 14 05:08:14.186929 systemd-resolved[1353]: 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 05:08:14.191026 systemd-resolved[1353]: Defaulting to hostname 'linux'. May 14 05:08:14.193029 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 14 05:08:14.194294 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 14 05:08:14.195800 systemd[1]: Reached target sysinit.target - System Initialization. May 14 05:08:14.196964 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 14 05:08:14.198223 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 05:08:14.199504 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. May 14 05:08:14.201211 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 14 05:08:14.202480 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 14 05:08:14.203788 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 14 05:08:14.205281 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 14 05:08:14.205309 systemd[1]: Reached target paths.target - Path Units. May 14 05:08:14.206275 systemd[1]: Reached target timers.target - Timer Units. May 14 05:08:14.209512 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 14 05:08:14.212289 systemd[1]: Starting docker.socket - Docker Socket for the API... May 14 05:08:14.218159 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 14 05:08:14.219596 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 14 05:08:14.221045 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 14 05:08:14.225290 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 14 05:08:14.226707 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 14 05:08:14.228147 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 05:08:14.228284 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 05:08:14.233658 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 14 05:08:14.237636 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 14 05:08:14.237824 systemd[1]: Reached target sockets.target - Socket Units. May 14 05:08:14.239788 systemd[1]: Reached target basic.target - Basic System. May 14 05:08:14.240883 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 14 05:08:14.240907 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 14 05:08:14.242351 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 14 05:08:14.245909 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 14 05:08:14.248855 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 14 05:08:14.251181 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 14 05:08:14.252835 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 05:08:14.254884 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... May 14 05:08:14.261018 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 14 05:08:14.265891 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 14 05:08:14.269989 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 14 05:08:14.278318 jq[1449]: false May 14 05:08:14.281834 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Refreshing passwd entry cache May 14 05:08:14.280193 oslogin_cache_refresh[1452]: Refreshing passwd entry cache May 14 05:08:14.282479 systemd[1]: Starting systemd-logind.service - User Login Management... May 14 05:08:14.284579 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 14 05:08:14.285183 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 14 05:08:14.285912 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Failure getting users, quitting May 14 05:08:14.286098 systemd[1]: Starting update-engine.service - Update Engine... May 14 05:08:14.288347 extend-filesystems[1451]: Found loop2 May 14 05:08:14.288520 oslogin_cache_refresh[1452]: Failure getting users, quitting May 14 05:08:14.288686 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 14 05:08:14.289222 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 14 05:08:14.289222 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Refreshing group entry cache May 14 05:08:14.288538 oslogin_cache_refresh[1452]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 14 05:08:14.288575 oslogin_cache_refresh[1452]: Refreshing group entry cache May 14 05:08:14.291054 extend-filesystems[1451]: Found loop3 May 14 05:08:14.291054 extend-filesystems[1451]: Found sr0 May 14 05:08:14.291054 extend-filesystems[1451]: Found vda May 14 05:08:14.291054 extend-filesystems[1451]: Found vda1 May 14 05:08:14.291054 extend-filesystems[1451]: Found vda2 May 14 05:08:14.291054 extend-filesystems[1451]: Found vda3 May 14 05:08:14.291054 extend-filesystems[1451]: Found usr May 14 05:08:14.291054 extend-filesystems[1451]: Found vda4 May 14 05:08:14.291054 extend-filesystems[1451]: Found vda6 May 14 05:08:14.291054 extend-filesystems[1451]: Found vda7 May 14 05:08:14.291054 extend-filesystems[1451]: Found vda9 May 14 05:08:14.291054 extend-filesystems[1451]: Checking size of /dev/vda9 May 14 05:08:14.294551 oslogin_cache_refresh[1452]: Failure getting groups, quitting May 14 05:08:14.291265 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 14 05:08:14.307383 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Failure getting groups, quitting May 14 05:08:14.307383 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 14 05:08:14.294560 oslogin_cache_refresh[1452]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 14 05:08:14.294137 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 14 05:08:14.294362 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 14 05:08:14.294920 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 14 05:08:14.295163 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 14 05:08:14.296883 systemd[1]: google-oslogin-cache.service: Deactivated successfully. May 14 05:08:14.297119 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. May 14 05:08:14.309937 jq[1466]: true May 14 05:08:14.321483 extend-filesystems[1451]: Old size kept for /dev/vda9 May 14 05:08:14.321956 systemd[1]: extend-filesystems.service: Deactivated successfully. May 14 05:08:14.322235 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 14 05:08:14.325215 systemd[1]: motdgen.service: Deactivated successfully. May 14 05:08:14.329224 update_engine[1465]: I20250514 05:08:14.328833 1465 main.cc:92] Flatcar Update Engine starting May 14 05:08:14.329495 jq[1475]: true May 14 05:08:14.325467 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 14 05:08:14.342591 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 14 05:08:14.348009 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 14 05:08:14.357687 dbus-daemon[1447]: [system] SELinux support is enabled May 14 05:08:14.359699 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 14 05:08:14.366165 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 05:08:14.366210 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 14 05:08:14.369924 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 May 14 05:08:14.368677 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 05:08:14.368695 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 14 05:08:14.378581 systemd[1]: Started update-engine.service - Update Engine. May 14 05:08:14.379835 update_engine[1465]: I20250514 05:08:14.379685 1465 update_check_scheduler.cc:74] Next update check in 3m26s May 14 05:08:14.382027 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 14 05:08:14.385739 kernel: mousedev: PS/2 mouse device common for all mice May 14 05:08:14.393173 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 14 05:08:14.393744 kernel: ACPI: button: Power Button [PWRF] May 14 05:08:14.402095 bash[1501]: Updated "/home/core/.ssh/authorized_keys" May 14 05:08:14.403055 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 14 05:08:14.408270 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 14 05:08:14.424247 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device May 14 05:08:14.429208 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt May 14 05:08:14.429368 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD May 14 05:08:14.452660 systemd-networkd[1418]: lo: Link UP May 14 05:08:14.452668 systemd-networkd[1418]: lo: Gained carrier May 14 05:08:14.457435 systemd-networkd[1418]: Enumeration completed May 14 05:08:14.457854 systemd-networkd[1418]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 05:08:14.457858 systemd-networkd[1418]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 14 05:08:14.458961 systemd[1]: Started systemd-networkd.service - Network Configuration. May 14 05:08:14.460436 systemd[1]: Reached target network.target - Network. May 14 05:08:14.465782 systemd[1]: Starting containerd.service - containerd container runtime... May 14 05:08:14.468028 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 14 05:08:14.476959 locksmithd[1503]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 14 05:08:14.477460 systemd-networkd[1418]: eth0: Link UP May 14 05:08:14.477649 systemd-networkd[1418]: eth0: Gained carrier May 14 05:08:14.477668 systemd-networkd[1418]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 05:08:14.477891 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 14 05:08:14.532916 systemd-networkd[1418]: eth0: DHCPv4 address 10.0.0.69/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 14 05:08:14.534188 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. May 14 05:08:14.535895 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 14 05:08:16.121218 systemd-timesyncd[1397]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 14 05:08:16.121318 systemd-timesyncd[1397]: Initial clock synchronization to Wed 2025-05-14 05:08:16.120933 UTC. May 14 05:08:16.122654 systemd-resolved[1353]: Clock change detected. Flushing caches. May 14 05:08:16.149800 (ntainerd)[1528]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 14 05:08:16.156816 systemd-logind[1464]: New seat seat0. May 14 05:08:16.157943 systemd[1]: Started systemd-logind.service - User Login Management. May 14 05:08:16.169064 kernel: kvm_amd: TSC scaling supported May 14 05:08:16.169096 kernel: kvm_amd: Nested Virtualization enabled May 14 05:08:16.169109 kernel: kvm_amd: Nested Paging enabled May 14 05:08:16.169121 kernel: kvm_amd: LBR virtualization supported May 14 05:08:16.169959 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported May 14 05:08:16.169990 kernel: kvm_amd: Virtual GIF supported May 14 05:08:16.171481 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:16.187767 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 05:08:16.188025 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:16.191906 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 05:08:16.197163 systemd-logind[1464]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) May 14 05:08:16.211036 systemd-logind[1464]: Watching system buttons on /dev/input/event2 (Power Button) May 14 05:08:16.255404 sshd_keygen[1486]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 14 05:08:16.273277 kernel: EDAC MC: Ver: 3.0.0 May 14 05:08:16.300578 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 14 05:08:16.311393 systemd[1]: Starting issuegen.service - Generate /run/issue... May 14 05:08:16.314422 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 14 05:08:16.332404 systemd[1]: issuegen.service: Deactivated successfully. May 14 05:08:16.332680 systemd[1]: Finished issuegen.service - Generate /run/issue. May 14 05:08:16.335547 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 14 05:08:16.358570 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 14 05:08:16.361289 systemd[1]: Started getty@tty1.service - Getty on tty1. May 14 05:08:16.363297 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 14 05:08:16.364635 systemd[1]: Reached target getty.target - Login Prompts. May 14 05:08:16.384298 containerd[1528]: time="2025-05-14T05:08:16Z" 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 05:08:16.385723 containerd[1528]: time="2025-05-14T05:08:16.385674666Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 14 05:08:16.394216 containerd[1528]: time="2025-05-14T05:08:16.394171363Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.262µs" May 14 05:08:16.394216 containerd[1528]: time="2025-05-14T05:08:16.394198765Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 14 05:08:16.394216 containerd[1528]: time="2025-05-14T05:08:16.394216909Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 14 05:08:16.394394 containerd[1528]: time="2025-05-14T05:08:16.394363744Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 14 05:08:16.394394 containerd[1528]: time="2025-05-14T05:08:16.394382850Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 14 05:08:16.394450 containerd[1528]: time="2025-05-14T05:08:16.394406515Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 14 05:08:16.394487 containerd[1528]: time="2025-05-14T05:08:16.394468972Z" 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 05:08:16.394487 containerd[1528]: time="2025-05-14T05:08:16.394481275Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 14 05:08:16.394721 containerd[1528]: time="2025-05-14T05:08:16.394687792Z" 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 05:08:16.394721 containerd[1528]: time="2025-05-14T05:08:16.394706848Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 14 05:08:16.394721 containerd[1528]: time="2025-05-14T05:08:16.394718019Z" 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 05:08:16.394783 containerd[1528]: time="2025-05-14T05:08:16.394726785Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 14 05:08:16.394834 containerd[1528]: time="2025-05-14T05:08:16.394811144Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 14 05:08:16.395088 containerd[1528]: time="2025-05-14T05:08:16.395056003Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 14 05:08:16.395113 containerd[1528]: time="2025-05-14T05:08:16.395091028Z" 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 05:08:16.395113 containerd[1528]: time="2025-05-14T05:08:16.395101588Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 14 05:08:16.395163 containerd[1528]: time="2025-05-14T05:08:16.395143246Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 14 05:08:16.395387 containerd[1528]: time="2025-05-14T05:08:16.395355645Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 14 05:08:16.395448 containerd[1528]: time="2025-05-14T05:08:16.395422049Z" level=info msg="metadata content store policy set" policy=shared May 14 05:08:16.400512 containerd[1528]: time="2025-05-14T05:08:16.400468024Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 14 05:08:16.400541 containerd[1528]: time="2025-05-14T05:08:16.400515082Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 14 05:08:16.400541 containerd[1528]: time="2025-05-14T05:08:16.400529770Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 14 05:08:16.400576 containerd[1528]: time="2025-05-14T05:08:16.400541302Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 14 05:08:16.400576 containerd[1528]: time="2025-05-14T05:08:16.400572260Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 14 05:08:16.400613 containerd[1528]: time="2025-05-14T05:08:16.400582980Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 14 05:08:16.400613 containerd[1528]: time="2025-05-14T05:08:16.400598218Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 14 05:08:16.400613 containerd[1528]: time="2025-05-14T05:08:16.400610592Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 14 05:08:16.400675 containerd[1528]: time="2025-05-14T05:08:16.400622173Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 14 05:08:16.400675 containerd[1528]: time="2025-05-14T05:08:16.400634266Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 14 05:08:16.400675 containerd[1528]: time="2025-05-14T05:08:16.400645697Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 14 05:08:16.400675 containerd[1528]: time="2025-05-14T05:08:16.400658221Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 14 05:08:16.400804 containerd[1528]: time="2025-05-14T05:08:16.400770341Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 14 05:08:16.400804 containerd[1528]: time="2025-05-14T05:08:16.400794266Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 14 05:08:16.400848 containerd[1528]: time="2025-05-14T05:08:16.400812260Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 14 05:08:16.400848 containerd[1528]: time="2025-05-14T05:08:16.400822709Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 14 05:08:16.400848 containerd[1528]: time="2025-05-14T05:08:16.400834702Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 14 05:08:16.400848 containerd[1528]: time="2025-05-14T05:08:16.400847646Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 14 05:08:16.400946 containerd[1528]: time="2025-05-14T05:08:16.400877893Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 14 05:08:16.400946 containerd[1528]: time="2025-05-14T05:08:16.400888864Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 14 05:08:16.400946 containerd[1528]: time="2025-05-14T05:08:16.400900095Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 14 05:08:16.400946 containerd[1528]: time="2025-05-14T05:08:16.400910765Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 14 05:08:16.400946 containerd[1528]: time="2025-05-14T05:08:16.400921495Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 14 05:08:16.401043 containerd[1528]: time="2025-05-14T05:08:16.400975727Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 14 05:08:16.401043 containerd[1528]: time="2025-05-14T05:08:16.400997427Z" level=info msg="Start snapshots syncer" May 14 05:08:16.401043 containerd[1528]: time="2025-05-14T05:08:16.401032513Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 14 05:08:16.401313 containerd[1528]: time="2025-05-14T05:08:16.401262434Z" 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 05:08:16.401412 containerd[1528]: time="2025-05-14T05:08:16.401312709Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 14 05:08:16.402049 containerd[1528]: time="2025-05-14T05:08:16.402011680Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 14 05:08:16.402159 containerd[1528]: time="2025-05-14T05:08:16.402118400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 14 05:08:16.402159 containerd[1528]: time="2025-05-14T05:08:16.402150470Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 14 05:08:16.402198 containerd[1528]: time="2025-05-14T05:08:16.402160609Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 14 05:08:16.402198 containerd[1528]: time="2025-05-14T05:08:16.402171319Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 14 05:08:16.402198 containerd[1528]: time="2025-05-14T05:08:16.402181408Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 14 05:08:16.402198 containerd[1528]: time="2025-05-14T05:08:16.402191888Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 14 05:08:16.402278 containerd[1528]: time="2025-05-14T05:08:16.402213759Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 14 05:08:16.402278 containerd[1528]: time="2025-05-14T05:08:16.402240629Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 14 05:08:16.402278 containerd[1528]: time="2025-05-14T05:08:16.402251089Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 14 05:08:16.402278 containerd[1528]: time="2025-05-14T05:08:16.402260767Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 14 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402286706Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 14 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402299960Z" 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 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402308326Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 14 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402317503Z" 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 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402325128Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 14 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402333704Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 14 05:08:16.402355 containerd[1528]: time="2025-05-14T05:08:16.402346989Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 14 05:08:16.402481 containerd[1528]: time="2025-05-14T05:08:16.402362928Z" level=info msg="runtime interface created" May 14 05:08:16.402481 containerd[1528]: time="2025-05-14T05:08:16.402369651Z" level=info msg="created NRI interface" May 14 05:08:16.402481 containerd[1528]: time="2025-05-14T05:08:16.402381363Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 14 05:08:16.402481 containerd[1528]: time="2025-05-14T05:08:16.402391222Z" level=info msg="Connect containerd service" May 14 05:08:16.402481 containerd[1528]: time="2025-05-14T05:08:16.402412532Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 14 05:08:16.403190 containerd[1528]: time="2025-05-14T05:08:16.403158170Z" 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 05:08:16.489360 containerd[1528]: time="2025-05-14T05:08:16.489157009Z" level=info msg="Start subscribing containerd event" May 14 05:08:16.489360 containerd[1528]: time="2025-05-14T05:08:16.489222322Z" level=info msg="Start recovering state" May 14 05:08:16.489360 containerd[1528]: time="2025-05-14T05:08:16.489348789Z" level=info msg="Start event monitor" May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489367955Z" level=info msg="Start cni network conf syncer for default" May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489375960Z" level=info msg="Start streaming server" May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489397390Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489405305Z" level=info msg="runtime interface starting up..." May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489411006Z" level=info msg="starting plugins..." May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489425613Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 14 05:08:16.489484 containerd[1528]: time="2025-05-14T05:08:16.489441022Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 14 05:08:16.489615 containerd[1528]: time="2025-05-14T05:08:16.489519890Z" level=info msg=serving... address=/run/containerd/containerd.sock May 14 05:08:16.489615 containerd[1528]: time="2025-05-14T05:08:16.489601934Z" level=info msg="containerd successfully booted in 0.105866s" May 14 05:08:16.489753 systemd[1]: Started containerd.service - containerd container runtime. May 14 05:08:17.396086 systemd-networkd[1418]: eth0: Gained IPv6LL May 14 05:08:17.399652 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 14 05:08:17.401418 systemd[1]: Reached target network-online.target - Network is Online. May 14 05:08:17.404003 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 14 05:08:17.406025 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 14 05:08:17.449145 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 14 05:08:17.450779 systemd[1]: coreos-metadata.service: Deactivated successfully. May 14 05:08:17.451057 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 14 05:08:17.453304 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 14 05:08:17.453550 systemd[1]: Reached target multi-user.target - Multi-User System. May 14 05:08:17.454827 systemd[1]: Startup finished in 2.835s (kernel) + 4.012s (initrd) + 3.255s (userspace) = 10.103s. May 14 05:08:23.764786 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 14 05:08:23.765945 systemd[1]: Started sshd@0-10.0.0.69:22-10.0.0.1:60122.service - OpenSSH per-connection server daemon (10.0.0.1:60122). May 14 05:08:23.832209 sshd[1603]: Accepted publickey for core from 10.0.0.1 port 60122 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:23.834115 sshd-session[1603]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:23.840242 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 14 05:08:23.841408 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 14 05:08:23.847971 systemd-logind[1464]: New session 1 of user core. May 14 05:08:23.869735 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 14 05:08:23.872660 systemd[1]: Starting user@500.service - User Manager for UID 500... May 14 05:08:23.890277 (systemd)[1607]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 14 05:08:23.892565 systemd-logind[1464]: New session c1 of user core. May 14 05:08:24.031639 systemd[1607]: Queued start job for default target default.target. May 14 05:08:24.041034 systemd[1607]: Created slice app.slice - User Application Slice. May 14 05:08:24.041060 systemd[1607]: Reached target paths.target - Paths. May 14 05:08:24.041097 systemd[1607]: Reached target timers.target - Timers. May 14 05:08:24.042468 systemd[1607]: Starting dbus.socket - D-Bus User Message Bus Socket... May 14 05:08:24.053129 systemd[1607]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 14 05:08:24.053247 systemd[1607]: Reached target sockets.target - Sockets. May 14 05:08:24.053286 systemd[1607]: Reached target basic.target - Basic System. May 14 05:08:24.053324 systemd[1607]: Reached target default.target - Main User Target. May 14 05:08:24.053353 systemd[1607]: Startup finished in 155ms. May 14 05:08:24.053672 systemd[1]: Started user@500.service - User Manager for UID 500. May 14 05:08:24.055293 systemd[1]: Started session-1.scope - Session 1 of User core. May 14 05:08:24.119683 systemd[1]: Started sshd@1-10.0.0.69:22-10.0.0.1:60124.service - OpenSSH per-connection server daemon (10.0.0.1:60124). May 14 05:08:24.164634 sshd[1618]: Accepted publickey for core from 10.0.0.1 port 60124 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:24.166014 sshd-session[1618]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:24.170263 systemd-logind[1464]: New session 2 of user core. May 14 05:08:24.183994 systemd[1]: Started session-2.scope - Session 2 of User core. May 14 05:08:24.236061 sshd[1620]: Connection closed by 10.0.0.1 port 60124 May 14 05:08:24.236386 sshd-session[1618]: pam_unix(sshd:session): session closed for user core May 14 05:08:24.244336 systemd[1]: sshd@1-10.0.0.69:22-10.0.0.1:60124.service: Deactivated successfully. May 14 05:08:24.246105 systemd[1]: session-2.scope: Deactivated successfully. May 14 05:08:24.246776 systemd-logind[1464]: Session 2 logged out. Waiting for processes to exit. May 14 05:08:24.249648 systemd[1]: Started sshd@2-10.0.0.69:22-10.0.0.1:60134.service - OpenSSH per-connection server daemon (10.0.0.1:60134). May 14 05:08:24.250264 systemd-logind[1464]: Removed session 2. May 14 05:08:24.297316 sshd[1626]: Accepted publickey for core from 10.0.0.1 port 60134 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:24.298465 sshd-session[1626]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:24.302353 systemd-logind[1464]: New session 3 of user core. May 14 05:08:24.315981 systemd[1]: Started session-3.scope - Session 3 of User core. May 14 05:08:24.364272 sshd[1629]: Connection closed by 10.0.0.1 port 60134 May 14 05:08:24.364577 sshd-session[1626]: pam_unix(sshd:session): session closed for user core May 14 05:08:24.375174 systemd[1]: sshd@2-10.0.0.69:22-10.0.0.1:60134.service: Deactivated successfully. May 14 05:08:24.376837 systemd[1]: session-3.scope: Deactivated successfully. May 14 05:08:24.377592 systemd-logind[1464]: Session 3 logged out. Waiting for processes to exit. May 14 05:08:24.380379 systemd[1]: Started sshd@3-10.0.0.69:22-10.0.0.1:60146.service - OpenSSH per-connection server daemon (10.0.0.1:60146). May 14 05:08:24.380879 systemd-logind[1464]: Removed session 3. May 14 05:08:24.432726 sshd[1635]: Accepted publickey for core from 10.0.0.1 port 60146 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:24.434115 sshd-session[1635]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:24.437790 systemd-logind[1464]: New session 4 of user core. May 14 05:08:24.448969 systemd[1]: Started session-4.scope - Session 4 of User core. May 14 05:08:24.501165 sshd[1637]: Connection closed by 10.0.0.1 port 60146 May 14 05:08:24.501465 sshd-session[1635]: pam_unix(sshd:session): session closed for user core May 14 05:08:24.509201 systemd[1]: sshd@3-10.0.0.69:22-10.0.0.1:60146.service: Deactivated successfully. May 14 05:08:24.510814 systemd[1]: session-4.scope: Deactivated successfully. May 14 05:08:24.511466 systemd-logind[1464]: Session 4 logged out. Waiting for processes to exit. May 14 05:08:24.514384 systemd[1]: Started sshd@4-10.0.0.69:22-10.0.0.1:60148.service - OpenSSH per-connection server daemon (10.0.0.1:60148). May 14 05:08:24.514937 systemd-logind[1464]: Removed session 4. May 14 05:08:24.560871 sshd[1643]: Accepted publickey for core from 10.0.0.1 port 60148 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:24.562150 sshd-session[1643]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:24.566281 systemd-logind[1464]: New session 5 of user core. May 14 05:08:24.582984 systemd[1]: Started session-5.scope - Session 5 of User core. May 14 05:08:24.639705 sudo[1646]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 14 05:08:24.640030 sudo[1646]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 05:08:24.659965 sudo[1646]: pam_unix(sudo:session): session closed for user root May 14 05:08:24.661679 sshd[1645]: Connection closed by 10.0.0.1 port 60148 May 14 05:08:24.661978 sshd-session[1643]: pam_unix(sshd:session): session closed for user core May 14 05:08:24.673394 systemd[1]: sshd@4-10.0.0.69:22-10.0.0.1:60148.service: Deactivated successfully. May 14 05:08:24.675128 systemd[1]: session-5.scope: Deactivated successfully. May 14 05:08:24.675770 systemd-logind[1464]: Session 5 logged out. Waiting for processes to exit. May 14 05:08:24.678648 systemd[1]: Started sshd@5-10.0.0.69:22-10.0.0.1:60152.service - OpenSSH per-connection server daemon (10.0.0.1:60152). May 14 05:08:24.679312 systemd-logind[1464]: Removed session 5. May 14 05:08:24.736454 sshd[1652]: Accepted publickey for core from 10.0.0.1 port 60152 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:24.737757 sshd-session[1652]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:24.741728 systemd-logind[1464]: New session 6 of user core. May 14 05:08:24.753997 systemd[1]: Started session-6.scope - Session 6 of User core. May 14 05:08:24.806610 sudo[1656]: 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 05:08:24.806937 sudo[1656]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 05:08:24.812895 sudo[1656]: pam_unix(sudo:session): session closed for user root May 14 05:08:24.818921 sudo[1655]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 14 05:08:24.819224 sudo[1655]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 05:08:24.828585 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 14 05:08:24.876266 augenrules[1678]: No rules May 14 05:08:24.877954 systemd[1]: audit-rules.service: Deactivated successfully. May 14 05:08:24.878213 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 14 05:08:24.879274 sudo[1655]: pam_unix(sudo:session): session closed for user root May 14 05:08:24.880787 sshd[1654]: Connection closed by 10.0.0.1 port 60152 May 14 05:08:24.881094 sshd-session[1652]: pam_unix(sshd:session): session closed for user core May 14 05:08:24.894424 systemd[1]: sshd@5-10.0.0.69:22-10.0.0.1:60152.service: Deactivated successfully. May 14 05:08:24.896183 systemd[1]: session-6.scope: Deactivated successfully. May 14 05:08:24.896870 systemd-logind[1464]: Session 6 logged out. Waiting for processes to exit. May 14 05:08:24.899641 systemd[1]: Started sshd@6-10.0.0.69:22-10.0.0.1:60162.service - OpenSSH per-connection server daemon (10.0.0.1:60162). May 14 05:08:24.900393 systemd-logind[1464]: Removed session 6. May 14 05:08:24.960073 sshd[1687]: Accepted publickey for core from 10.0.0.1 port 60162 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:24.961383 sshd-session[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:24.965365 systemd-logind[1464]: New session 7 of user core. May 14 05:08:24.974989 systemd[1]: Started session-7.scope - Session 7 of User core. May 14 05:08:25.028624 systemd[1]: Starting docker.service - Docker Application Container Engine... May 14 05:08:25.041214 (dockerd)[1691]: 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 05:08:25.254698 dockerd[1691]: time="2025-05-14T05:08:25.254563537Z" level=info msg="Starting up" May 14 05:08:25.255338 dockerd[1691]: time="2025-05-14T05:08:25.255294287Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 14 05:08:25.318911 dockerd[1691]: time="2025-05-14T05:08:25.318844449Z" level=info msg="Loading containers: start." May 14 05:08:25.328905 kernel: Initializing XFRM netlink socket May 14 05:08:25.563146 systemd-networkd[1418]: docker0: Link UP May 14 05:08:25.568143 dockerd[1691]: time="2025-05-14T05:08:25.568106163Z" level=info msg="Loading containers: done." May 14 05:08:25.580886 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1867641562-merged.mount: Deactivated successfully. May 14 05:08:25.582197 dockerd[1691]: time="2025-05-14T05:08:25.582161336Z" 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 05:08:25.582267 dockerd[1691]: time="2025-05-14T05:08:25.582215618Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 14 05:08:25.582333 dockerd[1691]: time="2025-05-14T05:08:25.582309985Z" level=info msg="Initializing buildkit" May 14 05:08:25.609958 dockerd[1691]: time="2025-05-14T05:08:25.609927428Z" level=info msg="Completed buildkit initialization" May 14 05:08:25.615835 dockerd[1691]: time="2025-05-14T05:08:25.615793721Z" level=info msg="Daemon has completed initialization" May 14 05:08:25.615904 dockerd[1691]: time="2025-05-14T05:08:25.615871547Z" level=info msg="API listen on /run/docker.sock" May 14 05:08:25.616030 systemd[1]: Started docker.service - Docker Application Container Engine. May 14 05:08:25.624389 sshd[1689]: Connection closed by 10.0.0.1 port 60162 May 14 05:08:25.624668 sshd-session[1687]: pam_unix(sshd:session): session closed for user core May 14 05:08:25.633244 systemd[1]: sshd@6-10.0.0.69:22-10.0.0.1:60162.service: Deactivated successfully. May 14 05:08:25.634877 systemd[1]: session-7.scope: Deactivated successfully. May 14 05:08:25.635614 systemd-logind[1464]: Session 7 logged out. Waiting for processes to exit. May 14 05:08:25.638580 systemd[1]: Started sshd@7-10.0.0.69:22-10.0.0.1:60178.service - OpenSSH per-connection server daemon (10.0.0.1:60178). May 14 05:08:25.639134 systemd-logind[1464]: Removed session 7. May 14 05:08:25.685595 sshd[1895]: Accepted publickey for core from 10.0.0.1 port 60178 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:25.686910 sshd-session[1895]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:25.690941 systemd-logind[1464]: New session 8 of user core. May 14 05:08:25.704982 systemd[1]: Started session-8.scope - Session 8 of User core. May 14 05:08:26.977374 systemd[1]: var-lib-docker-overlay2-0a1a24f66395e65406db2158233d69eb5ad1c24ddf1a08a7a77a7640d58b232b\x2dinit-merged.mount: Deactivated successfully. May 14 05:08:27.030730 containerd[1528]: time="2025-05-14T05:08:27.030681146Z" level=info msg="connecting to shim 377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5" address="unix:///run/containerd/s/aca3ec22a1a975927741a91579350ebc52fb321e37ff73225db41eb4dd15347b" namespace=moby protocol=ttrpc version=3 May 14 05:08:27.055975 systemd[1]: Started docker-377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5.scope - libcontainer container 377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5. May 14 05:08:27.069749 systemd-resolved[1353]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 14 05:08:27.095082 kernel: docker0: port 1(veth19276bd) entered blocking state May 14 05:08:27.095159 kernel: docker0: port 1(veth19276bd) entered disabled state May 14 05:08:27.095182 kernel: veth19276bd: entered allmulticast mode May 14 05:08:27.096267 kernel: veth19276bd: entered promiscuous mode May 14 05:08:27.096461 systemd-networkd[1418]: veth19276bd: Link UP May 14 05:08:27.107890 kernel: eth0: renamed from vethf7560ac May 14 05:08:27.109665 systemd-networkd[1418]: veth19276bd: Gained carrier May 14 05:08:27.109895 kernel: docker0: port 1(veth19276bd) entered blocking state May 14 05:08:27.109927 kernel: docker0: port 1(veth19276bd) entered forwarding state May 14 05:08:27.110699 systemd-networkd[1418]: docker0: Gained carrier May 14 05:08:27.140182 sshd[1897]: Connection closed by 10.0.0.1 port 60178 May 14 05:08:27.141479 sshd-session[1895]: pam_unix(sshd:session): session closed for user core May 14 05:08:27.149329 systemd[1]: sshd@7-10.0.0.69:22-10.0.0.1:60178.service: Deactivated successfully. May 14 05:08:27.151179 systemd[1]: session-8.scope: Deactivated successfully. May 14 05:08:27.151961 systemd-logind[1464]: Session 8 logged out. Waiting for processes to exit. May 14 05:08:27.155231 systemd[1]: Started sshd@8-10.0.0.69:22-10.0.0.1:60192.service - OpenSSH per-connection server daemon (10.0.0.1:60192). May 14 05:08:27.155844 systemd-logind[1464]: Removed session 8. May 14 05:08:27.200292 sshd[1974]: Accepted publickey for core from 10.0.0.1 port 60192 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:27.201599 sshd-session[1974]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:27.205553 systemd-logind[1464]: New session 9 of user core. May 14 05:08:27.214975 systemd[1]: Started session-9.scope - Session 9 of User core. May 14 05:08:27.270489 sshd[1976]: Connection closed by 10.0.0.1 port 60192 May 14 05:08:27.270933 sshd-session[1974]: pam_unix(sshd:session): session closed for user core May 14 05:08:27.283388 systemd[1]: sshd@8-10.0.0.69:22-10.0.0.1:60192.service: Deactivated successfully. May 14 05:08:27.285153 systemd[1]: session-9.scope: Deactivated successfully. May 14 05:08:27.285836 systemd-logind[1464]: Session 9 logged out. Waiting for processes to exit. May 14 05:08:27.288648 systemd[1]: Started sshd@9-10.0.0.69:22-10.0.0.1:60208.service - OpenSSH per-connection server daemon (10.0.0.1:60208). May 14 05:08:27.289416 systemd-logind[1464]: Removed session 9. May 14 05:08:27.345806 sshd[1982]: Accepted publickey for core from 10.0.0.1 port 60208 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:27.347114 sshd-session[1982]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:27.351016 systemd-logind[1464]: New session 10 of user core. May 14 05:08:27.364970 systemd[1]: Started session-10.scope - Session 10 of User core. May 14 05:08:27.417129 sudo[1985]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1528 May 14 05:08:27.417427 sudo[1985]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 05:08:27.420853 sudo[1985]: pam_unix(sudo:session): session closed for user root May 14 05:08:27.421035 containerd[1528]: time="2025-05-14T05:08:27.420991657Z" level=info msg="Stop CRI service" May 14 05:08:27.421456 dockerd[1691]: time="2025-05-14T05:08:27.421076235Z" 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 05:08:27.421456 dockerd[1691]: time="2025-05-14T05:08:27.421113836Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 14 05:08:27.421456 dockerd[1691]: time="2025-05-14T05:08:27.421252546Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 14 05:08:27.421456 dockerd[1691]: time="2025-05-14T05:08:27.421280989Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 14 05:08:27.422512 sshd[1984]: Connection closed by 10.0.0.1 port 60208 May 14 05:08:27.422984 sshd-session[1982]: pam_unix(sshd:session): session closed for user core May 14 05:08:27.435285 systemd[1]: containerd.service: Deactivated successfully. May 14 05:08:27.435400 systemd[1]: containerd.service: Unit process 1922 (containerd-shim) remains running after unit stopped. May 14 05:08:27.435672 systemd[1]: containerd.service: Consumed 320ms CPU time, 135.7M memory peak. May 14 05:08:27.436124 systemd[1]: sshd@9-10.0.0.69:22-10.0.0.1:60208.service: Deactivated successfully. May 14 05:08:27.437950 systemd[1]: session-10.scope: Deactivated successfully. May 14 05:08:27.439489 systemd-logind[1464]: Session 10 logged out. Waiting for processes to exit. May 14 05:08:27.442800 systemd[1]: Started sshd@10-10.0.0.69:22-10.0.0.1:60218.service - OpenSSH per-connection server daemon (10.0.0.1:60218). May 14 05:08:27.443480 systemd-logind[1464]: Removed session 10. May 14 05:08:27.492769 sshd[1992]: Accepted publickey for core from 10.0.0.1 port 60218 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:27.494137 sshd-session[1992]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:27.498102 systemd-logind[1464]: New session 11 of user core. May 14 05:08:27.512983 systemd[1]: Started session-11.scope - Session 11 of User core. May 14 05:08:27.567126 sshd[1994]: Connection closed by 10.0.0.1 port 60218 May 14 05:08:27.567531 sshd-session[1992]: pam_unix(sshd:session): session closed for user core May 14 05:08:27.570704 systemd[1]: sshd@10-10.0.0.69:22-10.0.0.1:60218.service: Deactivated successfully. May 14 05:08:27.572484 systemd[1]: session-11.scope: Deactivated successfully. May 14 05:08:27.574157 systemd-logind[1464]: Session 11 logged out. Waiting for processes to exit. May 14 05:08:27.575603 systemd-logind[1464]: Removed session 11. May 14 05:08:28.660073 systemd-networkd[1418]: veth19276bd: Gained IPv6LL May 14 05:08:29.044036 systemd-networkd[1418]: docker0: Gained IPv6LL May 14 05:08:32.686197 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. May 14 05:08:32.686696 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 14 05:08:32.686843 dockerd[1691]: time="2025-05-14T05:08:32.686706342Z" level=info msg="Processing signal 'terminated'" May 14 05:08:33.596420 systemd[1]: Started sshd@11-10.0.0.69:22-10.0.0.1:42672.service - OpenSSH per-connection server daemon (10.0.0.1:42672). May 14 05:08:33.641747 sshd[2000]: Accepted publickey for core from 10.0.0.1 port 42672 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:33.643384 sshd-session[2000]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:33.647581 systemd-logind[1464]: New session 12 of user core. May 14 05:08:33.656980 systemd[1]: Started session-12.scope - Session 12 of User core. May 14 05:08:33.712080 sshd[2002]: Connection closed by 10.0.0.1 port 42672 May 14 05:08:33.712425 sshd-session[2000]: pam_unix(sshd:session): session closed for user core May 14 05:08:33.716409 systemd[1]: sshd@11-10.0.0.69:22-10.0.0.1:42672.service: Deactivated successfully. May 14 05:08:33.718243 systemd[1]: session-12.scope: Deactivated successfully. May 14 05:08:33.718968 systemd-logind[1464]: Session 12 logged out. Waiting for processes to exit. May 14 05:08:33.720024 systemd-logind[1464]: Removed session 12. May 14 05:08:34.687851 dockerd[1691]: time="2025-05-14T05:08:34.687764806Z" level=error msg="Error sending stop (signal 15) to container" container=377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5 error="Cannot kill container 377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" May 14 05:08:34.687851 dockerd[1691]: time="2025-05-14T05:08:34.687813808Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5 May 14 05:08:39.729773 systemd[1]: Started sshd@12-10.0.0.69:22-10.0.0.1:53390.service - OpenSSH per-connection server daemon (10.0.0.1:53390). May 14 05:08:39.774882 sshd[2008]: Accepted publickey for core from 10.0.0.1 port 53390 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:39.776433 sshd-session[2008]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:39.780295 systemd-logind[1464]: New session 13 of user core. May 14 05:08:39.788970 systemd[1]: Started session-13.scope - Session 13 of User core. May 14 05:08:39.842937 sshd[2010]: Connection closed by 10.0.0.1 port 53390 May 14 05:08:39.843180 sshd-session[2008]: pam_unix(sshd:session): session closed for user core May 14 05:08:39.846421 systemd[1]: sshd@12-10.0.0.69:22-10.0.0.1:53390.service: Deactivated successfully. May 14 05:08:39.848169 systemd[1]: session-13.scope: Deactivated successfully. May 14 05:08:39.848781 systemd-logind[1464]: Session 13 logged out. Waiting for processes to exit. May 14 05:08:39.849800 systemd-logind[1464]: Removed session 13. May 14 05:08:44.689652 dockerd[1691]: time="2025-05-14T05:08:44.689573580Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5 error="context deadline exceeded" May 14 05:08:44.690234 systemd[1]: docker-377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5.scope: Deactivated successfully. May 14 05:08:45.859154 systemd[1]: Started sshd@13-10.0.0.69:22-10.0.0.1:53402.service - OpenSSH per-connection server daemon (10.0.0.1:53402). May 14 05:08:45.908282 sshd[2016]: Accepted publickey for core from 10.0.0.1 port 53402 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:45.909620 sshd-session[2016]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:45.913561 systemd-logind[1464]: New session 14 of user core. May 14 05:08:45.922999 systemd[1]: Started session-14.scope - Session 14 of User core. May 14 05:08:45.977935 sshd[2018]: Connection closed by 10.0.0.1 port 53402 May 14 05:08:45.978196 sshd-session[2016]: pam_unix(sshd:session): session closed for user core May 14 05:08:45.982248 systemd[1]: sshd@13-10.0.0.69:22-10.0.0.1:53402.service: Deactivated successfully. May 14 05:08:45.984191 systemd[1]: session-14.scope: Deactivated successfully. May 14 05:08:45.984854 systemd-logind[1464]: Session 14 logged out. Waiting for processes to exit. May 14 05:08:45.986067 systemd-logind[1464]: Removed session 14. May 14 05:08:47.687819 dockerd[1691]: time="2025-05-14T05:08:47.687761053Z" level=error msg="Force shutdown daemon" May 14 05:08:47.688273 dockerd[1691]: time="2025-05-14T05:08:47.687944647Z" level=info msg="Daemon shutdown complete" May 14 05:08:47.688273 dockerd[1691]: time="2025-05-14T05:08:47.688068850Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" May 14 05:08:47.688273 dockerd[1691]: time="2025-05-14T05:08:47.688092795Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby May 14 05:08:47.688273 dockerd[1691]: time="2025-05-14T05:08:47.688092384Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" May 14 05:08:47.688273 dockerd[1691]: time="2025-05-14T05:08:47.688130165Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby May 14 05:08:47.693056 systemd[1]: docker.service: Deactivated successfully. May 14 05:08:47.693447 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 14 05:08:47.693509 systemd[1]: docker.service: Consumed 857ms CPU time, 131.6M memory peak. May 14 05:08:47.693962 systemd[1]: docker.socket: Deactivated successfully. May 14 05:08:47.694295 systemd[1]: Closed docker.socket - Docker Socket for the API. May 14 05:08:47.694331 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 14 05:08:47.696184 systemd[1]: Starting docker.socket - Docker Socket for the API... May 14 05:08:47.696371 systemd[1]: containerd.service: Found left-over process 1922 (containerd-shim) in control group while starting unit. Ignoring. May 14 05:08:47.696375 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 14 05:08:47.710290 systemd[1]: Starting containerd.service - containerd container runtime... May 14 05:08:47.711005 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 14 05:08:47.723089 systemd[1]: containerd.service: Found left-over process 1922 (containerd-shim) in control group while starting unit. Ignoring. May 14 05:08:47.723100 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 14 05:08:47.727201 (ntainerd)[2029]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 14 05:08:47.742925 containerd[2029]: time="2025-05-14T05:08:47Z" 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 05:08:47.743467 containerd[2029]: time="2025-05-14T05:08:47.743433579Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 14 05:08:47.751379 containerd[2029]: time="2025-05-14T05:08:47.751325271Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.251µs" May 14 05:08:47.751379 containerd[2029]: time="2025-05-14T05:08:47.751371919Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 14 05:08:47.751454 containerd[2029]: time="2025-05-14T05:08:47.751399571Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 14 05:08:47.751454 containerd[2029]: time="2025-05-14T05:08:47.751438594Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 14 05:08:47.751490 containerd[2029]: time="2025-05-14T05:08:47.751453362Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 14 05:08:47.751747 containerd[2029]: time="2025-05-14T05:08:47.751724600Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 14 05:08:47.751784 containerd[2029]: time="2025-05-14T05:08:47.751761780Z" 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 05:08:47.751784 containerd[2029]: time="2025-05-14T05:08:47.751775446Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 14 05:08:47.752122 containerd[2029]: time="2025-05-14T05:08:47.752099103Z" 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 05:08:47.752122 containerd[2029]: time="2025-05-14T05:08:47.752116926Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 14 05:08:47.752162 containerd[2029]: time="2025-05-14T05:08:47.752127636Z" 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 05:08:47.752162 containerd[2029]: time="2025-05-14T05:08:47.752135621Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 14 05:08:47.752162 containerd[2029]: time="2025-05-14T05:08:47.752155689Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 14 05:08:47.752271 containerd[2029]: time="2025-05-14T05:08:47.752251328Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 14 05:08:47.752293 containerd[2029]: time="2025-05-14T05:08:47.752276926Z" 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 05:08:47.752293 containerd[2029]: time="2025-05-14T05:08:47.752285703Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 14 05:08:47.752391 containerd[2029]: time="2025-05-14T05:08:47.752318815Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 14 05:08:47.752525 containerd[2029]: time="2025-05-14T05:08:47.752505635Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 14 05:08:47.752722 containerd[2029]: time="2025-05-14T05:08:47.752695782Z" level=info msg="metadata content store policy set" policy=shared May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753063482Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753116181Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753147589Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753166445Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753186342Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753205338Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753233020Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753255291Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753273425Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753340351Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 14 05:08:47.753439 containerd[2029]: time="2025-05-14T05:08:47.753396376Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 14 05:08:47.753674 containerd[2029]: time="2025-05-14T05:08:47.753536058Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 14 05:08:47.754023 containerd[2029]: time="2025-05-14T05:08:47.753993797Z" level=info msg="connecting to shim 377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5" address="unix:///run/containerd/s/aca3ec22a1a975927741a91579350ebc52fb321e37ff73225db41eb4dd15347b" namespace=moby protocol=ttrpc version=3 May 14 05:08:47.762052 containerd[2029]: time="2025-05-14T05:08:47.762020332Z" level=info msg="cleaning leaked shim process" id=377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5 namespace=moby May 14 05:08:47.771539 containerd[2029]: time="2025-05-14T05:08:47.771467552Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 14 05:08:47.771818 containerd[2029]: time="2025-05-14T05:08:47.771791480Z" level=info msg="shim disconnected" id=377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5 namespace=moby May 14 05:08:47.771957 containerd[2029]: time="2025-05-14T05:08:47.771932585Z" level=warning msg="cleaning up after shim disconnected" id=377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5 namespace=moby May 14 05:08:47.772024 containerd[2029]: time="2025-05-14T05:08:47.771950869Z" level=info msg="cleaning up dead shim" namespace=moby May 14 05:08:47.782290 containerd[2029]: time="2025-05-14T05:08:47.782231462Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 14 05:08:47.782381 containerd[2029]: time="2025-05-14T05:08:47.782348061Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 14 05:08:47.782381 containerd[2029]: time="2025-05-14T05:08:47.782370864Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 14 05:08:47.782436 containerd[2029]: time="2025-05-14T05:08:47.782385181Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 14 05:08:47.782436 containerd[2029]: time="2025-05-14T05:08:47.782395811Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 14 05:08:47.782436 containerd[2029]: time="2025-05-14T05:08:47.782406871Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 14 05:08:47.782436 containerd[2029]: time="2025-05-14T05:08:47.782416429Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 14 05:08:47.782436 containerd[2029]: time="2025-05-14T05:08:47.782427400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 14 05:08:47.782436 containerd[2029]: time="2025-05-14T05:08:47.782436778Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 14 05:08:47.782542 containerd[2029]: time="2025-05-14T05:08:47.782447668Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 14 05:08:47.782542 containerd[2029]: time="2025-05-14T05:08:47.782458178Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 14 05:08:47.782542 containerd[2029]: time="2025-05-14T05:08:47.782475059Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 14 05:08:47.782595 containerd[2029]: time="2025-05-14T05:08:47.782541925Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 14 05:08:47.782595 containerd[2029]: time="2025-05-14T05:08:47.782553316Z" level=info msg="Start snapshots syncer" May 14 05:08:47.782595 containerd[2029]: time="2025-05-14T05:08:47.782583813Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 14 05:08:47.782811 containerd[2029]: time="2025-05-14T05:08:47.782776625Z" 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 05:08:47.782908 containerd[2029]: time="2025-05-14T05:08:47.782826629Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 14 05:08:47.782930 containerd[2029]: time="2025-05-14T05:08:47.782915816Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 14 05:08:47.782989 containerd[2029]: time="2025-05-14T05:08:47.782955210Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 14 05:08:47.782989 containerd[2029]: time="2025-05-14T05:08:47.782987050Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 14 05:08:47.782989 containerd[2029]: time="2025-05-14T05:08:47.782998381Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783007839Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783018779Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783028708Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783039698Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783062782Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783072971Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783082238Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783117094Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 14 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783129537Z" 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 05:08:47.783134 containerd[2029]: time="2025-05-14T05:08:47.783137823Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783148012Z" 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 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783155987Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783165915Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783175072Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783191704Z" level=info msg="runtime interface created" May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783196903Z" level=info msg="created NRI interface" May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783204478Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783214376Z" level=info msg="Connect containerd service" May 14 05:08:47.783330 containerd[2029]: time="2025-05-14T05:08:47.783243070Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 14 05:08:47.783786 containerd[2029]: time="2025-05-14T05:08:47.783753878Z" 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 05:08:47.793901 containerd[2029]: time="2025-05-14T05:08:47.793855205Z" level=info msg="Start subscribing containerd event" May 14 05:08:47.793971 containerd[2029]: time="2025-05-14T05:08:47.793917622Z" level=info msg="Start recovering state" May 14 05:08:47.794026 containerd[2029]: time="2025-05-14T05:08:47.794010517Z" level=info msg="Start event monitor" May 14 05:08:47.794051 containerd[2029]: time="2025-05-14T05:08:47.794017299Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 14 05:08:47.794051 containerd[2029]: time="2025-05-14T05:08:47.794031736Z" level=info msg="Start cni network conf syncer for default" May 14 05:08:47.794051 containerd[2029]: time="2025-05-14T05:08:47.794041184Z" level=info msg="Start streaming server" May 14 05:08:47.794051 containerd[2029]: time="2025-05-14T05:08:47.794050071Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 14 05:08:47.794170 containerd[2029]: time="2025-05-14T05:08:47.794058366Z" level=info msg="runtime interface starting up..." May 14 05:08:47.794170 containerd[2029]: time="2025-05-14T05:08:47.794064398Z" level=info msg="starting plugins..." May 14 05:08:47.794170 containerd[2029]: time="2025-05-14T05:08:47.794070229Z" level=info msg=serving... address=/run/containerd/containerd.sock May 14 05:08:47.794170 containerd[2029]: time="2025-05-14T05:08:47.794073214Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 14 05:08:47.794295 systemd[1]: Started containerd.service - containerd container runtime. May 14 05:08:47.795760 containerd[2029]: time="2025-05-14T05:08:47.795735282Z" level=info msg="containerd successfully booted in 0.053002s" May 14 05:08:47.796051 systemd[1]: Starting docker.service - Docker Application Container Engine... May 14 05:08:47.806165 (dockerd)[2077]: 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 05:08:47.834579 dockerd[2077]: time="2025-05-14T05:08:47.834520181Z" level=info msg="Starting up" May 14 05:08:47.835186 dockerd[2077]: time="2025-05-14T05:08:47.835166503Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 14 05:08:47.869889 dockerd[2077]: time="2025-05-14T05:08:47.869832377Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 14 05:08:47.894811 dockerd[2077]: time="2025-05-14T05:08:47.894751859Z" level=info msg="Loading containers: start." May 14 05:08:47.910280 systemd[1]: var-lib-docker-overlay2-0a1a24f66395e65406db2158233d69eb5ad1c24ddf1a08a7a77a7640d58b232b-merged.mount: Deactivated successfully. May 14 05:08:48.281824 systemd-networkd[1418]: veth19276bd: Link DOWN May 14 05:08:48.281835 systemd-networkd[1418]: veth19276bd: Lost carrier May 14 05:08:48.282926 kernel: docker0: port 1(veth19276bd) entered disabled state May 14 05:08:48.285395 kernel: veth19276bd (unregistering): left allmulticast mode May 14 05:08:48.285441 kernel: veth19276bd (unregistering): left promiscuous mode May 14 05:08:48.285466 kernel: docker0: port 1(veth19276bd) entered disabled state May 14 05:08:48.286032 systemd-networkd[1418]: docker0: Lost carrier May 14 05:08:48.287223 dockerd[2077]: time="2025-05-14T05:08:48.287175824Z" level=info msg="Removing stale sandbox 8ef65df0822aad74d68844d1032bedd50a0d1769905bedb6422a21d39acbc878 (377411f9978d6308eb8b4471067cfe0e64968d291e244bafcb3e34e2e4ee35c5)" May 14 05:08:48.293454 dockerd[2077]: time="2025-05-14T05:08:48.293421028Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 14 05:08:48.293516 dockerd[2077]: time="2025-05-14T05:08:48.293456004Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 2b71d213810dd75d8aecc25022fd7c66395fb1d6582913818d3bb041359de6c4 0f0ed93df3c95a3dea5e9c3659b3670b99b45c2f59a83c65d1a3267addf49d60], retrying...." May 14 05:08:48.480522 dockerd[2077]: time="2025-05-14T05:08:48.480471211Z" level=warning msg="error locating sandbox id 8ef65df0822aad74d68844d1032bedd50a0d1769905bedb6422a21d39acbc878: sandbox 8ef65df0822aad74d68844d1032bedd50a0d1769905bedb6422a21d39acbc878 not found" May 14 05:08:48.480638 dockerd[2077]: time="2025-05-14T05:08:48.480584894Z" level=info msg="Loading containers: done." May 14 05:08:48.492703 dockerd[2077]: time="2025-05-14T05:08:48.492667177Z" 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 05:08:48.492821 dockerd[2077]: time="2025-05-14T05:08:48.492733682Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 14 05:08:48.492821 dockerd[2077]: time="2025-05-14T05:08:48.492775069Z" level=info msg="Initializing buildkit" May 14 05:08:48.507529 dockerd[2077]: time="2025-05-14T05:08:48.507498316Z" level=info msg="Completed buildkit initialization" May 14 05:08:48.511535 dockerd[2077]: time="2025-05-14T05:08:48.511486907Z" level=info msg="Daemon has completed initialization" May 14 05:08:48.511657 dockerd[2077]: time="2025-05-14T05:08:48.511548112Z" level=info msg="API listen on /run/docker.sock" May 14 05:08:48.511729 systemd[1]: Started docker.service - Docker Application Container Engine. May 14 05:08:48.856258 systemd[1]: run-docker-netns-8ef65df0822a.mount: Deactivated successfully. May 14 05:08:52.000317 systemd[1]: Started sshd@14-10.0.0.69:22-10.0.0.1:51724.service - OpenSSH per-connection server daemon (10.0.0.1:51724). May 14 05:08:52.042730 sshd[2298]: Accepted publickey for core from 10.0.0.1 port 51724 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:52.044059 sshd-session[2298]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:52.048156 systemd-logind[1464]: New session 15 of user core. May 14 05:08:52.063979 systemd[1]: Started session-15.scope - Session 15 of User core. May 14 05:08:52.119238 sshd[2300]: Connection closed by 10.0.0.1 port 51724 May 14 05:08:52.119511 sshd-session[2298]: pam_unix(sshd:session): session closed for user core May 14 05:08:52.132409 systemd[1]: sshd@14-10.0.0.69:22-10.0.0.1:51724.service: Deactivated successfully. May 14 05:08:52.134145 systemd[1]: session-15.scope: Deactivated successfully. May 14 05:08:52.134791 systemd-logind[1464]: Session 15 logged out. Waiting for processes to exit. May 14 05:08:52.137685 systemd[1]: Started sshd@15-10.0.0.69:22-10.0.0.1:51730.service - OpenSSH per-connection server daemon (10.0.0.1:51730). May 14 05:08:52.138205 systemd-logind[1464]: Removed session 15. May 14 05:08:52.181078 sshd[2306]: Accepted publickey for core from 10.0.0.1 port 51730 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:52.182490 sshd-session[2306]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:52.186713 systemd-logind[1464]: New session 16 of user core. May 14 05:08:52.194984 systemd[1]: Started session-16.scope - Session 16 of User core. May 14 05:08:52.249491 sshd[2308]: Connection closed by 10.0.0.1 port 51730 May 14 05:08:52.250050 sshd-session[2306]: pam_unix(sshd:session): session closed for user core May 14 05:08:52.258064 systemd[1]: sshd@15-10.0.0.69:22-10.0.0.1:51730.service: Deactivated successfully. May 14 05:08:52.259573 systemd[1]: session-16.scope: Deactivated successfully. May 14 05:08:52.260424 systemd-logind[1464]: Session 16 logged out. Waiting for processes to exit. May 14 05:08:52.262925 systemd[1]: Started sshd@16-10.0.0.69:22-10.0.0.1:51738.service - OpenSSH per-connection server daemon (10.0.0.1:51738). May 14 05:08:52.263501 systemd-logind[1464]: Removed session 16. May 14 05:08:52.314622 sshd[2314]: Accepted publickey for core from 10.0.0.1 port 51738 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:52.316163 sshd-session[2314]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:52.320363 systemd-logind[1464]: New session 17 of user core. May 14 05:08:52.329998 systemd[1]: Started session-17.scope - Session 17 of User core. May 14 05:08:52.389068 sshd[2316]: Connection closed by 10.0.0.1 port 51738 May 14 05:08:52.389347 sshd-session[2314]: pam_unix(sshd:session): session closed for user core May 14 05:08:52.399626 systemd[1]: sshd@16-10.0.0.69:22-10.0.0.1:51738.service: Deactivated successfully. May 14 05:08:52.401535 systemd[1]: session-17.scope: Deactivated successfully. May 14 05:08:52.402203 systemd-logind[1464]: Session 17 logged out. Waiting for processes to exit. May 14 05:08:52.405147 systemd[1]: Started sshd@17-10.0.0.69:22-10.0.0.1:51748.service - OpenSSH per-connection server daemon (10.0.0.1:51748). May 14 05:08:52.405645 systemd-logind[1464]: Removed session 17. May 14 05:08:52.446457 sshd[2329]: Accepted publickey for core from 10.0.0.1 port 51748 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:52.447806 sshd-session[2329]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:52.451918 systemd-logind[1464]: New session 18 of user core. May 14 05:08:52.461985 systemd[1]: Started session-18.scope - Session 18 of User core. May 14 05:08:52.536022 systemd[1]: var-lib-docker-overlay2-91c413ac17a69bc11b1e0f405e7cb3b4da51bf26367258b7cfbabcc07da70fba\x2dinit-merged.mount: Deactivated successfully. May 14 05:08:52.579567 containerd[2029]: time="2025-05-14T05:08:52.579507240Z" level=info msg="connecting to shim d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0" address="unix:///run/containerd/s/70249ac9c7f9e496872e7270772430644653c1cc5b28a259febee2f89f574400" namespace=moby protocol=ttrpc version=3 May 14 05:08:52.612002 systemd[1]: Started docker-d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0.scope - libcontainer container d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0. May 14 05:08:52.623819 systemd-resolved[1353]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 14 05:08:52.647320 kernel: docker0: port 1(veth7c7035f) entered blocking state May 14 05:08:52.647372 kernel: docker0: port 1(veth7c7035f) entered disabled state May 14 05:08:52.647390 kernel: veth7c7035f: entered allmulticast mode May 14 05:08:52.648054 kernel: veth7c7035f: entered promiscuous mode May 14 05:08:52.648272 systemd-networkd[1418]: veth7c7035f: Link UP May 14 05:08:52.657891 kernel: eth0: renamed from veth315fa37 May 14 05:08:52.660384 kernel: docker0: port 1(veth7c7035f) entered blocking state May 14 05:08:52.660442 kernel: docker0: port 1(veth7c7035f) entered forwarding state May 14 05:08:52.660465 systemd-networkd[1418]: veth7c7035f: Gained carrier May 14 05:08:52.660716 systemd-networkd[1418]: docker0: Gained carrier May 14 05:08:52.685316 sshd[2331]: Connection closed by 10.0.0.1 port 51748 May 14 05:08:52.685634 sshd-session[2329]: pam_unix(sshd:session): session closed for user core May 14 05:08:52.697536 systemd[1]: sshd@17-10.0.0.69:22-10.0.0.1:51748.service: Deactivated successfully. May 14 05:08:52.699250 systemd[1]: session-18.scope: Deactivated successfully. May 14 05:08:52.699935 systemd-logind[1464]: Session 18 logged out. Waiting for processes to exit. May 14 05:08:52.702849 systemd[1]: Started sshd@18-10.0.0.69:22-10.0.0.1:51762.service - OpenSSH per-connection server daemon (10.0.0.1:51762). May 14 05:08:52.703699 systemd-logind[1464]: Removed session 18. May 14 05:08:52.758533 sshd[2401]: Accepted publickey for core from 10.0.0.1 port 51762 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:52.760222 sshd-session[2401]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:52.765003 systemd-logind[1464]: New session 19 of user core. May 14 05:08:52.772086 systemd[1]: Started session-19.scope - Session 19 of User core. May 14 05:08:52.828556 sshd[2403]: Connection closed by 10.0.0.1 port 51762 May 14 05:08:52.828794 sshd-session[2401]: pam_unix(sshd:session): session closed for user core May 14 05:08:52.846180 systemd[1]: sshd@18-10.0.0.69:22-10.0.0.1:51762.service: Deactivated successfully. May 14 05:08:52.848368 systemd[1]: session-19.scope: Deactivated successfully. May 14 05:08:52.849249 systemd-logind[1464]: Session 19 logged out. Waiting for processes to exit. May 14 05:08:52.852674 systemd[1]: Started sshd@19-10.0.0.69:22-10.0.0.1:51778.service - OpenSSH per-connection server daemon (10.0.0.1:51778). May 14 05:08:52.853372 systemd-logind[1464]: Removed session 19. May 14 05:08:52.898463 sshd[2409]: Accepted publickey for core from 10.0.0.1 port 51778 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:52.899813 sshd-session[2409]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:52.904307 systemd-logind[1464]: New session 20 of user core. May 14 05:08:52.914991 systemd[1]: Started session-20.scope - Session 20 of User core. May 14 05:08:52.967537 sudo[2413]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2029 May 14 05:08:52.967840 sudo[2413]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 05:08:52.971903 sudo[2413]: pam_unix(sudo:session): session closed for user root May 14 05:08:52.973631 sshd[2412]: Connection closed by 10.0.0.1 port 51778 May 14 05:08:52.973996 sshd-session[2409]: pam_unix(sshd:session): session closed for user core May 14 05:08:52.976377 dockerd[2077]: time="2025-05-14T05:08:52.976318208Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 14 05:08:52.976377 dockerd[2077]: time="2025-05-14T05:08:52.976355540Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 14 05:08:52.976739 dockerd[2077]: time="2025-05-14T05:08:52.976363455Z" 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 05:08:52.976739 dockerd[2077]: time="2025-05-14T05:08:52.976392450Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 14 05:08:52.983222 systemd[1]: containerd.service: Deactivated successfully. May 14 05:08:52.983368 systemd[1]: containerd.service: Unit process 2350 (containerd-shim) remains running after unit stopped. May 14 05:08:52.983687 systemd[1]: containerd.service: Consumed 175ms CPU time, 137.9M memory peak. May 14 05:08:52.984262 systemd[1]: sshd@19-10.0.0.69:22-10.0.0.1:51778.service: Deactivated successfully. May 14 05:08:52.986473 systemd[1]: session-20.scope: Deactivated successfully. May 14 05:08:52.988275 systemd-logind[1464]: Session 20 logged out. Waiting for processes to exit. May 14 05:08:52.991526 systemd[1]: Started sshd@20-10.0.0.69:22-10.0.0.1:51792.service - OpenSSH per-connection server daemon (10.0.0.1:51792). May 14 05:08:52.992069 systemd-logind[1464]: Removed session 20. May 14 05:08:53.043200 sshd[2420]: Accepted publickey for core from 10.0.0.1 port 51792 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:53.044950 sshd-session[2420]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:53.049521 systemd-logind[1464]: New session 21 of user core. May 14 05:08:53.069085 systemd[1]: Started session-21.scope - Session 21 of User core. May 14 05:08:53.124667 sshd[2422]: Connection closed by 10.0.0.1 port 51792 May 14 05:08:53.124884 sshd-session[2420]: pam_unix(sshd:session): session closed for user core May 14 05:08:53.129083 systemd[1]: sshd@20-10.0.0.69:22-10.0.0.1:51792.service: Deactivated successfully. May 14 05:08:53.131032 systemd[1]: session-21.scope: Deactivated successfully. May 14 05:08:53.131708 systemd-logind[1464]: Session 21 logged out. Waiting for processes to exit. May 14 05:08:53.132822 systemd-logind[1464]: Removed session 21. May 14 05:08:53.940073 systemd-networkd[1418]: veth7c7035f: Gained IPv6LL May 14 05:08:58.168717 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. May 14 05:08:58.169170 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 14 05:08:58.169369 dockerd[2077]: time="2025-05-14T05:08:58.169288088Z" level=info msg="Processing signal 'terminated'" May 14 05:08:59.141607 systemd[1]: Started sshd@21-10.0.0.69:22-10.0.0.1:51830.service - OpenSSH per-connection server daemon (10.0.0.1:51830). May 14 05:08:59.176486 sshd[2428]: Accepted publickey for core from 10.0.0.1 port 51830 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:08:59.177815 sshd-session[2428]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:08:59.182033 systemd-logind[1464]: New session 22 of user core. May 14 05:08:59.192007 systemd[1]: Started session-22.scope - Session 22 of User core. May 14 05:08:59.246976 sshd[2430]: Connection closed by 10.0.0.1 port 51830 May 14 05:08:59.247281 sshd-session[2428]: pam_unix(sshd:session): session closed for user core May 14 05:08:59.251417 systemd[1]: sshd@21-10.0.0.69:22-10.0.0.1:51830.service: Deactivated successfully. May 14 05:08:59.253461 systemd[1]: session-22.scope: Deactivated successfully. May 14 05:08:59.254188 systemd-logind[1464]: Session 22 logged out. Waiting for processes to exit. May 14 05:08:59.255349 systemd-logind[1464]: Removed session 22. May 14 05:09:00.171528 dockerd[2077]: time="2025-05-14T05:09:00.171425762Z" level=error msg="Error sending stop (signal 15) to container" container=d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0 error="Cannot kill container d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" May 14 05:09:00.171528 dockerd[2077]: time="2025-05-14T05:09:00.171506415Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0 May 14 05:09:01.353160 update_engine[1465]: I20250514 05:09:01.353034 1465 update_attempter.cc:509] Updating boot flags... May 14 05:09:05.259477 systemd[1]: Started sshd@22-10.0.0.69:22-10.0.0.1:51842.service - OpenSSH per-connection server daemon (10.0.0.1:51842). May 14 05:09:05.303278 sshd[2454]: Accepted publickey for core from 10.0.0.1 port 51842 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:09:05.304573 sshd-session[2454]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:09:05.308706 systemd-logind[1464]: New session 23 of user core. May 14 05:09:05.314988 systemd[1]: Started session-23.scope - Session 23 of User core. May 14 05:09:05.369322 sshd[2456]: Connection closed by 10.0.0.1 port 51842 May 14 05:09:05.369600 sshd-session[2454]: pam_unix(sshd:session): session closed for user core May 14 05:09:05.373453 systemd[1]: sshd@22-10.0.0.69:22-10.0.0.1:51842.service: Deactivated successfully. May 14 05:09:05.375310 systemd[1]: session-23.scope: Deactivated successfully. May 14 05:09:05.375980 systemd-logind[1464]: Session 23 logged out. Waiting for processes to exit. May 14 05:09:05.377175 systemd-logind[1464]: Removed session 23. May 14 05:09:10.171933 dockerd[2077]: time="2025-05-14T05:09:10.171831377Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0 error="context deadline exceeded" May 14 05:09:10.172836 systemd[1]: docker-d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0.scope: Deactivated successfully. May 14 05:09:11.387494 systemd[1]: Started sshd@23-10.0.0.69:22-10.0.0.1:54496.service - OpenSSH per-connection server daemon (10.0.0.1:54496). May 14 05:09:11.436206 sshd[2462]: Accepted publickey for core from 10.0.0.1 port 54496 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:09:11.437739 sshd-session[2462]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:09:11.442016 systemd-logind[1464]: New session 24 of user core. May 14 05:09:11.451970 systemd[1]: Started session-24.scope - Session 24 of User core. May 14 05:09:11.506201 sshd[2464]: Connection closed by 10.0.0.1 port 54496 May 14 05:09:11.506482 sshd-session[2462]: pam_unix(sshd:session): session closed for user core May 14 05:09:11.511121 systemd[1]: sshd@23-10.0.0.69:22-10.0.0.1:54496.service: Deactivated successfully. May 14 05:09:11.512934 systemd[1]: session-24.scope: Deactivated successfully. May 14 05:09:11.513686 systemd-logind[1464]: Session 24 logged out. Waiting for processes to exit. May 14 05:09:11.514781 systemd-logind[1464]: Removed session 24. May 14 05:09:13.170248 dockerd[2077]: time="2025-05-14T05:09:13.170147764Z" level=error msg="Force shutdown daemon" May 14 05:09:13.170726 dockerd[2077]: time="2025-05-14T05:09:13.170382267Z" level=info msg="Daemon shutdown complete" May 14 05:09:13.170726 dockerd[2077]: time="2025-05-14T05:09:13.170444324Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" May 14 05:09:13.170726 dockerd[2077]: time="2025-05-14T05:09:13.170479671Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby May 14 05:09:13.177757 systemd[1]: docker.service: Deactivated successfully. May 14 05:09:13.178188 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 14 05:09:13.178690 systemd[1]: docker.socket: Deactivated successfully. May 14 05:09:13.179044 systemd[1]: Closed docker.socket - Docker Socket for the API. May 14 05:09:13.179085 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 14 05:09:13.180832 systemd[1]: Starting docker.socket - Docker Socket for the API... May 14 05:09:13.181047 systemd[1]: containerd.service: Found left-over process 2350 (containerd-shim) in control group while starting unit. Ignoring. May 14 05:09:13.181057 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 14 05:09:13.191391 systemd[1]: Starting containerd.service - containerd container runtime... May 14 05:09:13.192102 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 14 05:09:13.203640 systemd[1]: containerd.service: Found left-over process 2350 (containerd-shim) in control group while starting unit. Ignoring. May 14 05:09:13.203650 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 14 05:09:13.208872 (ntainerd)[2475]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 14 05:09:13.224848 containerd[2475]: time="2025-05-14T05:09:13Z" 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 05:09:13.225394 containerd[2475]: time="2025-05-14T05:09:13.225358868Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 14 05:09:13.233154 containerd[2475]: time="2025-05-14T05:09:13.233104567Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.065µs" May 14 05:09:13.233207 containerd[2475]: time="2025-05-14T05:09:13.233173567Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 14 05:09:13.233238 containerd[2475]: time="2025-05-14T05:09:13.233218873Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 14 05:09:13.233301 containerd[2475]: time="2025-05-14T05:09:13.233263066Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 14 05:09:13.233334 containerd[2475]: time="2025-05-14T05:09:13.233302692Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 14 05:09:13.233597 containerd[2475]: time="2025-05-14T05:09:13.233559416Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 14 05:09:13.233809 containerd[2475]: time="2025-05-14T05:09:13.233608418Z" 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 05:09:13.233809 containerd[2475]: time="2025-05-14T05:09:13.233635480Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 14 05:09:13.234126 containerd[2475]: time="2025-05-14T05:09:13.234094566Z" 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 05:09:13.234126 containerd[2475]: time="2025-05-14T05:09:13.234123380Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 14 05:09:13.234218 containerd[2475]: time="2025-05-14T05:09:13.234140422Z" 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 05:09:13.234218 containerd[2475]: time="2025-05-14T05:09:13.234152706Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 14 05:09:13.234218 containerd[2475]: time="2025-05-14T05:09:13.234187872Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 14 05:09:13.234324 containerd[2475]: time="2025-05-14T05:09:13.234304622Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 14 05:09:13.234356 containerd[2475]: time="2025-05-14T05:09:13.234340721Z" 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 05:09:13.234385 containerd[2475]: time="2025-05-14T05:09:13.234355819Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 14 05:09:13.234413 containerd[2475]: time="2025-05-14T05:09:13.234395704Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 14 05:09:13.234625 containerd[2475]: time="2025-05-14T05:09:13.234596343Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 14 05:09:13.234662 containerd[2475]: time="2025-05-14T05:09:13.234623213Z" level=info msg="metadata content store policy set" policy=shared May 14 05:09:13.234783 containerd[2475]: time="2025-05-14T05:09:13.234755714Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 14 05:09:13.234820 containerd[2475]: time="2025-05-14T05:09:13.234810717Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 14 05:09:13.234848 containerd[2475]: time="2025-05-14T05:09:13.234828060Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 14 05:09:13.234848 containerd[2475]: time="2025-05-14T05:09:13.234842458Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 14 05:09:13.234939 containerd[2475]: time="2025-05-14T05:09:13.234876792Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 14 05:09:13.234939 containerd[2475]: time="2025-05-14T05:09:13.234900066Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 14 05:09:13.234939 containerd[2475]: time="2025-05-14T05:09:13.234914863Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 14 05:09:13.234939 containerd[2475]: time="2025-05-14T05:09:13.234928560Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 14 05:09:13.235057 containerd[2475]: time="2025-05-14T05:09:13.234940432Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 14 05:09:13.235057 containerd[2475]: time="2025-05-14T05:09:13.234953116Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 14 05:09:13.235057 containerd[2475]: time="2025-05-14T05:09:13.234964878Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 14 05:09:13.235057 containerd[2475]: time="2025-05-14T05:09:13.234979736Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 14 05:09:13.235272 containerd[2475]: time="2025-05-14T05:09:13.235238515Z" level=info msg="connecting to shim d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0" address="unix:///run/containerd/s/70249ac9c7f9e496872e7270772430644653c1cc5b28a259febee2f89f574400" namespace=moby protocol=ttrpc version=3 May 14 05:09:13.243255 containerd[2475]: time="2025-05-14T05:09:13.243224368Z" level=info msg="cleaning leaked shim process" id=d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0 namespace=moby May 14 05:09:13.254306 containerd[2475]: time="2025-05-14T05:09:13.254244215Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 14 05:09:13.254306 containerd[2475]: time="2025-05-14T05:09:13.254288209Z" level=info msg="shim disconnected" id=d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0 namespace=moby May 14 05:09:13.254416 containerd[2475]: time="2025-05-14T05:09:13.254313657Z" level=warning msg="cleaning up after shim disconnected" id=d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0 namespace=moby May 14 05:09:13.254416 containerd[2475]: time="2025-05-14T05:09:13.254323856Z" level=info msg="cleaning up dead shim" namespace=moby May 14 05:09:13.266122 containerd[2475]: time="2025-05-14T05:09:13.266068913Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 14 05:09:13.266237 containerd[2475]: time="2025-05-14T05:09:13.266208867Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 14 05:09:13.266276 containerd[2475]: time="2025-05-14T05:09:13.266238413Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 14 05:09:13.266276 containerd[2475]: time="2025-05-14T05:09:13.266253282Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 14 05:09:13.266276 containerd[2475]: time="2025-05-14T05:09:13.266264202Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 14 05:09:13.266276 containerd[2475]: time="2025-05-14T05:09:13.266274922Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 14 05:09:13.266357 containerd[2475]: time="2025-05-14T05:09:13.266293627Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 14 05:09:13.266357 containerd[2475]: time="2025-05-14T05:09:13.266305359Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 14 05:09:13.266357 containerd[2475]: time="2025-05-14T05:09:13.266315278Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 14 05:09:13.266357 containerd[2475]: time="2025-05-14T05:09:13.266325828Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 14 05:09:13.266357 containerd[2475]: time="2025-05-14T05:09:13.266336018Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 14 05:09:13.266357 containerd[2475]: time="2025-05-14T05:09:13.266345205Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 14 05:09:13.266471 containerd[2475]: time="2025-05-14T05:09:13.266403384Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 14 05:09:13.266471 containerd[2475]: time="2025-05-14T05:09:13.266416409Z" level=info msg="Start snapshots syncer" May 14 05:09:13.266471 containerd[2475]: time="2025-05-14T05:09:13.266451636Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 14 05:09:13.266688 containerd[2475]: time="2025-05-14T05:09:13.266649278Z" 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 05:09:13.266766 containerd[2475]: time="2025-05-14T05:09:13.266699704Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 14 05:09:13.266802 containerd[2475]: time="2025-05-14T05:09:13.266783332Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 14 05:09:13.266842 containerd[2475]: time="2025-05-14T05:09:13.266826914Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 14 05:09:13.266888 containerd[2475]: time="2025-05-14T05:09:13.266853404Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 14 05:09:13.266910 containerd[2475]: time="2025-05-14T05:09:13.266886947Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 14 05:09:13.266910 containerd[2475]: time="2025-05-14T05:09:13.266897106Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 14 05:09:13.266910 containerd[2475]: time="2025-05-14T05:09:13.266908538Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 14 05:09:13.266978 containerd[2475]: time="2025-05-14T05:09:13.266920109Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 14 05:09:13.266978 containerd[2475]: time="2025-05-14T05:09:13.266931611Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 14 05:09:13.266978 containerd[2475]: time="2025-05-14T05:09:13.266954896Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 14 05:09:13.266978 containerd[2475]: time="2025-05-14T05:09:13.266964584Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 14 05:09:13.266978 containerd[2475]: time="2025-05-14T05:09:13.266975564Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 14 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267010530Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 14 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267024327Z" 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 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267032783Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 14 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267043733Z" 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 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267052089Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 14 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267061076Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 14 05:09:13.267071 containerd[2475]: time="2025-05-14T05:09:13.267070654Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 14 05:09:13.267215 containerd[2475]: time="2025-05-14T05:09:13.267100510Z" level=info msg="runtime interface created" May 14 05:09:13.267215 containerd[2475]: time="2025-05-14T05:09:13.267106833Z" level=info msg="created NRI interface" May 14 05:09:13.267215 containerd[2475]: time="2025-05-14T05:09:13.267123133Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 14 05:09:13.267215 containerd[2475]: time="2025-05-14T05:09:13.267133793Z" level=info msg="Connect containerd service" May 14 05:09:13.267215 containerd[2475]: time="2025-05-14T05:09:13.267154843Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 14 05:09:13.267631 containerd[2475]: time="2025-05-14T05:09:13.267601786Z" 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 05:09:13.278831 containerd[2475]: time="2025-05-14T05:09:13.278722896Z" level=info msg="Start subscribing containerd event" May 14 05:09:13.278831 containerd[2475]: time="2025-05-14T05:09:13.278826531Z" level=info msg="Start recovering state" May 14 05:09:13.278977 containerd[2475]: time="2025-05-14T05:09:13.278951478Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 14 05:09:13.279054 containerd[2475]: time="2025-05-14T05:09:13.278967207Z" level=info msg="Start event monitor" May 14 05:09:13.279054 containerd[2475]: time="2025-05-14T05:09:13.279051236Z" level=info msg="Start cni network conf syncer for default" May 14 05:09:13.279054 containerd[2475]: time="2025-05-14T05:09:13.279061896Z" level=info msg="Start streaming server" May 14 05:09:13.279215 containerd[2475]: time="2025-05-14T05:09:13.279077495Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 14 05:09:13.279215 containerd[2475]: time="2025-05-14T05:09:13.279085931Z" level=info msg="runtime interface starting up..." May 14 05:09:13.279215 containerd[2475]: time="2025-05-14T05:09:13.279091833Z" level=info msg="starting plugins..." May 14 05:09:13.279215 containerd[2475]: time="2025-05-14T05:09:13.279102884Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 14 05:09:13.279215 containerd[2475]: time="2025-05-14T05:09:13.279015960Z" level=info msg=serving... address=/run/containerd/containerd.sock May 14 05:09:13.279343 systemd[1]: Started containerd.service - containerd container runtime. May 14 05:09:13.279818 containerd[2475]: time="2025-05-14T05:09:13.279792786Z" level=info msg="containerd successfully booted in 0.055159s" May 14 05:09:13.281062 systemd[1]: Starting docker.service - Docker Application Container Engine... May 14 05:09:13.295162 (dockerd)[2522]: 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 05:09:13.322229 dockerd[2522]: time="2025-05-14T05:09:13.322173023Z" level=info msg="Starting up" May 14 05:09:13.322832 dockerd[2522]: time="2025-05-14T05:09:13.322797181Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 14 05:09:13.558891 dockerd[2522]: time="2025-05-14T05:09:13.558778586Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 14 05:09:13.582247 dockerd[2522]: time="2025-05-14T05:09:13.582191384Z" level=info msg="Loading containers: start." May 14 05:09:13.904343 systemd[1]: var-lib-docker-overlay2-91c413ac17a69bc11b1e0f405e7cb3b4da51bf26367258b7cfbabcc07da70fba-merged.mount: Deactivated successfully. May 14 05:09:14.582939 systemd[1]: run-docker-netns-38528a70dd96.mount: Deactivated successfully. May 14 05:09:14.583020 systemd-networkd[1418]: veth7c7035f: Link DOWN May 14 05:09:14.583024 systemd-networkd[1418]: veth7c7035f: Lost carrier May 14 05:09:14.584224 kernel: docker0: port 1(veth7c7035f) entered disabled state May 14 05:09:14.584271 kernel: veth7c7035f (unregistering): left allmulticast mode May 14 05:09:14.584289 kernel: veth7c7035f (unregistering): left promiscuous mode May 14 05:09:14.584964 kernel: docker0: port 1(veth7c7035f) entered disabled state May 14 05:09:14.586932 systemd-networkd[1418]: docker0: Lost carrier May 14 05:09:14.588927 dockerd[2522]: time="2025-05-14T05:09:14.587507984Z" level=info msg="Removing stale sandbox 38528a70dd962424d3296639e51b9981fce6ee7e25ebb0309a344a8390c58b7f (d97c141b9533d9faabad24bea279e15cac8680f60c6f1b7528255478480c53b0)" May 14 05:09:14.593737 dockerd[2522]: time="2025-05-14T05:09:14.593707340Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 14 05:09:14.593789 dockerd[2522]: time="2025-05-14T05:09:14.593737476Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 4f09cff8300ee1b3d9dbd99f4ba2c5e60ba45bcf1519b865590b778c79465bc9 e48f23090fde1b69973197b47e869776543496118c3a7f11d56923e57a138990], retrying...." May 14 05:09:14.597834 systemd[1]: run-docker-netns-38528a70dd96.mount: Deactivated successfully. May 14 05:09:14.749076 dockerd[2522]: time="2025-05-14T05:09:14.749030668Z" level=warning msg="error locating sandbox id 8ef65df0822aad74d68844d1032bedd50a0d1769905bedb6422a21d39acbc878: sandbox 8ef65df0822aad74d68844d1032bedd50a0d1769905bedb6422a21d39acbc878 not found" May 14 05:09:14.749076 dockerd[2522]: time="2025-05-14T05:09:14.749069080Z" level=warning msg="error locating sandbox id 38528a70dd962424d3296639e51b9981fce6ee7e25ebb0309a344a8390c58b7f: sandbox 38528a70dd962424d3296639e51b9981fce6ee7e25ebb0309a344a8390c58b7f not found" May 14 05:09:14.749246 dockerd[2522]: time="2025-05-14T05:09:14.749206960Z" level=info msg="Loading containers: done." May 14 05:09:14.764476 dockerd[2522]: time="2025-05-14T05:09:14.764425221Z" 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 05:09:14.764655 dockerd[2522]: time="2025-05-14T05:09:14.764506946Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 14 05:09:14.764655 dockerd[2522]: time="2025-05-14T05:09:14.764544757Z" level=info msg="Initializing buildkit" May 14 05:09:14.780162 dockerd[2522]: time="2025-05-14T05:09:14.780125853Z" level=info msg="Completed buildkit initialization" May 14 05:09:14.784178 dockerd[2522]: time="2025-05-14T05:09:14.784144114Z" level=info msg="Daemon has completed initialization" May 14 05:09:14.784272 dockerd[2522]: time="2025-05-14T05:09:14.784217072Z" level=info msg="API listen on /run/docker.sock" May 14 05:09:14.784403 systemd[1]: Started docker.service - Docker Application Container Engine. May 14 05:09:15.390671 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4040306741-merged.mount: Deactivated successfully. May 14 05:09:17.522482 systemd[1]: Started sshd@24-10.0.0.69:22-10.0.0.1:54510.service - OpenSSH per-connection server daemon (10.0.0.1:54510). May 14 05:09:17.571708 sshd[2743]: Accepted publickey for core from 10.0.0.1 port 54510 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:09:17.573063 sshd-session[2743]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:09:17.577096 systemd-logind[1464]: New session 25 of user core. May 14 05:09:17.587981 systemd[1]: Started session-25.scope - Session 25 of User core. May 14 05:09:17.642289 sshd[2745]: Connection closed by 10.0.0.1 port 54510 May 14 05:09:17.642603 sshd-session[2743]: pam_unix(sshd:session): session closed for user core May 14 05:09:17.650363 systemd[1]: sshd@24-10.0.0.69:22-10.0.0.1:54510.service: Deactivated successfully. May 14 05:09:17.651988 systemd[1]: session-25.scope: Deactivated successfully. May 14 05:09:17.652673 systemd-logind[1464]: Session 25 logged out. Waiting for processes to exit. May 14 05:09:17.655415 systemd[1]: Started sshd@25-10.0.0.69:22-10.0.0.1:54512.service - OpenSSH per-connection server daemon (10.0.0.1:54512). May 14 05:09:17.655975 systemd-logind[1464]: Removed session 25. May 14 05:09:17.706087 sshd[2751]: Accepted publickey for core from 10.0.0.1 port 54512 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:09:17.707391 sshd-session[2751]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:09:17.711059 systemd-logind[1464]: New session 26 of user core. May 14 05:09:17.721974 systemd[1]: Started session-26.scope - Session 26 of User core. May 14 05:09:17.776632 sshd[2753]: Connection closed by 10.0.0.1 port 54512 May 14 05:09:17.776880 sshd-session[2751]: pam_unix(sshd:session): session closed for user core May 14 05:09:17.785318 systemd[1]: sshd@25-10.0.0.69:22-10.0.0.1:54512.service: Deactivated successfully. May 14 05:09:17.786993 systemd[1]: session-26.scope: Deactivated successfully. May 14 05:09:17.787646 systemd-logind[1464]: Session 26 logged out. Waiting for processes to exit. May 14 05:09:17.790386 systemd[1]: Started sshd@26-10.0.0.69:22-10.0.0.1:54520.service - OpenSSH per-connection server daemon (10.0.0.1:54520). May 14 05:09:17.790901 systemd-logind[1464]: Removed session 26. May 14 05:09:17.834978 sshd[2759]: Accepted publickey for core from 10.0.0.1 port 54520 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:09:17.836361 sshd-session[2759]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:09:17.840359 systemd-logind[1464]: New session 27 of user core. May 14 05:09:17.853978 systemd[1]: Started session-27.scope - Session 27 of User core. May 14 05:09:17.915481 sshd[2761]: Connection closed by 10.0.0.1 port 54520 May 14 05:09:17.915855 sshd-session[2759]: pam_unix(sshd:session): session closed for user core May 14 05:09:17.929613 systemd[1]: sshd@26-10.0.0.69:22-10.0.0.1:54520.service: Deactivated successfully. May 14 05:09:17.931377 systemd[1]: session-27.scope: Deactivated successfully. May 14 05:09:17.932192 systemd-logind[1464]: Session 27 logged out. Waiting for processes to exit. May 14 05:09:17.935186 systemd[1]: Started sshd@27-10.0.0.69:22-10.0.0.1:54530.service - OpenSSH per-connection server daemon (10.0.0.1:54530). May 14 05:09:17.935904 systemd-logind[1464]: Removed session 27. May 14 05:09:17.996578 sshd[2774]: Accepted publickey for core from 10.0.0.1 port 54530 ssh2: RSA SHA256:9779yoEmBEYtokxLadky4y4rhX8tiwkjz8vWSk0iWXU May 14 05:09:17.998014 sshd-session[2774]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 05:09:18.002412 systemd-logind[1464]: New session 28 of user core. May 14 05:09:18.011967 systemd[1]: Started session-28.scope - Session 28 of User core. May 14 05:09:18.267961 systemd[1]: var-lib-docker-overlay2-5a01b43a2cb3f196f98722eb259afe43b3cad709794e092ecfb7f30821b9cf5f\x2dinit-merged.mount: Deactivated successfully. May 14 05:09:18.544547 containerd[2475]: time="2025-05-14T05:09:18.544417044Z" level=info msg="connecting to shim 6c5e6f83d33883772bef279ae7db96ef570c14e8bd39e0246ce9fc2a95007cd8" address="unix:///run/containerd/s/75cdf596391a7beaa9f9ab4e9bf62721ff85ef5dabeca938523195a157bfd26b" namespace=moby protocol=ttrpc version=3 May 14 05:09:18.575152 systemd[1]: Started docker-6c5e6f83d33883772bef279ae7db96ef570c14e8bd39e0246ce9fc2a95007cd8.scope - libcontainer container 6c5e6f83d33883772bef279ae7db96ef570c14e8bd39e0246ce9fc2a95007cd8. May 14 05:09:18.588251 systemd-resolved[1353]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 14 05:09:18.610038 kernel: docker0: port 1(vethaa65e07) entered blocking state May 14 05:09:18.610147 kernel: docker0: port 1(vethaa65e07) entered disabled state May 14 05:09:18.610166 kernel: vethaa65e07: entered allmulticast mode May 14 05:09:18.611376 kernel: vethaa65e07: entered promiscuous mode May 14 05:09:18.611615 systemd-networkd[1418]: vethaa65e07: Link UP May 14 05:09:18.617957 kernel: eth0: renamed from veth6ddca92 May 14 05:09:18.620494 kernel: docker0: port 1(vethaa65e07) entered blocking state May 14 05:09:18.620537 kernel: docker0: port 1(vethaa65e07) entered forwarding state May 14 05:09:18.620515 systemd-networkd[1418]: vethaa65e07: Gained carrier May 14 05:09:18.621191 systemd-networkd[1418]: docker0: Gained carrier May 14 05:09:18.648646 sshd[2776]: Connection closed by 10.0.0.1 port 54530 May 14 05:09:18.649291 sshd-session[2774]: pam_unix(sshd:session): session closed for user core May 14 05:09:18.652840 systemd[1]: sshd@27-10.0.0.69:22-10.0.0.1:54530.service: Deactivated successfully. May 14 05:09:18.654924 systemd[1]: session-28.scope: Deactivated successfully. May 14 05:09:18.657311 systemd-logind[1464]: Session 28 logged out. Waiting for processes to exit. May 14 05:09:18.658425 systemd-logind[1464]: Removed session 28. May 14 05:09:19.796084 systemd-networkd[1418]: vethaa65e07: Gained IPv6LL