Sep 4 00:03:26.855584 kernel: Linux version 6.12.44-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 Sep 3 22:05:39 -00 2025 Sep 4 00:03:26.855611 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=c7fa427551c105672074cbcbe7e23c997f471a6e879d708e8d6cbfad2147666e Sep 4 00:03:26.855625 kernel: BIOS-provided physical RAM map: Sep 4 00:03:26.855635 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000002ffff] usable Sep 4 00:03:26.855643 kernel: BIOS-e820: [mem 0x0000000000030000-0x000000000004ffff] reserved Sep 4 00:03:26.855652 kernel: BIOS-e820: [mem 0x0000000000050000-0x000000000009efff] usable Sep 4 00:03:26.855663 kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved Sep 4 00:03:26.855672 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009b8ecfff] usable Sep 4 00:03:26.855681 kernel: BIOS-e820: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Sep 4 00:03:26.855690 kernel: BIOS-e820: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Sep 4 00:03:26.855699 kernel: BIOS-e820: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Sep 4 00:03:26.855711 kernel: BIOS-e820: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Sep 4 00:03:26.855720 kernel: BIOS-e820: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Sep 4 00:03:26.855729 kernel: BIOS-e820: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Sep 4 00:03:26.855740 kernel: BIOS-e820: [mem 0x000000009bfb7000-0x000000009bffffff] usable Sep 4 00:03:26.855750 kernel: BIOS-e820: [mem 0x000000009c000000-0x000000009cffffff] reserved Sep 4 00:03:26.855762 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Sep 4 00:03:26.855772 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 4 00:03:26.855782 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Sep 4 00:03:26.855791 kernel: NX (Execute Disable) protection: active Sep 4 00:03:26.855801 kernel: APIC: Static calls initialized Sep 4 00:03:26.855811 kernel: e820: update [mem 0x9a13e018-0x9a147c57] usable ==> usable Sep 4 00:03:26.855821 kernel: e820: update [mem 0x9a101018-0x9a13de57] usable ==> usable Sep 4 00:03:26.855830 kernel: extended physical RAM map: Sep 4 00:03:26.855840 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000002ffff] usable Sep 4 00:03:26.855850 kernel: reserve setup_data: [mem 0x0000000000030000-0x000000000004ffff] reserved Sep 4 00:03:26.855859 kernel: reserve setup_data: [mem 0x0000000000050000-0x000000000009efff] usable Sep 4 00:03:26.855871 kernel: reserve setup_data: [mem 0x000000000009f000-0x000000000009ffff] reserved Sep 4 00:03:26.855881 kernel: reserve setup_data: [mem 0x0000000000100000-0x000000009a101017] usable Sep 4 00:03:26.855891 kernel: reserve setup_data: [mem 0x000000009a101018-0x000000009a13de57] usable Sep 4 00:03:26.855900 kernel: reserve setup_data: [mem 0x000000009a13de58-0x000000009a13e017] usable Sep 4 00:03:26.855910 kernel: reserve setup_data: [mem 0x000000009a13e018-0x000000009a147c57] usable Sep 4 00:03:26.855920 kernel: reserve setup_data: [mem 0x000000009a147c58-0x000000009b8ecfff] usable Sep 4 00:03:26.855929 kernel: reserve setup_data: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Sep 4 00:03:26.855939 kernel: reserve setup_data: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Sep 4 00:03:26.855948 kernel: reserve setup_data: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Sep 4 00:03:26.855958 kernel: reserve setup_data: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Sep 4 00:03:26.855968 kernel: reserve setup_data: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Sep 4 00:03:26.855980 kernel: reserve setup_data: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Sep 4 00:03:26.855992 kernel: reserve setup_data: [mem 0x000000009bfb7000-0x000000009bffffff] usable Sep 4 00:03:26.856008 kernel: reserve setup_data: [mem 0x000000009c000000-0x000000009cffffff] reserved Sep 4 00:03:26.856019 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Sep 4 00:03:26.856029 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 4 00:03:26.856039 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Sep 4 00:03:26.856051 kernel: efi: EFI v2.7 by EDK II Sep 4 00:03:26.856062 kernel: efi: SMBIOS=0x9b9d5000 ACPI=0x9bb7e000 ACPI 2.0=0x9bb7e014 MEMATTR=0x9a1af018 RNG=0x9bb73018 Sep 4 00:03:26.856072 kernel: random: crng init done Sep 4 00:03:26.856082 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Sep 4 00:03:26.856092 kernel: secureboot: Secure boot enabled Sep 4 00:03:26.856102 kernel: SMBIOS 2.8 present. Sep 4 00:03:26.856112 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Sep 4 00:03:26.856122 kernel: DMI: Memory slots populated: 1/1 Sep 4 00:03:26.856132 kernel: Hypervisor detected: KVM Sep 4 00:03:26.856142 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 4 00:03:26.856180 kernel: kvm-clock: using sched offset of 5008341697 cycles Sep 4 00:03:26.856191 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 4 00:03:26.856201 kernel: tsc: Detected 2794.748 MHz processor Sep 4 00:03:26.856212 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 4 00:03:26.856222 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 4 00:03:26.856244 kernel: last_pfn = 0x9c000 max_arch_pfn = 0x400000000 Sep 4 00:03:26.856255 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Sep 4 00:03:26.856266 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 4 00:03:26.856276 kernel: Using GB pages for direct mapping Sep 4 00:03:26.856286 kernel: ACPI: Early table checksum verification disabled Sep 4 00:03:26.856299 kernel: ACPI: RSDP 0x000000009BB7E014 000024 (v02 BOCHS ) Sep 4 00:03:26.856310 kernel: ACPI: XSDT 0x000000009BB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Sep 4 00:03:26.856321 kernel: ACPI: FACP 0x000000009BB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 00:03:26.856331 kernel: ACPI: DSDT 0x000000009BB7A000 002237 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 00:03:26.856341 kernel: ACPI: FACS 0x000000009BBDD000 000040 Sep 4 00:03:26.856352 kernel: ACPI: APIC 0x000000009BB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 00:03:26.856362 kernel: ACPI: HPET 0x000000009BB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 00:03:26.856372 kernel: ACPI: MCFG 0x000000009BB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 00:03:26.856385 kernel: ACPI: WAET 0x000000009BB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 00:03:26.856395 kernel: ACPI: BGRT 0x000000009BB74000 000038 (v01 INTEL EDK2 00000002 01000013) Sep 4 00:03:26.856405 kernel: ACPI: Reserving FACP table memory at [mem 0x9bb79000-0x9bb790f3] Sep 4 00:03:26.856416 kernel: ACPI: Reserving DSDT table memory at [mem 0x9bb7a000-0x9bb7c236] Sep 4 00:03:26.856426 kernel: ACPI: Reserving FACS table memory at [mem 0x9bbdd000-0x9bbdd03f] Sep 4 00:03:26.856436 kernel: ACPI: Reserving APIC table memory at [mem 0x9bb78000-0x9bb7808f] Sep 4 00:03:26.856446 kernel: ACPI: Reserving HPET table memory at [mem 0x9bb77000-0x9bb77037] Sep 4 00:03:26.856457 kernel: ACPI: Reserving MCFG table memory at [mem 0x9bb76000-0x9bb7603b] Sep 4 00:03:26.856467 kernel: ACPI: Reserving WAET table memory at [mem 0x9bb75000-0x9bb75027] Sep 4 00:03:26.856477 kernel: ACPI: Reserving BGRT table memory at [mem 0x9bb74000-0x9bb74037] Sep 4 00:03:26.856489 kernel: No NUMA configuration found Sep 4 00:03:26.856500 kernel: Faking a node at [mem 0x0000000000000000-0x000000009bffffff] Sep 4 00:03:26.856510 kernel: NODE_DATA(0) allocated [mem 0x9bf57dc0-0x9bf5efff] Sep 4 00:03:26.856520 kernel: Zone ranges: Sep 4 00:03:26.856531 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 4 00:03:26.856541 kernel: DMA32 [mem 0x0000000001000000-0x000000009bffffff] Sep 4 00:03:26.856551 kernel: Normal empty Sep 4 00:03:26.856561 kernel: Device empty Sep 4 00:03:26.856572 kernel: Movable zone start for each node Sep 4 00:03:26.856584 kernel: Early memory node ranges Sep 4 00:03:26.856594 kernel: node 0: [mem 0x0000000000001000-0x000000000002ffff] Sep 4 00:03:26.856605 kernel: node 0: [mem 0x0000000000050000-0x000000000009efff] Sep 4 00:03:26.856615 kernel: node 0: [mem 0x0000000000100000-0x000000009b8ecfff] Sep 4 00:03:26.856625 kernel: node 0: [mem 0x000000009bbff000-0x000000009bfb0fff] Sep 4 00:03:26.856635 kernel: node 0: [mem 0x000000009bfb7000-0x000000009bffffff] Sep 4 00:03:26.856645 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009bffffff] Sep 4 00:03:26.856656 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 4 00:03:26.856666 kernel: On node 0, zone DMA: 32 pages in unavailable ranges Sep 4 00:03:26.856678 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Sep 4 00:03:26.856689 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Sep 4 00:03:26.856699 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Sep 4 00:03:26.856709 kernel: On node 0, zone DMA32: 16384 pages in unavailable ranges Sep 4 00:03:26.856719 kernel: ACPI: PM-Timer IO Port: 0x608 Sep 4 00:03:26.856730 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 4 00:03:26.856740 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 4 00:03:26.856750 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 4 00:03:26.856761 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 4 00:03:26.856771 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 4 00:03:26.856783 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 4 00:03:26.856794 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 4 00:03:26.856804 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 4 00:03:26.856815 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 4 00:03:26.856825 kernel: TSC deadline timer available Sep 4 00:03:26.856835 kernel: CPU topo: Max. logical packages: 1 Sep 4 00:03:26.856845 kernel: CPU topo: Max. logical dies: 1 Sep 4 00:03:26.856858 kernel: CPU topo: Max. dies per package: 1 Sep 4 00:03:26.856876 kernel: CPU topo: Max. threads per core: 1 Sep 4 00:03:26.856887 kernel: CPU topo: Num. cores per package: 4 Sep 4 00:03:26.856898 kernel: CPU topo: Num. threads per package: 4 Sep 4 00:03:26.856908 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Sep 4 00:03:26.856921 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Sep 4 00:03:26.856932 kernel: kvm-guest: KVM setup pv remote TLB flush Sep 4 00:03:26.856943 kernel: kvm-guest: setup PV sched yield Sep 4 00:03:26.856954 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Sep 4 00:03:26.856964 kernel: Booting paravirtualized kernel on KVM Sep 4 00:03:26.856978 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 4 00:03:26.856989 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Sep 4 00:03:26.857000 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Sep 4 00:03:26.857010 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Sep 4 00:03:26.857020 kernel: pcpu-alloc: [0] 0 1 2 3 Sep 4 00:03:26.857031 kernel: kvm-guest: PV spinlocks enabled Sep 4 00:03:26.857042 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 4 00:03:26.857054 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=c7fa427551c105672074cbcbe7e23c997f471a6e879d708e8d6cbfad2147666e Sep 4 00:03:26.857068 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 4 00:03:26.857079 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 00:03:26.857090 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 00:03:26.857100 kernel: Fallback order for Node 0: 0 Sep 4 00:03:26.857111 kernel: Built 1 zonelists, mobility grouping on. Total pages: 638054 Sep 4 00:03:26.857122 kernel: Policy zone: DMA32 Sep 4 00:03:26.857132 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 00:03:26.857143 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 4 00:03:26.857221 kernel: ftrace: allocating 40099 entries in 157 pages Sep 4 00:03:26.857246 kernel: ftrace: allocated 157 pages with 5 groups Sep 4 00:03:26.857257 kernel: Dynamic Preempt: voluntary Sep 4 00:03:26.857268 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 00:03:26.857279 kernel: rcu: RCU event tracing is enabled. Sep 4 00:03:26.857290 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 4 00:03:26.857301 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 00:03:26.857312 kernel: Rude variant of Tasks RCU enabled. Sep 4 00:03:26.857323 kernel: Tracing variant of Tasks RCU enabled. Sep 4 00:03:26.857334 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 00:03:26.857347 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 4 00:03:26.857358 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 4 00:03:26.857369 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 4 00:03:26.857380 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 4 00:03:26.857391 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Sep 4 00:03:26.857401 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 00:03:26.857412 kernel: Console: colour dummy device 80x25 Sep 4 00:03:26.857423 kernel: printk: legacy console [ttyS0] enabled Sep 4 00:03:26.857433 kernel: ACPI: Core revision 20240827 Sep 4 00:03:26.857447 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 4 00:03:26.857457 kernel: APIC: Switch to symmetric I/O mode setup Sep 4 00:03:26.857468 kernel: x2apic enabled Sep 4 00:03:26.857479 kernel: APIC: Switched APIC routing to: physical x2apic Sep 4 00:03:26.857490 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Sep 4 00:03:26.857501 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Sep 4 00:03:26.857511 kernel: kvm-guest: setup PV IPIs Sep 4 00:03:26.857522 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 4 00:03:26.857533 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Sep 4 00:03:26.857546 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Sep 4 00:03:26.857557 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 4 00:03:26.857568 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Sep 4 00:03:26.857579 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Sep 4 00:03:26.857590 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 4 00:03:26.857600 kernel: Spectre V2 : Mitigation: Retpolines Sep 4 00:03:26.857611 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 4 00:03:26.857622 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Sep 4 00:03:26.857633 kernel: active return thunk: retbleed_return_thunk Sep 4 00:03:26.857646 kernel: RETBleed: Mitigation: untrained return thunk Sep 4 00:03:26.857657 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Sep 4 00:03:26.857668 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Sep 4 00:03:26.857679 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Sep 4 00:03:26.857691 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Sep 4 00:03:26.857711 kernel: active return thunk: srso_return_thunk Sep 4 00:03:26.857723 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Sep 4 00:03:26.857734 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 4 00:03:26.857763 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 4 00:03:26.857774 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 4 00:03:26.857785 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 4 00:03:26.857796 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Sep 4 00:03:26.857807 kernel: Freeing SMP alternatives memory: 32K Sep 4 00:03:26.857832 kernel: pid_max: default: 32768 minimum: 301 Sep 4 00:03:26.857843 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 4 00:03:26.857854 kernel: landlock: Up and running. Sep 4 00:03:26.857865 kernel: SELinux: Initializing. Sep 4 00:03:26.857878 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 00:03:26.857890 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 00:03:26.857901 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Sep 4 00:03:26.857912 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Sep 4 00:03:26.857923 kernel: ... version: 0 Sep 4 00:03:26.857934 kernel: ... bit width: 48 Sep 4 00:03:26.857945 kernel: ... generic registers: 6 Sep 4 00:03:26.857956 kernel: ... value mask: 0000ffffffffffff Sep 4 00:03:26.857967 kernel: ... max period: 00007fffffffffff Sep 4 00:03:26.857980 kernel: ... fixed-purpose events: 0 Sep 4 00:03:26.857991 kernel: ... event mask: 000000000000003f Sep 4 00:03:26.858002 kernel: signal: max sigframe size: 1776 Sep 4 00:03:26.858013 kernel: rcu: Hierarchical SRCU implementation. Sep 4 00:03:26.858024 kernel: rcu: Max phase no-delay instances is 400. Sep 4 00:03:26.858035 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 4 00:03:26.858046 kernel: smp: Bringing up secondary CPUs ... Sep 4 00:03:26.858057 kernel: smpboot: x86: Booting SMP configuration: Sep 4 00:03:26.858068 kernel: .... node #0, CPUs: #1 #2 #3 Sep 4 00:03:26.858082 kernel: smp: Brought up 1 node, 4 CPUs Sep 4 00:03:26.858093 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Sep 4 00:03:26.858104 kernel: Memory: 2411272K/2552216K available (14336K kernel code, 2428K rwdata, 9956K rodata, 53832K init, 1088K bss, 135016K reserved, 0K cma-reserved) Sep 4 00:03:26.858115 kernel: devtmpfs: initialized Sep 4 00:03:26.858126 kernel: x86/mm: Memory block size: 128MB Sep 4 00:03:26.858137 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bb7f000-0x9bbfefff] (524288 bytes) Sep 4 00:03:26.858160 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bfb5000-0x9bfb6fff] (8192 bytes) Sep 4 00:03:26.858172 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 00:03:26.858183 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 4 00:03:26.858197 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 00:03:26.858207 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 00:03:26.858218 kernel: audit: initializing netlink subsys (disabled) Sep 4 00:03:26.858238 kernel: audit: type=2000 audit(1756944204.396:1): state=initialized audit_enabled=0 res=1 Sep 4 00:03:26.858249 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 00:03:26.858260 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 4 00:03:26.858271 kernel: cpuidle: using governor menu Sep 4 00:03:26.858282 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 00:03:26.858292 kernel: dca service started, version 1.12.1 Sep 4 00:03:26.858306 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Sep 4 00:03:26.858317 kernel: PCI: Using configuration type 1 for base access Sep 4 00:03:26.858328 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 4 00:03:26.858339 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 00:03:26.858350 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 00:03:26.858361 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 00:03:26.858372 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 00:03:26.858383 kernel: ACPI: Added _OSI(Module Device) Sep 4 00:03:26.858393 kernel: ACPI: Added _OSI(Processor Device) Sep 4 00:03:26.858407 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 00:03:26.858417 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 00:03:26.858428 kernel: ACPI: Interpreter enabled Sep 4 00:03:26.858439 kernel: ACPI: PM: (supports S0 S5) Sep 4 00:03:26.858450 kernel: ACPI: Using IOAPIC for interrupt routing Sep 4 00:03:26.858461 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 4 00:03:26.858472 kernel: PCI: Using E820 reservations for host bridge windows Sep 4 00:03:26.858483 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Sep 4 00:03:26.858494 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 4 00:03:26.858704 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 00:03:26.858855 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Sep 4 00:03:26.859005 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Sep 4 00:03:26.859022 kernel: PCI host bridge to bus 0000:00 Sep 4 00:03:26.859195 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 4 00:03:26.859373 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 4 00:03:26.859560 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 4 00:03:26.859717 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Sep 4 00:03:26.859852 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Sep 4 00:03:26.859986 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Sep 4 00:03:26.860123 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 4 00:03:26.860335 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Sep 4 00:03:26.860497 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Sep 4 00:03:26.860652 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Sep 4 00:03:26.860800 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Sep 4 00:03:26.860949 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Sep 4 00:03:26.861099 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 4 00:03:26.861294 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 4 00:03:26.861497 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Sep 4 00:03:26.861649 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Sep 4 00:03:26.861802 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Sep 4 00:03:26.861961 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Sep 4 00:03:26.862114 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Sep 4 00:03:26.862293 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Sep 4 00:03:26.862443 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Sep 4 00:03:26.862602 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Sep 4 00:03:26.862810 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Sep 4 00:03:26.862963 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Sep 4 00:03:26.863113 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Sep 4 00:03:26.863293 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Sep 4 00:03:26.863452 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Sep 4 00:03:26.863602 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Sep 4 00:03:26.863758 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Sep 4 00:03:26.863911 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Sep 4 00:03:26.864060 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Sep 4 00:03:26.864274 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Sep 4 00:03:26.864427 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Sep 4 00:03:26.864443 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Sep 4 00:03:26.864455 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 4 00:03:26.864466 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 4 00:03:26.864481 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Sep 4 00:03:26.864492 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Sep 4 00:03:26.864503 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Sep 4 00:03:26.864514 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Sep 4 00:03:26.864525 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Sep 4 00:03:26.864536 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Sep 4 00:03:26.864547 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Sep 4 00:03:26.864558 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Sep 4 00:03:26.864569 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Sep 4 00:03:26.864583 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Sep 4 00:03:26.864594 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Sep 4 00:03:26.864605 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Sep 4 00:03:26.864616 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Sep 4 00:03:26.864627 kernel: iommu: Default domain type: Translated Sep 4 00:03:26.864638 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 4 00:03:26.864649 kernel: efivars: Registered efivars operations Sep 4 00:03:26.864659 kernel: PCI: Using ACPI for IRQ routing Sep 4 00:03:26.864670 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 4 00:03:26.864682 kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] Sep 4 00:03:26.864696 kernel: e820: reserve RAM buffer [mem 0x9a101018-0x9bffffff] Sep 4 00:03:26.864707 kernel: e820: reserve RAM buffer [mem 0x9a13e018-0x9bffffff] Sep 4 00:03:26.864718 kernel: e820: reserve RAM buffer [mem 0x9b8ed000-0x9bffffff] Sep 4 00:03:26.864729 kernel: e820: reserve RAM buffer [mem 0x9bfb1000-0x9bffffff] Sep 4 00:03:26.864880 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Sep 4 00:03:26.865038 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Sep 4 00:03:26.865209 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 4 00:03:26.865225 kernel: vgaarb: loaded Sep 4 00:03:26.865252 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 4 00:03:26.865263 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 4 00:03:26.865274 kernel: clocksource: Switched to clocksource kvm-clock Sep 4 00:03:26.865285 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 00:03:26.865296 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 00:03:26.865307 kernel: pnp: PnP ACPI init Sep 4 00:03:26.865471 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Sep 4 00:03:26.865488 kernel: pnp: PnP ACPI: found 6 devices Sep 4 00:03:26.865503 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 4 00:03:26.865514 kernel: NET: Registered PF_INET protocol family Sep 4 00:03:26.865526 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 00:03:26.865537 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 00:03:26.865548 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 00:03:26.865559 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 00:03:26.865571 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 00:03:26.865582 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 00:03:26.865593 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 00:03:26.865606 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 00:03:26.865618 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 00:03:26.865629 kernel: NET: Registered PF_XDP protocol family Sep 4 00:03:26.865778 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Sep 4 00:03:26.865927 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Sep 4 00:03:26.866068 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 4 00:03:26.866248 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 4 00:03:26.866385 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 4 00:03:26.866517 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Sep 4 00:03:26.866646 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Sep 4 00:03:26.866783 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Sep 4 00:03:26.866797 kernel: PCI: CLS 0 bytes, default 64 Sep 4 00:03:26.866809 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Sep 4 00:03:26.866821 kernel: Initialise system trusted keyrings Sep 4 00:03:26.866832 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 00:03:26.866843 kernel: Key type asymmetric registered Sep 4 00:03:26.866858 kernel: Asymmetric key parser 'x509' registered Sep 4 00:03:26.866886 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 4 00:03:26.866900 kernel: io scheduler mq-deadline registered Sep 4 00:03:26.866911 kernel: io scheduler kyber registered Sep 4 00:03:26.866925 kernel: io scheduler bfq registered Sep 4 00:03:26.866936 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 4 00:03:26.866949 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Sep 4 00:03:26.866961 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Sep 4 00:03:26.866972 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Sep 4 00:03:26.866984 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 00:03:26.866998 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 4 00:03:26.867010 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 4 00:03:26.867021 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 4 00:03:26.867032 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 4 00:03:26.867044 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Sep 4 00:03:26.867218 kernel: rtc_cmos 00:04: RTC can wake from S4 Sep 4 00:03:26.867378 kernel: rtc_cmos 00:04: registered as rtc0 Sep 4 00:03:26.867516 kernel: rtc_cmos 00:04: setting system clock to 2025-09-04T00:03:26 UTC (1756944206) Sep 4 00:03:26.867657 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Sep 4 00:03:26.867673 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Sep 4 00:03:26.867685 kernel: efifb: probing for efifb Sep 4 00:03:26.867696 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Sep 4 00:03:26.867708 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Sep 4 00:03:26.867719 kernel: efifb: scrolling: redraw Sep 4 00:03:26.867731 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 4 00:03:26.867742 kernel: Console: switching to colour frame buffer device 160x50 Sep 4 00:03:26.867757 kernel: fb0: EFI VGA frame buffer device Sep 4 00:03:26.867771 kernel: pstore: Using crash dump compression: deflate Sep 4 00:03:26.867783 kernel: pstore: Registered efi_pstore as persistent store backend Sep 4 00:03:26.867794 kernel: NET: Registered PF_INET6 protocol family Sep 4 00:03:26.867806 kernel: Segment Routing with IPv6 Sep 4 00:03:26.867817 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 00:03:26.867832 kernel: NET: Registered PF_PACKET protocol family Sep 4 00:03:26.867843 kernel: Key type dns_resolver registered Sep 4 00:03:26.867855 kernel: IPI shorthand broadcast: enabled Sep 4 00:03:26.867866 kernel: sched_clock: Marking stable (2788002673, 137929881)->(2944254810, -18322256) Sep 4 00:03:26.867878 kernel: registered taskstats version 1 Sep 4 00:03:26.867890 kernel: Loading compiled-in X.509 certificates Sep 4 00:03:26.867902 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.44-flatcar: 247a8159a15e16f8eb89737aa66cd9cf9bbb3c10' Sep 4 00:03:26.867913 kernel: Demotion targets for Node 0: null Sep 4 00:03:26.867925 kernel: Key type .fscrypt registered Sep 4 00:03:26.867939 kernel: Key type fscrypt-provisioning registered Sep 4 00:03:26.867951 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 00:03:26.867962 kernel: ima: Allocated hash algorithm: sha1 Sep 4 00:03:26.867973 kernel: ima: No architecture policies found Sep 4 00:03:26.867985 kernel: clk: Disabling unused clocks Sep 4 00:03:26.867996 kernel: Warning: unable to open an initial console. Sep 4 00:03:26.868008 kernel: Freeing unused kernel image (initmem) memory: 53832K Sep 4 00:03:26.868019 kernel: Write protecting the kernel read-only data: 24576k Sep 4 00:03:26.868031 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Sep 4 00:03:26.868045 kernel: Run /init as init process Sep 4 00:03:26.868057 kernel: with arguments: Sep 4 00:03:26.868068 kernel: /init Sep 4 00:03:26.868079 kernel: with environment: Sep 4 00:03:26.868090 kernel: HOME=/ Sep 4 00:03:26.868101 kernel: TERM=linux Sep 4 00:03:26.868113 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 4 00:03:26.868125 systemd[1]: Successfully made /usr/ read-only. Sep 4 00:03:26.868144 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 4 00:03:26.868183 systemd[1]: Detected virtualization kvm. Sep 4 00:03:26.868195 systemd[1]: Detected architecture x86-64. Sep 4 00:03:26.868207 systemd[1]: Running in initrd. Sep 4 00:03:26.868219 systemd[1]: No hostname configured, using default hostname. Sep 4 00:03:26.868240 systemd[1]: Hostname set to . Sep 4 00:03:26.868253 systemd[1]: Initializing machine ID from VM UUID. Sep 4 00:03:26.868268 systemd[1]: Queued start job for default target initrd.target. Sep 4 00:03:26.868281 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 00:03:26.868294 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 00:03:26.868307 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 00:03:26.868319 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 00:03:26.868332 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 00:03:26.868345 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 00:03:26.868363 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 00:03:26.868375 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 00:03:26.868388 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 00:03:26.868400 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 00:03:26.868412 systemd[1]: Reached target paths.target - Path Units. Sep 4 00:03:26.868424 systemd[1]: Reached target slices.target - Slice Units. Sep 4 00:03:26.868436 systemd[1]: Reached target swap.target - Swaps. Sep 4 00:03:26.868448 systemd[1]: Reached target timers.target - Timer Units. Sep 4 00:03:26.868461 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 00:03:26.868476 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 00:03:26.868488 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 00:03:26.868500 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 4 00:03:26.868512 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 00:03:26.868525 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 00:03:26.868537 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 00:03:26.868549 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 00:03:26.868562 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 00:03:26.868576 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 00:03:26.868588 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 00:03:26.868601 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 4 00:03:26.868614 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 00:03:26.868626 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 00:03:26.868638 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 00:03:26.868651 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:03:26.868663 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 00:03:26.868679 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 00:03:26.868691 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 00:03:26.868704 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 00:03:26.868742 systemd-journald[220]: Collecting audit messages is disabled. Sep 4 00:03:26.868776 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:26.868789 systemd-journald[220]: Journal started Sep 4 00:03:26.868815 systemd-journald[220]: Runtime Journal (/run/log/journal/36a3b848af0d4f668d013f58b3f6a48b) is 6M, max 48.2M, 42.2M free. Sep 4 00:03:26.859671 systemd-modules-load[221]: Inserted module 'overlay' Sep 4 00:03:26.871261 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 00:03:26.876339 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 00:03:26.877115 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 00:03:26.888916 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 00:03:26.891270 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 00:03:26.897197 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 00:03:26.900747 systemd-modules-load[221]: Inserted module 'br_netfilter' Sep 4 00:03:26.901184 kernel: Bridge firewalling registered Sep 4 00:03:26.903293 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 00:03:26.906673 systemd-tmpfiles[242]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 4 00:03:26.909062 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 00:03:26.911737 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 00:03:26.916260 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 00:03:26.917745 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 00:03:26.921957 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 00:03:26.934316 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 00:03:26.937592 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 00:03:26.949472 dracut-cmdline[260]: 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=c7fa427551c105672074cbcbe7e23c997f471a6e879d708e8d6cbfad2147666e Sep 4 00:03:26.999665 systemd-resolved[263]: Positive Trust Anchors: Sep 4 00:03:26.999680 systemd-resolved[263]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 00:03:26.999709 systemd-resolved[263]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 4 00:03:27.002816 systemd-resolved[263]: Defaulting to hostname 'linux'. Sep 4 00:03:27.004069 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 00:03:27.010260 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 00:03:27.058245 kernel: SCSI subsystem initialized Sep 4 00:03:27.068199 kernel: Loading iSCSI transport class v2.0-870. Sep 4 00:03:27.079214 kernel: iscsi: registered transport (tcp) Sep 4 00:03:27.101207 kernel: iscsi: registered transport (qla4xxx) Sep 4 00:03:27.101291 kernel: QLogic iSCSI HBA Driver Sep 4 00:03:27.123431 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 00:03:27.150556 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 00:03:27.164583 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 00:03:27.219210 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 00:03:27.220697 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 00:03:27.281188 kernel: raid6: avx2x4 gen() 18481 MB/s Sep 4 00:03:27.298178 kernel: raid6: avx2x2 gen() 29775 MB/s Sep 4 00:03:27.315230 kernel: raid6: avx2x1 gen() 24098 MB/s Sep 4 00:03:27.315271 kernel: raid6: using algorithm avx2x2 gen() 29775 MB/s Sep 4 00:03:27.333402 kernel: raid6: .... xor() 16285 MB/s, rmw enabled Sep 4 00:03:27.333476 kernel: raid6: using avx2x2 recovery algorithm Sep 4 00:03:27.358185 kernel: xor: automatically using best checksumming function avx Sep 4 00:03:27.530184 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 00:03:27.538662 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 00:03:27.541737 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 00:03:27.589649 systemd-udevd[472]: Using default interface naming scheme 'v255'. Sep 4 00:03:27.594932 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 00:03:27.599095 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 00:03:27.632460 dracut-pre-trigger[481]: rd.md=0: removing MD RAID activation Sep 4 00:03:27.662494 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 00:03:27.665043 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 00:03:27.741621 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 00:03:27.745083 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 00:03:27.787194 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Sep 4 00:03:27.803455 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 4 00:03:27.806179 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 00:03:27.807176 kernel: cryptd: max_cpu_qlen set to 1000 Sep 4 00:03:27.819256 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Sep 4 00:03:27.829306 kernel: AES CTR mode by8 optimization enabled Sep 4 00:03:27.830833 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:03:27.832224 kernel: libata version 3.00 loaded. Sep 4 00:03:27.830999 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:27.835359 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:03:27.842531 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:03:27.849392 kernel: ahci 0000:00:1f.2: version 3.0 Sep 4 00:03:27.849611 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Sep 4 00:03:27.849634 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Sep 4 00:03:27.848049 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 4 00:03:27.856787 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Sep 4 00:03:27.862440 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Sep 4 00:03:27.862736 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:03:27.862861 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:27.870559 kernel: scsi host0: ahci Sep 4 00:03:27.868597 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:03:27.873196 kernel: scsi host1: ahci Sep 4 00:03:27.879188 kernel: scsi host2: ahci Sep 4 00:03:27.884198 kernel: scsi host3: ahci Sep 4 00:03:27.884394 kernel: scsi host4: ahci Sep 4 00:03:27.884835 kernel: scsi host5: ahci Sep 4 00:03:27.886891 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 1 Sep 4 00:03:27.886917 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 1 Sep 4 00:03:27.889060 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 1 Sep 4 00:03:27.889075 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 1 Sep 4 00:03:27.891195 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 1 Sep 4 00:03:27.892274 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 1 Sep 4 00:03:27.896060 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 4 00:03:27.910258 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:27.921624 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 4 00:03:27.928782 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 4 00:03:27.928847 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 4 00:03:27.940446 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 00:03:27.942814 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 00:03:27.965179 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 00:03:27.970161 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 00:03:28.202613 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 4 00:03:28.202702 kernel: ata2: SATA link down (SStatus 0 SControl 300) Sep 4 00:03:28.202721 kernel: ata1: SATA link down (SStatus 0 SControl 300) Sep 4 00:03:28.202738 kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 4 00:03:28.204183 kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 4 00:03:28.205188 kernel: ata6: SATA link down (SStatus 0 SControl 300) Sep 4 00:03:28.205214 kernel: ata3.00: LPM support broken, forcing max_power Sep 4 00:03:28.206399 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 4 00:03:28.206423 kernel: ata3.00: applying bridge limits Sep 4 00:03:28.207535 kernel: ata3.00: LPM support broken, forcing max_power Sep 4 00:03:28.207550 kernel: ata3.00: configured for UDMA/100 Sep 4 00:03:28.210180 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 4 00:03:28.251187 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 4 00:03:28.251547 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 4 00:03:28.267207 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Sep 4 00:03:28.665710 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 00:03:28.667813 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 00:03:28.669232 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 00:03:28.672291 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 00:03:28.675713 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 00:03:28.717137 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 00:03:28.975945 disk-uuid[635]: The operation has completed successfully. Sep 4 00:03:28.977431 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 00:03:29.006235 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 00:03:29.006360 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 00:03:29.038729 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 00:03:29.068936 sh[664]: Success Sep 4 00:03:29.087687 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 00:03:29.087759 kernel: device-mapper: uevent: version 1.0.3 Sep 4 00:03:29.087772 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 4 00:03:29.098196 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 4 00:03:29.132424 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 00:03:29.135258 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 00:03:29.147728 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 00:03:29.154182 kernel: BTRFS: device fsid 8a9c2e34-3d3c-49a9-acce-59bf90003071 devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (676) Sep 4 00:03:29.156292 kernel: BTRFS info (device dm-0): first mount of filesystem 8a9c2e34-3d3c-49a9-acce-59bf90003071 Sep 4 00:03:29.156323 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 4 00:03:29.161204 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 00:03:29.161232 kernel: BTRFS info (device dm-0): enabling free space tree Sep 4 00:03:29.162472 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 00:03:29.163277 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 4 00:03:29.165375 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 4 00:03:29.166246 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 4 00:03:29.167914 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 00:03:29.194188 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (707) Sep 4 00:03:29.196412 kernel: BTRFS info (device vda6): first mount of filesystem 75efd3be-3398-4525-8f67-b36cc847539d Sep 4 00:03:29.196450 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 00:03:29.200199 kernel: BTRFS info (device vda6): turning on async discard Sep 4 00:03:29.200242 kernel: BTRFS info (device vda6): enabling free space tree Sep 4 00:03:29.206239 kernel: BTRFS info (device vda6): last unmount of filesystem 75efd3be-3398-4525-8f67-b36cc847539d Sep 4 00:03:29.207868 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 4 00:03:29.210179 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 00:03:29.299188 ignition[754]: Ignition 2.21.0 Sep 4 00:03:29.299200 ignition[754]: Stage: fetch-offline Sep 4 00:03:29.299231 ignition[754]: no configs at "/usr/lib/ignition/base.d" Sep 4 00:03:29.301297 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 00:03:29.299240 ignition[754]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 00:03:29.304843 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 00:03:29.299315 ignition[754]: parsed url from cmdline: "" Sep 4 00:03:29.299319 ignition[754]: no config URL provided Sep 4 00:03:29.299324 ignition[754]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 00:03:29.299331 ignition[754]: no config at "/usr/lib/ignition/user.ign" Sep 4 00:03:29.299352 ignition[754]: op(1): [started] loading QEMU firmware config module Sep 4 00:03:29.299357 ignition[754]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 4 00:03:29.308910 ignition[754]: op(1): [finished] loading QEMU firmware config module Sep 4 00:03:29.310647 ignition[754]: parsing config with SHA512: df675fb564bcee76c3a633fd54e18887e4ba8056a80ec8789e88cc645618f2e5b19a0c7956ade5595ca2a090ac5282820c3526654966a904d32314e3a06cdd1b Sep 4 00:03:29.317658 unknown[754]: fetched base config from "system" Sep 4 00:03:29.317670 unknown[754]: fetched user config from "qemu" Sep 4 00:03:29.317826 ignition[754]: fetch-offline: fetch-offline passed Sep 4 00:03:29.317898 ignition[754]: Ignition finished successfully Sep 4 00:03:29.323001 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 00:03:29.348855 systemd-networkd[854]: lo: Link UP Sep 4 00:03:29.348864 systemd-networkd[854]: lo: Gained carrier Sep 4 00:03:29.350367 systemd-networkd[854]: Enumeration completed Sep 4 00:03:29.350473 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 00:03:29.350758 systemd-networkd[854]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 00:03:29.350762 systemd-networkd[854]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 00:03:29.351894 systemd-networkd[854]: eth0: Link UP Sep 4 00:03:29.352080 systemd-networkd[854]: eth0: Gained carrier Sep 4 00:03:29.352091 systemd-networkd[854]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 00:03:29.352124 systemd[1]: Reached target network.target - Network. Sep 4 00:03:29.352901 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 4 00:03:29.356897 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 00:03:29.369205 systemd-networkd[854]: eth0: DHCPv4 address 10.0.0.77/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 00:03:29.392440 ignition[858]: Ignition 2.21.0 Sep 4 00:03:29.392459 ignition[858]: Stage: kargs Sep 4 00:03:29.392690 ignition[858]: no configs at "/usr/lib/ignition/base.d" Sep 4 00:03:29.392702 ignition[858]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 00:03:29.393261 ignition[858]: kargs: kargs passed Sep 4 00:03:29.393308 ignition[858]: Ignition finished successfully Sep 4 00:03:29.399414 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 00:03:29.401354 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 00:03:29.427944 systemd-resolved[263]: Detected conflict on linux IN A 10.0.0.77 Sep 4 00:03:29.427960 systemd-resolved[263]: Hostname conflict, changing published hostname from 'linux' to 'linux10'. Sep 4 00:03:29.434492 ignition[868]: Ignition 2.21.0 Sep 4 00:03:29.434502 ignition[868]: Stage: disks Sep 4 00:03:29.434617 ignition[868]: no configs at "/usr/lib/ignition/base.d" Sep 4 00:03:29.434626 ignition[868]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 00:03:29.435040 ignition[868]: disks: disks passed Sep 4 00:03:29.437532 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 00:03:29.435082 ignition[868]: Ignition finished successfully Sep 4 00:03:29.438081 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 00:03:29.439478 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 00:03:29.439799 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 00:03:29.440123 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 00:03:29.440442 systemd[1]: Reached target basic.target - Basic System. Sep 4 00:03:29.448445 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 00:03:29.484773 systemd-fsck[878]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 4 00:03:29.492268 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 00:03:29.496691 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 00:03:29.604179 kernel: EXT4-fs (vda9): mounted filesystem c3518c93-f823-4477-a620-ff9666a59be5 r/w with ordered data mode. Quota mode: none. Sep 4 00:03:29.604971 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 00:03:29.606946 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 00:03:29.610067 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 00:03:29.612453 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 00:03:29.614354 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 4 00:03:29.614396 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 4 00:03:29.616019 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 00:03:29.623500 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 00:03:29.624709 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 00:03:29.631335 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (887) Sep 4 00:03:29.631367 kernel: BTRFS info (device vda6): first mount of filesystem 75efd3be-3398-4525-8f67-b36cc847539d Sep 4 00:03:29.631387 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 00:03:29.635188 kernel: BTRFS info (device vda6): turning on async discard Sep 4 00:03:29.635217 kernel: BTRFS info (device vda6): enabling free space tree Sep 4 00:03:29.637541 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 00:03:29.659670 initrd-setup-root[911]: cut: /sysroot/etc/passwd: No such file or directory Sep 4 00:03:29.664464 initrd-setup-root[918]: cut: /sysroot/etc/group: No such file or directory Sep 4 00:03:29.669037 initrd-setup-root[925]: cut: /sysroot/etc/shadow: No such file or directory Sep 4 00:03:29.673509 initrd-setup-root[932]: cut: /sysroot/etc/gshadow: No such file or directory Sep 4 00:03:29.754528 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 00:03:29.756929 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 00:03:29.757876 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 4 00:03:29.787219 kernel: BTRFS info (device vda6): last unmount of filesystem 75efd3be-3398-4525-8f67-b36cc847539d Sep 4 00:03:29.806276 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 4 00:03:29.820485 ignition[1001]: INFO : Ignition 2.21.0 Sep 4 00:03:29.820485 ignition[1001]: INFO : Stage: mount Sep 4 00:03:29.822468 ignition[1001]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 00:03:29.822468 ignition[1001]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 00:03:29.824703 ignition[1001]: INFO : mount: mount passed Sep 4 00:03:29.824703 ignition[1001]: INFO : Ignition finished successfully Sep 4 00:03:29.825488 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 00:03:29.827758 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 00:03:30.154387 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 4 00:03:30.156295 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 00:03:30.180886 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1014) Sep 4 00:03:30.180923 kernel: BTRFS info (device vda6): first mount of filesystem 75efd3be-3398-4525-8f67-b36cc847539d Sep 4 00:03:30.180934 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 00:03:30.185183 kernel: BTRFS info (device vda6): turning on async discard Sep 4 00:03:30.185209 kernel: BTRFS info (device vda6): enabling free space tree Sep 4 00:03:30.186632 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 00:03:30.223663 ignition[1031]: INFO : Ignition 2.21.0 Sep 4 00:03:30.223663 ignition[1031]: INFO : Stage: files Sep 4 00:03:30.225532 ignition[1031]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 00:03:30.225532 ignition[1031]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 00:03:30.225532 ignition[1031]: DEBUG : files: compiled without relabeling support, skipping Sep 4 00:03:30.225532 ignition[1031]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 4 00:03:30.225532 ignition[1031]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 4 00:03:30.232118 ignition[1031]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 4 00:03:30.232118 ignition[1031]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 4 00:03:30.232118 ignition[1031]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 4 00:03:30.227835 unknown[1031]: wrote ssh authorized keys file for user: core Sep 4 00:03:30.238261 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 00:03:30.238261 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 00:03:30.238261 ignition[1031]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Sep 4 00:03:30.238261 ignition[1031]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 00:03:30.245471 ignition[1031]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 00:03:30.245471 ignition[1031]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Sep 4 00:03:30.245471 ignition[1031]: INFO : files: op(6): [started] processing unit "docker.service" Sep 4 00:03:30.245471 ignition[1031]: INFO : files: op(6): [finished] processing unit "docker.service" Sep 4 00:03:30.245471 ignition[1031]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 4 00:03:30.264462 ignition[1031]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 4 00:03:30.269444 ignition[1031]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 4 00:03:30.271597 ignition[1031]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 4 00:03:30.271597 ignition[1031]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 4 00:03:30.274838 ignition[1031]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 4 00:03:30.274838 ignition[1031]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 00:03:30.274838 ignition[1031]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 00:03:30.274838 ignition[1031]: INFO : files: files passed Sep 4 00:03:30.274838 ignition[1031]: INFO : Ignition finished successfully Sep 4 00:03:30.281701 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 00:03:30.285723 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 00:03:30.288498 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 00:03:30.312268 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 00:03:30.312438 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 00:03:30.319322 initrd-setup-root-after-ignition[1060]: grep: /sysroot/oem/oem-release: No such file or directory Sep 4 00:03:30.322818 initrd-setup-root-after-ignition[1066]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 00:03:30.327359 initrd-setup-root-after-ignition[1062]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 00:03:30.327359 initrd-setup-root-after-ignition[1062]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 00:03:30.334118 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 00:03:30.339486 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 4 00:03:30.342288 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 00:03:30.452393 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 00:03:30.452569 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 00:03:30.456923 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 00:03:30.464383 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 00:03:30.491293 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 00:03:30.499623 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 00:03:30.549706 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 00:03:30.559181 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 00:03:30.599764 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 00:03:30.606097 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 00:03:30.610391 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 00:03:30.612450 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 00:03:30.612743 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 00:03:30.625449 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 00:03:30.626332 systemd[1]: Stopped target basic.target - Basic System. Sep 4 00:03:30.634080 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 4 00:03:30.634319 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 00:03:30.639961 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 00:03:30.640272 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 4 00:03:30.644242 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 00:03:30.647722 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 00:03:30.654931 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 00:03:30.656426 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 00:03:30.659140 systemd[1]: Stopped target swap.target - Swaps. Sep 4 00:03:30.673704 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 00:03:30.673920 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 00:03:30.685354 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 00:03:30.694531 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 00:03:30.699031 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 00:03:30.701369 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 00:03:30.705287 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 00:03:30.705479 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 00:03:30.711745 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 00:03:30.711980 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 00:03:30.720780 systemd[1]: Stopped target paths.target - Path Units. Sep 4 00:03:30.732278 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 00:03:30.736314 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 00:03:30.737282 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 00:03:30.743493 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 00:03:30.746669 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 00:03:30.746826 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 00:03:30.750593 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 00:03:30.750709 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 00:03:30.757014 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 00:03:30.757242 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 00:03:30.760851 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 00:03:30.760984 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 00:03:30.764585 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 00:03:30.770269 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 4 00:03:30.771198 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 00:03:30.771451 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 00:03:30.773661 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 00:03:30.773839 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 00:03:30.798638 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 00:03:30.799704 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 00:03:30.827651 ignition[1086]: INFO : Ignition 2.21.0 Sep 4 00:03:30.827651 ignition[1086]: INFO : Stage: umount Sep 4 00:03:30.831972 ignition[1086]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 00:03:30.831972 ignition[1086]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 00:03:30.831972 ignition[1086]: INFO : umount: umount passed Sep 4 00:03:30.831972 ignition[1086]: INFO : Ignition finished successfully Sep 4 00:03:30.832022 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 4 00:03:30.834311 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 00:03:30.834489 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 00:03:30.839143 systemd[1]: Stopped target network.target - Network. Sep 4 00:03:30.839801 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 00:03:30.839908 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 00:03:30.840498 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 00:03:30.840578 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 00:03:30.840902 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 4 00:03:30.840974 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 4 00:03:30.841549 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 00:03:30.841629 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 00:03:30.842204 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 4 00:03:30.853664 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 00:03:30.860829 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 4 00:03:30.860989 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 4 00:03:30.864974 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 00:03:30.865225 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 00:03:30.871130 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 4 00:03:30.871478 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 00:03:30.871644 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 4 00:03:30.876745 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Sep 4 00:03:30.879945 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 4 00:03:30.881923 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 00:03:30.881998 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 4 00:03:30.883078 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 00:03:30.883293 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 00:03:30.888547 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 00:03:30.889893 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 00:03:30.889991 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 00:03:30.890611 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 00:03:30.890674 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 00:03:30.901100 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 00:03:30.901289 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 00:03:30.905570 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 00:03:30.905670 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 00:03:30.922861 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 00:03:30.960811 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 00:03:30.965407 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 00:03:30.967586 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 00:03:30.967642 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 00:03:30.970845 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 00:03:30.970895 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 00:03:30.975332 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 00:03:30.975441 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 00:03:30.982123 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 00:03:30.982232 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 00:03:30.983583 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 00:03:30.983650 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 00:03:30.986410 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 00:03:30.991953 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 4 00:03:30.992040 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 00:03:31.005188 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 00:03:31.005273 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 00:03:31.031550 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 00:03:31.031635 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 00:03:31.042979 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 00:03:31.043074 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 00:03:31.058627 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:03:31.058744 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:31.062002 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 00:03:31.062195 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 00:03:31.064052 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 00:03:31.066049 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 00:03:31.070169 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 00:03:31.094291 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 00:03:31.145585 systemd[1]: Switching root. Sep 4 00:03:31.198128 systemd-journald[220]: Journal stopped Sep 4 00:03:33.121499 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Sep 4 00:03:33.121584 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 00:03:33.121602 kernel: SELinux: policy capability open_perms=1 Sep 4 00:03:33.121619 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 00:03:33.121634 kernel: SELinux: policy capability always_check_network=0 Sep 4 00:03:33.121648 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 00:03:33.121663 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 00:03:33.121678 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 00:03:33.121695 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 00:03:33.121712 kernel: SELinux: policy capability userspace_initial_context=0 Sep 4 00:03:33.121727 kernel: audit: type=1403 audit(1756944211.389:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 00:03:33.121744 systemd[1]: Successfully loaded SELinux policy in 90.124ms. Sep 4 00:03:33.121776 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 26.251ms. Sep 4 00:03:33.121796 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 4 00:03:33.121811 systemd[1]: Detected virtualization kvm. Sep 4 00:03:33.121830 systemd[1]: Detected architecture x86-64. Sep 4 00:03:33.121848 systemd[1]: Detected first boot. Sep 4 00:03:33.121872 systemd[1]: Initializing machine ID from VM UUID. Sep 4 00:03:33.121901 zram_generator::config[1131]: No configuration found. Sep 4 00:03:33.121927 kernel: Guest personality initialized and is inactive Sep 4 00:03:33.121942 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Sep 4 00:03:33.121959 kernel: Initialized host personality Sep 4 00:03:33.121973 kernel: NET: Registered PF_VSOCK protocol family Sep 4 00:03:33.121987 systemd[1]: Populated /etc with preset unit settings. Sep 4 00:03:33.122001 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 4 00:03:33.122013 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 00:03:33.122026 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 00:03:33.122038 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 00:03:33.122050 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 00:03:33.122073 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 00:03:33.122088 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 00:03:33.122100 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 00:03:33.122112 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 00:03:33.122125 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 00:03:33.122137 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 00:03:33.122164 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 00:03:33.122177 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 00:03:33.122189 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 00:03:33.122201 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 00:03:33.122216 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 00:03:33.122231 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 00:03:33.122243 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 00:03:33.122256 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 4 00:03:33.122268 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 00:03:33.122280 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 00:03:33.122292 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 00:03:33.122306 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 00:03:33.122319 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 00:03:33.122331 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 00:03:33.122343 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 00:03:33.122359 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 00:03:33.122371 systemd[1]: Reached target slices.target - Slice Units. Sep 4 00:03:33.122383 systemd[1]: Reached target swap.target - Swaps. Sep 4 00:03:33.122396 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 00:03:33.122408 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 00:03:33.122422 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 4 00:03:33.122434 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 00:03:33.122446 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 00:03:33.122460 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 00:03:33.122472 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 00:03:33.122484 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 00:03:33.122497 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 00:03:33.122509 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 00:03:33.122521 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 00:03:33.122535 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 00:03:33.122547 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 00:03:33.122559 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 00:03:33.122572 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 4 00:03:33.122584 systemd[1]: Reached target machines.target - Containers. Sep 4 00:03:33.122596 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 00:03:33.122609 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 00:03:33.122621 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 00:03:33.122633 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 00:03:33.122647 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 00:03:33.122659 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 00:03:33.122671 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 00:03:33.122683 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 00:03:33.122695 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 00:03:33.122708 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 00:03:33.122722 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 00:03:33.122735 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 00:03:33.122750 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 00:03:33.122762 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 00:03:33.122775 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 4 00:03:33.122787 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 00:03:33.122802 kernel: fuse: init (API version 7.41) Sep 4 00:03:33.122816 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 00:03:33.122831 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 00:03:33.122846 kernel: loop: module loaded Sep 4 00:03:33.122862 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 00:03:33.122884 kernel: ACPI: bus type drm_connector registered Sep 4 00:03:33.122904 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 4 00:03:33.122922 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 00:03:33.122935 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 00:03:33.122947 systemd[1]: Stopped verity-setup.service. Sep 4 00:03:33.122962 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 00:03:33.122974 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 00:03:33.122987 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 00:03:33.122999 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 00:03:33.123012 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 00:03:33.123028 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 00:03:33.123073 systemd-journald[1202]: Collecting audit messages is disabled. Sep 4 00:03:33.123098 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 00:03:33.123112 systemd-journald[1202]: Journal started Sep 4 00:03:33.123135 systemd-journald[1202]: Runtime Journal (/run/log/journal/36a3b848af0d4f668d013f58b3f6a48b) is 6M, max 48.2M, 42.2M free. Sep 4 00:03:32.600044 systemd[1]: Queued start job for default target multi-user.target. Sep 4 00:03:32.633184 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 4 00:03:32.636478 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 00:03:33.125208 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 00:03:33.128240 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 00:03:33.129880 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 00:03:33.131984 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 00:03:33.132511 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 00:03:33.134361 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 00:03:33.134645 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 00:03:33.136520 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 00:03:33.136822 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 00:03:33.138577 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 00:03:33.138924 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 00:03:33.140817 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 00:03:33.141131 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 00:03:33.142812 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 00:03:33.143104 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 00:03:33.145014 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 00:03:33.146876 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 00:03:33.148806 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 00:03:33.150773 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 4 00:03:33.167434 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 00:03:33.171033 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 00:03:33.173602 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 00:03:33.175086 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 00:03:33.175119 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 00:03:33.177500 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 4 00:03:33.186823 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 00:03:33.190597 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 00:03:33.192235 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 00:03:33.196295 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 00:03:33.197792 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 00:03:33.201305 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 00:03:33.202772 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 00:03:33.206289 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 00:03:33.210958 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 00:03:33.217290 systemd-journald[1202]: Time spent on flushing to /var/log/journal/36a3b848af0d4f668d013f58b3f6a48b is 19.503ms for 1012 entries. Sep 4 00:03:33.217290 systemd-journald[1202]: System Journal (/var/log/journal/36a3b848af0d4f668d013f58b3f6a48b) is 8M, max 195.6M, 187.6M free. Sep 4 00:03:33.364570 systemd-journald[1202]: Received client request to flush runtime journal. Sep 4 00:03:33.364708 kernel: loop0: detected capacity change from 0 to 113872 Sep 4 00:03:33.222354 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 00:03:33.258446 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 00:03:33.260067 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 00:03:33.261434 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 00:03:33.333729 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 00:03:33.337974 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 00:03:33.342446 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 4 00:03:33.344311 systemd-tmpfiles[1251]: ACLs are not supported, ignoring. Sep 4 00:03:33.344327 systemd-tmpfiles[1251]: ACLs are not supported, ignoring. Sep 4 00:03:33.344560 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 00:03:33.356360 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 00:03:33.359591 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 00:03:33.371211 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 00:03:33.372751 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 00:03:33.384946 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 4 00:03:33.396181 kernel: loop1: detected capacity change from 0 to 146240 Sep 4 00:03:33.410643 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 00:03:33.413875 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 00:03:33.429837 kernel: loop2: detected capacity change from 0 to 113872 Sep 4 00:03:33.446077 kernel: loop3: detected capacity change from 0 to 146240 Sep 4 00:03:33.448342 systemd-tmpfiles[1274]: ACLs are not supported, ignoring. Sep 4 00:03:33.448368 systemd-tmpfiles[1274]: ACLs are not supported, ignoring. Sep 4 00:03:33.455338 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 00:03:33.459062 (sd-merge)[1275]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 4 00:03:33.459708 (sd-merge)[1275]: Merged extensions into '/usr'. Sep 4 00:03:33.463810 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 00:03:33.468393 systemd[1]: Starting ensure-sysext.service... Sep 4 00:03:33.471327 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 00:03:33.499946 systemd[1]: Reload requested from client PID 1279 ('systemctl') (unit ensure-sysext.service)... Sep 4 00:03:33.500131 systemd[1]: Reloading... Sep 4 00:03:33.509553 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 4 00:03:33.509605 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 4 00:03:33.509973 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 00:03:33.510335 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 00:03:33.511296 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 00:03:33.511637 systemd-tmpfiles[1280]: ACLs are not supported, ignoring. Sep 4 00:03:33.511729 systemd-tmpfiles[1280]: ACLs are not supported, ignoring. Sep 4 00:03:33.517629 systemd-tmpfiles[1280]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 00:03:33.517646 systemd-tmpfiles[1280]: Skipping /boot Sep 4 00:03:33.537212 systemd-tmpfiles[1280]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 00:03:33.537380 systemd-tmpfiles[1280]: Skipping /boot Sep 4 00:03:33.582177 zram_generator::config[1309]: No configuration found. Sep 4 00:03:33.694090 ldconfig[1245]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 00:03:33.714706 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. Sep 4 00:03:33.800901 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 00:03:33.801451 systemd[1]: Reloading finished in 300 ms. Sep 4 00:03:33.826390 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 00:03:33.858852 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 00:03:33.868674 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 4 00:03:33.871632 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 00:03:33.875534 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 00:03:33.886453 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 00:03:33.889002 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 00:03:33.892774 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 00:03:33.893658 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 00:03:33.895023 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 00:03:33.903647 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 00:03:33.906604 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 00:03:33.907969 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 00:03:33.908127 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 4 00:03:33.908296 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 00:03:33.909807 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 00:03:33.910505 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 00:03:33.915321 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 00:03:33.915986 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 00:03:33.929484 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 00:03:33.933282 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 00:03:33.935867 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 00:03:33.936300 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 00:03:33.951474 systemd[1]: Finished ensure-sysext.service. Sep 4 00:03:33.955401 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 00:03:33.955591 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 00:03:33.957027 augenrules[1380]: No rules Sep 4 00:03:33.958352 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 00:03:33.963308 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 00:03:33.966606 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 00:03:33.974915 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 00:03:33.976276 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 00:03:33.976414 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 4 00:03:33.979354 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 4 00:03:33.982754 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 00:03:33.983933 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 00:03:33.984911 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 00:03:33.985266 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 4 00:03:33.986910 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 00:03:33.988707 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 00:03:33.988967 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 00:03:33.990879 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 00:03:33.991205 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 00:03:33.992862 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 00:03:33.993139 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 00:03:33.994989 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 00:03:33.995414 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 00:03:34.003030 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 00:03:34.003139 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 00:03:34.003202 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 4 00:03:34.044799 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 00:03:34.062345 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 00:03:34.066273 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 00:03:34.070606 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 00:03:34.093450 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 00:03:34.112971 systemd-udevd[1403]: Using default interface naming scheme 'v255'. Sep 4 00:03:34.136705 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 00:03:34.143359 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 00:03:34.147520 systemd-resolved[1350]: Positive Trust Anchors: Sep 4 00:03:34.151207 systemd-resolved[1350]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 00:03:34.151261 systemd-resolved[1350]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 4 00:03:34.155765 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 4 00:03:34.157717 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 00:03:34.160817 systemd-resolved[1350]: Defaulting to hostname 'linux'. Sep 4 00:03:34.164903 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 00:03:34.166264 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 00:03:34.167491 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 00:03:34.168697 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 00:03:34.169997 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 00:03:34.171418 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 4 00:03:34.173014 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 00:03:34.174394 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 00:03:34.175694 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 00:03:34.177007 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 00:03:34.177044 systemd[1]: Reached target paths.target - Path Units. Sep 4 00:03:34.178806 systemd[1]: Reached target timers.target - Timer Units. Sep 4 00:03:34.180950 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 00:03:34.184040 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 00:03:34.189730 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 4 00:03:34.192743 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 4 00:03:34.194985 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 4 00:03:34.205537 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 00:03:34.207534 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 4 00:03:34.211857 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 00:03:34.218546 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 00:03:34.219906 systemd[1]: Reached target basic.target - Basic System. Sep 4 00:03:34.221036 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 00:03:34.221081 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 00:03:34.224291 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 00:03:34.227365 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 00:03:34.233305 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 00:03:34.237493 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 00:03:34.240285 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 4 00:03:34.243120 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 4 00:03:34.256860 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 00:03:34.260521 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 00:03:34.265496 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 00:03:34.283000 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 00:03:34.284107 jq[1443]: false Sep 4 00:03:34.286198 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 00:03:34.286825 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 00:03:34.287771 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 00:03:34.292189 google_oslogin_nss_cache[1445]: oslogin_cache_refresh[1445]: Refreshing passwd entry cache Sep 4 00:03:34.290827 oslogin_cache_refresh[1445]: Refreshing passwd entry cache Sep 4 00:03:34.295869 google_oslogin_nss_cache[1445]: oslogin_cache_refresh[1445]: Failure getting users, quitting Sep 4 00:03:34.295869 google_oslogin_nss_cache[1445]: oslogin_cache_refresh[1445]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 4 00:03:34.295869 google_oslogin_nss_cache[1445]: oslogin_cache_refresh[1445]: Refreshing group entry cache Sep 4 00:03:34.295869 google_oslogin_nss_cache[1445]: oslogin_cache_refresh[1445]: Failure getting groups, quitting Sep 4 00:03:34.295869 google_oslogin_nss_cache[1445]: oslogin_cache_refresh[1445]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 4 00:03:34.294485 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 00:03:34.293871 oslogin_cache_refresh[1445]: Failure getting users, quitting Sep 4 00:03:34.293892 oslogin_cache_refresh[1445]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 4 00:03:34.293943 oslogin_cache_refresh[1445]: Refreshing group entry cache Sep 4 00:03:34.294571 oslogin_cache_refresh[1445]: Failure getting groups, quitting Sep 4 00:03:34.294580 oslogin_cache_refresh[1445]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 4 00:03:34.302483 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 00:03:34.304250 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 00:03:34.304514 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 00:03:34.304824 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 4 00:03:34.305091 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 4 00:03:34.312551 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 00:03:34.312981 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 00:03:34.313806 systemd-networkd[1412]: lo: Link UP Sep 4 00:03:34.314703 jq[1453]: true Sep 4 00:03:34.313820 systemd-networkd[1412]: lo: Gained carrier Sep 4 00:03:34.315759 systemd-networkd[1412]: Enumeration completed Sep 4 00:03:34.316881 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 00:03:34.333185 jq[1462]: true Sep 4 00:03:34.338596 update_engine[1452]: I20250904 00:03:34.338522 1452 main.cc:92] Flatcar Update Engine starting Sep 4 00:03:34.345697 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 4 00:03:34.346015 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 00:03:34.347383 extend-filesystems[1444]: Found /dev/vda6 Sep 4 00:03:34.350789 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 00:03:34.353084 systemd[1]: Reached target network.target - Network. Sep 4 00:03:34.354428 extend-filesystems[1444]: Found /dev/vda9 Sep 4 00:03:34.357775 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 00:03:34.362496 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 4 00:03:34.363348 extend-filesystems[1444]: Checking size of /dev/vda9 Sep 4 00:03:34.366934 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 00:03:34.383879 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 00:03:34.383463 dbus-daemon[1439]: [system] SELinux support is enabled Sep 4 00:03:34.390183 extend-filesystems[1444]: Old size kept for /dev/vda9 Sep 4 00:03:34.393564 update_engine[1452]: I20250904 00:03:34.393429 1452 update_check_scheduler.cc:74] Next update check in 6m38s Sep 4 00:03:34.396895 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 00:03:34.397213 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 00:03:34.399679 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 4 00:03:34.399722 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 00:03:34.401130 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 4 00:03:34.401165 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 00:03:34.402986 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 4 00:03:34.405632 systemd[1]: Started update-engine.service - Update Engine. Sep 4 00:03:34.410815 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 00:03:34.421435 (ntainerd)[1509]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 00:03:34.425198 bash[1506]: Updated "/home/core/.ssh/authorized_keys" Sep 4 00:03:34.428276 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 4 00:03:34.431262 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 4 00:03:34.437050 systemd-networkd[1412]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 00:03:34.437059 systemd-networkd[1412]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 00:03:34.438063 systemd-networkd[1412]: eth0: Link UP Sep 4 00:03:34.443621 systemd-networkd[1412]: eth0: Gained carrier Sep 4 00:03:34.443796 systemd-networkd[1412]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 00:03:34.453112 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 00:03:34.455992 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 00:03:34.459235 systemd-networkd[1412]: eth0: DHCPv4 address 10.0.0.77/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 00:03:34.460905 systemd-timesyncd[1389]: Network configuration changed, trying to establish connection. Sep 4 00:03:35.172213 systemd-timesyncd[1389]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 4 00:03:35.172332 systemd-timesyncd[1389]: Initial clock synchronization to Thu 2025-09-04 00:03:35.171896 UTC. Sep 4 00:03:35.172721 systemd-resolved[1350]: Clock change detected. Flushing caches. Sep 4 00:03:35.184585 kernel: mousedev: PS/2 mouse device common for all mice Sep 4 00:03:35.187426 systemd-logind[1451]: New seat seat0. Sep 4 00:03:35.188668 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 00:03:35.191742 locksmithd[1507]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 00:03:35.201078 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 00:03:35.208598 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Sep 4 00:03:35.214611 kernel: ACPI: button: Power Button [PWRF] Sep 4 00:03:35.234603 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Sep 4 00:03:35.234899 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Sep 4 00:03:35.236992 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Sep 4 00:03:35.368621 containerd[1509]: time="2025-09-04T00:03:35Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 4 00:03:35.371458 containerd[1509]: time="2025-09-04T00:03:35.371403349Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Sep 4 00:03:35.390754 containerd[1509]: time="2025-09-04T00:03:35.390689154Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.081µs" Sep 4 00:03:35.390754 containerd[1509]: time="2025-09-04T00:03:35.390738747Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 4 00:03:35.390754 containerd[1509]: time="2025-09-04T00:03:35.390763583Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 4 00:03:35.391023 containerd[1509]: time="2025-09-04T00:03:35.390993935Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 4 00:03:35.391049 containerd[1509]: time="2025-09-04T00:03:35.391030173Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 4 00:03:35.391082 containerd[1509]: time="2025-09-04T00:03:35.391062815Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391173 containerd[1509]: time="2025-09-04T00:03:35.391144127Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391173 containerd[1509]: time="2025-09-04T00:03:35.391168463Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391651 containerd[1509]: time="2025-09-04T00:03:35.391603619Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391651 containerd[1509]: time="2025-09-04T00:03:35.391647461Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391708 containerd[1509]: time="2025-09-04T00:03:35.391663331Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391708 containerd[1509]: time="2025-09-04T00:03:35.391675293Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 4 00:03:35.391827 containerd[1509]: time="2025-09-04T00:03:35.391798024Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 4 00:03:35.392166 containerd[1509]: time="2025-09-04T00:03:35.392137841Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:03:35.392204 containerd[1509]: time="2025-09-04T00:03:35.392176634Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:03:35.392204 containerd[1509]: time="2025-09-04T00:03:35.392186863Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 4 00:03:35.392253 containerd[1509]: time="2025-09-04T00:03:35.392209756Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 4 00:03:35.392478 containerd[1509]: time="2025-09-04T00:03:35.392448584Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 4 00:03:35.392662 containerd[1509]: time="2025-09-04T00:03:35.392533974Z" level=info msg="metadata content store policy set" policy=shared Sep 4 00:03:35.399635 containerd[1509]: time="2025-09-04T00:03:35.399583467Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 4 00:03:35.400626 containerd[1509]: time="2025-09-04T00:03:35.400599092Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400627275Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400713016Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400731300Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400740978Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400755676Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400766807Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400776435Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400794579Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400803636Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400816049Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 4 00:03:35.400948 containerd[1509]: time="2025-09-04T00:03:35.400945782Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.400965980Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.400979906Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.400989564Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.400999503Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401009842Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401020222Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401031473Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401042063Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401052242Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401063022Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 4 00:03:35.401139 containerd[1509]: time="2025-09-04T00:03:35.401138985Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 4 00:03:35.401330 containerd[1509]: time="2025-09-04T00:03:35.401156037Z" level=info msg="Start snapshots syncer" Sep 4 00:03:35.401330 containerd[1509]: time="2025-09-04T00:03:35.401181204Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 4 00:03:35.401450 containerd[1509]: time="2025-09-04T00:03:35.401387511Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 4 00:03:35.401595 containerd[1509]: time="2025-09-04T00:03:35.401474895Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 4 00:03:35.401595 containerd[1509]: time="2025-09-04T00:03:35.401568510Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 4 00:03:35.401700 containerd[1509]: time="2025-09-04T00:03:35.401675621Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 4 00:03:35.401728 containerd[1509]: time="2025-09-04T00:03:35.401701470Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 4 00:03:35.401728 containerd[1509]: time="2025-09-04T00:03:35.401712330Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 4 00:03:35.401728 containerd[1509]: time="2025-09-04T00:03:35.401723321Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 4 00:03:35.401781 containerd[1509]: time="2025-09-04T00:03:35.401734321Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 4 00:03:35.401781 containerd[1509]: time="2025-09-04T00:03:35.401744901Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 4 00:03:35.401781 containerd[1509]: time="2025-09-04T00:03:35.401755912Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 4 00:03:35.401839 containerd[1509]: time="2025-09-04T00:03:35.401782892Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 4 00:03:35.401839 containerd[1509]: time="2025-09-04T00:03:35.401793062Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 4 00:03:35.401839 containerd[1509]: time="2025-09-04T00:03:35.401802559Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 4 00:03:35.401839 containerd[1509]: time="2025-09-04T00:03:35.401834389Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401848536Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401857412Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401867511Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401874845Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401883762Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401893019Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 4 00:03:35.401907 containerd[1509]: time="2025-09-04T00:03:35.401909059Z" level=info msg="runtime interface created" Sep 4 00:03:35.402037 containerd[1509]: time="2025-09-04T00:03:35.401914860Z" level=info msg="created NRI interface" Sep 4 00:03:35.402037 containerd[1509]: time="2025-09-04T00:03:35.401923466Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 4 00:03:35.402037 containerd[1509]: time="2025-09-04T00:03:35.401933906Z" level=info msg="Connect containerd service" Sep 4 00:03:35.402037 containerd[1509]: time="2025-09-04T00:03:35.401953472Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 00:03:35.402695 containerd[1509]: time="2025-09-04T00:03:35.402668173Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 4 00:03:35.405785 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:03:35.430087 systemd-logind[1451]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 4 00:03:35.453728 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:03:35.454453 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:35.459005 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:03:35.543976 systemd-logind[1451]: Watching system buttons on /dev/input/event2 (Power Button) Sep 4 00:03:35.547362 containerd[1509]: time="2025-09-04T00:03:35.547204251Z" level=info msg="Start subscribing containerd event" Sep 4 00:03:35.547550 containerd[1509]: time="2025-09-04T00:03:35.547385121Z" level=info msg="Start recovering state" Sep 4 00:03:35.548012 containerd[1509]: time="2025-09-04T00:03:35.547832820Z" level=info msg="Start event monitor" Sep 4 00:03:35.548012 containerd[1509]: time="2025-09-04T00:03:35.547906729Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 00:03:35.548012 containerd[1509]: time="2025-09-04T00:03:35.547934040Z" level=info msg="Start cni network conf syncer for default" Sep 4 00:03:35.548824 containerd[1509]: time="2025-09-04T00:03:35.547946684Z" level=info msg="Start streaming server" Sep 4 00:03:35.548824 containerd[1509]: time="2025-09-04T00:03:35.548616100Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 4 00:03:35.548824 containerd[1509]: time="2025-09-04T00:03:35.548629214Z" level=info msg="runtime interface starting up..." Sep 4 00:03:35.548824 containerd[1509]: time="2025-09-04T00:03:35.548636257Z" level=info msg="starting plugins..." Sep 4 00:03:35.548824 containerd[1509]: time="2025-09-04T00:03:35.548185241Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 00:03:35.553162 containerd[1509]: time="2025-09-04T00:03:35.552635439Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 4 00:03:35.553162 containerd[1509]: time="2025-09-04T00:03:35.552949568Z" level=info msg="containerd successfully booted in 0.187227s" Sep 4 00:03:35.553225 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 00:03:35.568564 kernel: kvm_amd: TSC scaling supported Sep 4 00:03:35.568648 kernel: kvm_amd: Nested Virtualization enabled Sep 4 00:03:35.568667 kernel: kvm_amd: Nested Paging enabled Sep 4 00:03:35.568683 kernel: kvm_amd: LBR virtualization supported Sep 4 00:03:35.577652 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:03:35.586572 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Sep 4 00:03:35.586650 kernel: kvm_amd: Virtual GIF supported Sep 4 00:03:35.617584 kernel: EDAC MC: Ver: 3.0.0 Sep 4 00:03:35.661426 sshd_keygen[1469]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 4 00:03:35.689315 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 00:03:35.692388 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 00:03:35.720033 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 00:03:35.720393 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 00:03:35.723726 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 00:03:35.753818 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 00:03:35.756856 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 00:03:35.759019 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 4 00:03:35.760258 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 00:03:36.981791 systemd-networkd[1412]: eth0: Gained IPv6LL Sep 4 00:03:36.984835 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 00:03:36.986646 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 00:03:36.989264 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 4 00:03:36.991558 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 00:03:37.031754 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 00:03:37.035637 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 4 00:03:37.035937 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 4 00:03:37.037824 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 4 00:03:37.038001 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 00:03:37.039438 systemd[1]: Startup finished in 2.861s (kernel) + 4.712s (initrd) + 5.027s (userspace) = 12.600s. Sep 4 00:03:40.496096 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 00:03:40.497448 systemd[1]: Started sshd@0-10.0.0.77:22-10.0.0.1:36072.service - OpenSSH per-connection server daemon (10.0.0.1:36072). Sep 4 00:03:40.574302 sshd[1602]: Accepted publickey for core from 10.0.0.1 port 36072 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:40.576690 sshd-session[1602]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:40.583968 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 00:03:40.585210 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 00:03:40.592589 systemd-logind[1451]: New session 1 of user core. Sep 4 00:03:40.609224 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 00:03:40.613708 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 00:03:40.629427 (systemd)[1606]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 00:03:40.632633 systemd-logind[1451]: New session c1 of user core. Sep 4 00:03:40.804944 systemd[1606]: Queued start job for default target default.target. Sep 4 00:03:40.826080 systemd[1606]: Created slice app.slice - User Application Slice. Sep 4 00:03:40.826111 systemd[1606]: Reached target paths.target - Paths. Sep 4 00:03:40.826154 systemd[1606]: Reached target timers.target - Timers. Sep 4 00:03:40.827878 systemd[1606]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 00:03:40.839514 systemd[1606]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 00:03:40.839712 systemd[1606]: Reached target sockets.target - Sockets. Sep 4 00:03:40.839776 systemd[1606]: Reached target basic.target - Basic System. Sep 4 00:03:40.839826 systemd[1606]: Reached target default.target - Main User Target. Sep 4 00:03:40.839869 systemd[1606]: Startup finished in 198ms. Sep 4 00:03:40.840418 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 00:03:40.842454 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 00:03:40.910377 systemd[1]: Started sshd@1-10.0.0.77:22-10.0.0.1:36080.service - OpenSSH per-connection server daemon (10.0.0.1:36080). Sep 4 00:03:40.967071 sshd[1617]: Accepted publickey for core from 10.0.0.1 port 36080 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:40.968751 sshd-session[1617]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:40.973593 systemd-logind[1451]: New session 2 of user core. Sep 4 00:03:40.987734 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 00:03:41.042217 sshd[1619]: Connection closed by 10.0.0.1 port 36080 Sep 4 00:03:41.042599 sshd-session[1617]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:41.056489 systemd[1]: sshd@1-10.0.0.77:22-10.0.0.1:36080.service: Deactivated successfully. Sep 4 00:03:41.058223 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 00:03:41.059020 systemd-logind[1451]: Session 2 logged out. Waiting for processes to exit. Sep 4 00:03:41.062288 systemd[1]: Started sshd@2-10.0.0.77:22-10.0.0.1:36094.service - OpenSSH per-connection server daemon (10.0.0.1:36094). Sep 4 00:03:41.063049 systemd-logind[1451]: Removed session 2. Sep 4 00:03:41.110778 sshd[1625]: Accepted publickey for core from 10.0.0.1 port 36094 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:41.112505 sshd-session[1625]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:41.117524 systemd-logind[1451]: New session 3 of user core. Sep 4 00:03:41.130782 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 00:03:41.181833 sshd[1627]: Connection closed by 10.0.0.1 port 36094 Sep 4 00:03:41.182210 sshd-session[1625]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:41.200059 systemd[1]: sshd@2-10.0.0.77:22-10.0.0.1:36094.service: Deactivated successfully. Sep 4 00:03:41.202065 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 00:03:41.202806 systemd-logind[1451]: Session 3 logged out. Waiting for processes to exit. Sep 4 00:03:41.205443 systemd[1]: Started sshd@3-10.0.0.77:22-10.0.0.1:36102.service - OpenSSH per-connection server daemon (10.0.0.1:36102). Sep 4 00:03:41.206297 systemd-logind[1451]: Removed session 3. Sep 4 00:03:41.259420 sshd[1633]: Accepted publickey for core from 10.0.0.1 port 36102 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:41.261121 sshd-session[1633]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:41.265559 systemd-logind[1451]: New session 4 of user core. Sep 4 00:03:41.275735 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 00:03:41.331886 sshd[1635]: Connection closed by 10.0.0.1 port 36102 Sep 4 00:03:41.332204 sshd-session[1633]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:41.348017 systemd[1]: sshd@3-10.0.0.77:22-10.0.0.1:36102.service: Deactivated successfully. Sep 4 00:03:41.349972 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 00:03:41.350687 systemd-logind[1451]: Session 4 logged out. Waiting for processes to exit. Sep 4 00:03:41.353456 systemd[1]: Started sshd@4-10.0.0.77:22-10.0.0.1:36114.service - OpenSSH per-connection server daemon (10.0.0.1:36114). Sep 4 00:03:41.354167 systemd-logind[1451]: Removed session 4. Sep 4 00:03:41.403310 sshd[1641]: Accepted publickey for core from 10.0.0.1 port 36114 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:41.405073 sshd-session[1641]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:41.410323 systemd-logind[1451]: New session 5 of user core. Sep 4 00:03:41.419759 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 00:03:41.481624 sudo[1644]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 4 00:03:41.482019 sudo[1644]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:03:41.502134 sudo[1644]: pam_unix(sudo:session): session closed for user root Sep 4 00:03:41.504210 sshd[1643]: Connection closed by 10.0.0.1 port 36114 Sep 4 00:03:41.504611 sshd-session[1641]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:41.516269 systemd[1]: sshd@4-10.0.0.77:22-10.0.0.1:36114.service: Deactivated successfully. Sep 4 00:03:41.518436 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 00:03:41.519279 systemd-logind[1451]: Session 5 logged out. Waiting for processes to exit. Sep 4 00:03:41.522500 systemd[1]: Started sshd@5-10.0.0.77:22-10.0.0.1:36130.service - OpenSSH per-connection server daemon (10.0.0.1:36130). Sep 4 00:03:41.523356 systemd-logind[1451]: Removed session 5. Sep 4 00:03:41.567992 sshd[1650]: Accepted publickey for core from 10.0.0.1 port 36130 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:41.569752 sshd-session[1650]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:41.575004 systemd-logind[1451]: New session 6 of user core. Sep 4 00:03:41.589713 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 4 00:03:41.643589 sudo[1654]: 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 Sep 4 00:03:41.643950 sudo[1654]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:03:41.650620 sudo[1654]: pam_unix(sudo:session): session closed for user root Sep 4 00:03:41.656839 sudo[1653]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 4 00:03:41.657218 sudo[1653]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:03:41.669188 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 4 00:03:41.719724 augenrules[1676]: No rules Sep 4 00:03:41.721244 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 00:03:41.721517 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 4 00:03:41.722584 sudo[1653]: pam_unix(sudo:session): session closed for user root Sep 4 00:03:41.724064 sshd[1652]: Connection closed by 10.0.0.1 port 36130 Sep 4 00:03:41.724362 sshd-session[1650]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:41.735228 systemd[1]: sshd@5-10.0.0.77:22-10.0.0.1:36130.service: Deactivated successfully. Sep 4 00:03:41.736981 systemd[1]: session-6.scope: Deactivated successfully. Sep 4 00:03:41.737656 systemd-logind[1451]: Session 6 logged out. Waiting for processes to exit. Sep 4 00:03:41.740256 systemd[1]: Started sshd@6-10.0.0.77:22-10.0.0.1:36144.service - OpenSSH per-connection server daemon (10.0.0.1:36144). Sep 4 00:03:41.741012 systemd-logind[1451]: Removed session 6. Sep 4 00:03:41.787009 sshd[1685]: Accepted publickey for core from 10.0.0.1 port 36144 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:41.788460 sshd-session[1685]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:41.792632 systemd-logind[1451]: New session 7 of user core. Sep 4 00:03:41.802776 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 4 00:03:41.858022 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 4 00:03:41.883063 (dockerd)[1689]: 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 Sep 4 00:03:42.108892 dockerd[1689]: time="2025-09-04T00:03:42.108738254Z" level=info msg="Starting up" Sep 4 00:03:42.110200 dockerd[1689]: time="2025-09-04T00:03:42.110176862Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 4 00:03:42.181039 dockerd[1689]: time="2025-09-04T00:03:42.180965251Z" level=info msg="Loading containers: start." Sep 4 00:03:42.191583 kernel: Initializing XFRM netlink socket Sep 4 00:03:42.464040 systemd-networkd[1412]: docker0: Link UP Sep 4 00:03:42.470364 dockerd[1689]: time="2025-09-04T00:03:42.470316251Z" level=info msg="Loading containers: done." Sep 4 00:03:42.484729 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3618138899-merged.mount: Deactivated successfully. Sep 4 00:03:42.486253 dockerd[1689]: time="2025-09-04T00:03:42.486197750Z" 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 Sep 4 00:03:42.486321 dockerd[1689]: time="2025-09-04T00:03:42.486310271Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Sep 4 00:03:42.486445 dockerd[1689]: time="2025-09-04T00:03:42.486412272Z" level=info msg="Initializing buildkit" Sep 4 00:03:42.518517 dockerd[1689]: time="2025-09-04T00:03:42.518454995Z" level=info msg="Completed buildkit initialization" Sep 4 00:03:42.523551 dockerd[1689]: time="2025-09-04T00:03:42.523486102Z" level=info msg="Daemon has completed initialization" Sep 4 00:03:42.523645 dockerd[1689]: time="2025-09-04T00:03:42.523572284Z" level=info msg="API listen on /run/docker.sock" Sep 4 00:03:42.523814 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 4 00:03:42.533165 sshd[1687]: Connection closed by 10.0.0.1 port 36144 Sep 4 00:03:42.533524 sshd-session[1685]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:42.545164 systemd[1]: sshd@6-10.0.0.77:22-10.0.0.1:36144.service: Deactivated successfully. Sep 4 00:03:42.547461 systemd[1]: session-7.scope: Deactivated successfully. Sep 4 00:03:42.548484 systemd-logind[1451]: Session 7 logged out. Waiting for processes to exit. Sep 4 00:03:42.552059 systemd[1]: Started sshd@7-10.0.0.77:22-10.0.0.1:36158.service - OpenSSH per-connection server daemon (10.0.0.1:36158). Sep 4 00:03:42.552925 systemd-logind[1451]: Removed session 7. Sep 4 00:03:42.603143 sshd[1895]: Accepted publickey for core from 10.0.0.1 port 36158 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:42.605196 sshd-session[1895]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:42.610864 systemd-logind[1451]: New session 8 of user core. Sep 4 00:03:42.620731 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 4 00:03:44.092508 systemd[1]: var-lib-docker-overlay2-57b7a99c4240ea6b098dd1f95924283438b715738245c2c71a17ae844a32d9ba\x2dinit-merged.mount: Deactivated successfully. Sep 4 00:03:44.269257 containerd[1509]: time="2025-09-04T00:03:44.269201285Z" level=info msg="connecting to shim 7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c" address="unix:///run/containerd/s/f00ea59031d75a647aaf2a0a6d0eed37d3d1e7e0e645ed7cd7ee6f79c4d901b2" namespace=moby protocol=ttrpc version=3 Sep 4 00:03:44.296825 systemd[1]: Started docker-7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c.scope - libcontainer container 7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c. Sep 4 00:03:44.314433 systemd-resolved[1350]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 4 00:03:44.348168 kernel: docker0: port 1(veth53eb0ec) entered blocking state Sep 4 00:03:44.348267 kernel: docker0: port 1(veth53eb0ec) entered disabled state Sep 4 00:03:44.348291 kernel: veth53eb0ec: entered allmulticast mode Sep 4 00:03:44.349838 kernel: veth53eb0ec: entered promiscuous mode Sep 4 00:03:44.350423 systemd-networkd[1412]: veth53eb0ec: Link UP Sep 4 00:03:44.363709 kernel: eth0: renamed from veth41df0bb Sep 4 00:03:44.365601 kernel: docker0: port 1(veth53eb0ec) entered blocking state Sep 4 00:03:44.365695 kernel: docker0: port 1(veth53eb0ec) entered forwarding state Sep 4 00:03:44.365754 systemd-networkd[1412]: veth53eb0ec: Gained carrier Sep 4 00:03:44.366520 systemd-networkd[1412]: docker0: Gained carrier Sep 4 00:03:44.452273 sshd[1897]: Connection closed by 10.0.0.1 port 36158 Sep 4 00:03:44.454851 sshd-session[1895]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:44.486307 systemd[1]: sshd@7-10.0.0.77:22-10.0.0.1:36158.service: Deactivated successfully. Sep 4 00:03:44.490791 systemd[1]: session-8.scope: Deactivated successfully. Sep 4 00:03:44.495024 systemd-logind[1451]: Session 8 logged out. Waiting for processes to exit. Sep 4 00:03:44.503966 systemd[1]: Started sshd@8-10.0.0.77:22-10.0.0.1:36166.service - OpenSSH per-connection server daemon (10.0.0.1:36166). Sep 4 00:03:44.512186 systemd-logind[1451]: Removed session 8. Sep 4 00:03:44.604222 sshd[1970]: Accepted publickey for core from 10.0.0.1 port 36166 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:44.607850 sshd-session[1970]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:44.621747 systemd-logind[1451]: New session 9 of user core. Sep 4 00:03:44.639120 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 4 00:03:44.718298 sshd[1972]: Connection closed by 10.0.0.1 port 36166 Sep 4 00:03:44.716370 sshd-session[1970]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:44.745409 systemd[1]: sshd@8-10.0.0.77:22-10.0.0.1:36166.service: Deactivated successfully. Sep 4 00:03:44.754395 systemd[1]: session-9.scope: Deactivated successfully. Sep 4 00:03:44.761311 systemd-logind[1451]: Session 9 logged out. Waiting for processes to exit. Sep 4 00:03:44.772993 systemd[1]: Started sshd@9-10.0.0.77:22-10.0.0.1:36176.service - OpenSSH per-connection server daemon (10.0.0.1:36176). Sep 4 00:03:44.777902 systemd-logind[1451]: Removed session 9. Sep 4 00:03:44.868472 sshd[1978]: Accepted publickey for core from 10.0.0.1 port 36176 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:44.872230 sshd-session[1978]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:44.902673 systemd-logind[1451]: New session 10 of user core. Sep 4 00:03:44.911324 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 4 00:03:44.985963 sudo[1981]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1509 Sep 4 00:03:44.986410 sudo[1981]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:03:45.004515 sudo[1981]: pam_unix(sudo:session): session closed for user root Sep 4 00:03:45.006682 dockerd[1689]: time="2025-09-04T00:03:45.006416650Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 4 00:03:45.006682 dockerd[1689]: time="2025-09-04T00:03:45.006463077Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 4 00:03:45.007157 containerd[1509]: time="2025-09-04T00:03:45.006193411Z" level=info msg="Stop CRI service" Sep 4 00:03:45.007442 dockerd[1689]: time="2025-09-04T00:03:45.007276313Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 4 00:03:45.007442 dockerd[1689]: time="2025-09-04T00:03:45.007301971Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 4 00:03:45.007527 sshd[1980]: Connection closed by 10.0.0.1 port 36176 Sep 4 00:03:45.008000 sshd-session[1978]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:45.013666 containerd[1509]: time="2025-09-04T00:03:45.012424629Z" level=info msg="Stop CRI service" Sep 4 00:03:45.013666 containerd[1509]: time="2025-09-04T00:03:45.012814130Z" level=info msg="Event monitor stopped" Sep 4 00:03:45.013666 containerd[1509]: time="2025-09-04T00:03:45.012827806Z" level=info msg="Stream server stopped" Sep 4 00:03:45.030273 systemd[1]: containerd.service: Deactivated successfully. Sep 4 00:03:45.030426 systemd[1]: containerd.service: Unit process 1920 (containerd-shim) remains running after unit stopped. Sep 4 00:03:45.030814 systemd[1]: containerd.service: Consumed 370ms CPU time, 137.2M memory peak. Sep 4 00:03:45.031413 systemd[1]: sshd@9-10.0.0.77:22-10.0.0.1:36176.service: Deactivated successfully. Sep 4 00:03:45.033700 systemd[1]: session-10.scope: Deactivated successfully. Sep 4 00:03:45.037349 systemd-logind[1451]: Session 10 logged out. Waiting for processes to exit. Sep 4 00:03:45.047761 systemd[1]: Started sshd@10-10.0.0.77:22-10.0.0.1:36178.service - OpenSSH per-connection server daemon (10.0.0.1:36178). Sep 4 00:03:45.050044 systemd-logind[1451]: Removed session 10. Sep 4 00:03:45.130792 sshd[1988]: Accepted publickey for core from 10.0.0.1 port 36178 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:45.133420 sshd-session[1988]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:45.151896 systemd-logind[1451]: New session 11 of user core. Sep 4 00:03:45.164793 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 4 00:03:45.243165 sshd[1990]: Connection closed by 10.0.0.1 port 36178 Sep 4 00:03:45.242288 sshd-session[1988]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:45.248971 systemd[1]: sshd@10-10.0.0.77:22-10.0.0.1:36178.service: Deactivated successfully. Sep 4 00:03:45.251273 systemd[1]: session-11.scope: Deactivated successfully. Sep 4 00:03:45.256746 systemd-logind[1451]: Session 11 logged out. Waiting for processes to exit. Sep 4 00:03:45.261479 systemd-logind[1451]: Removed session 11. Sep 4 00:03:45.493763 systemd-networkd[1412]: docker0: Gained IPv6LL Sep 4 00:03:46.389793 systemd-networkd[1412]: veth53eb0ec: Gained IPv6LL Sep 4 00:03:50.277018 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 4 00:03:50.277458 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 4 00:03:50.277635 dockerd[1689]: time="2025-09-04T00:03:50.277587841Z" level=info msg="Processing signal 'terminated'" Sep 4 00:03:51.257199 systemd[1]: Started sshd@11-10.0.0.77:22-10.0.0.1:46582.service - OpenSSH per-connection server daemon (10.0.0.1:46582). Sep 4 00:03:51.295919 sshd[1996]: Accepted publickey for core from 10.0.0.1 port 46582 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:51.297696 sshd-session[1996]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:51.302100 systemd-logind[1451]: New session 12 of user core. Sep 4 00:03:51.311681 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 4 00:03:51.367576 sshd[1998]: Connection closed by 10.0.0.1 port 46582 Sep 4 00:03:51.367833 sshd-session[1996]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:51.370518 systemd[1]: sshd@11-10.0.0.77:22-10.0.0.1:46582.service: Deactivated successfully. Sep 4 00:03:51.372300 systemd[1]: session-12.scope: Deactivated successfully. Sep 4 00:03:51.373660 systemd-logind[1451]: Session 12 logged out. Waiting for processes to exit. Sep 4 00:03:51.374797 systemd-logind[1451]: Removed session 12. Sep 4 00:03:52.278431 dockerd[1689]: time="2025-09-04T00:03:52.278364205Z" level=error msg="Error sending stop (signal 15) to container" container=7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c error="Cannot kill container 7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" Sep 4 00:03:52.278431 dockerd[1689]: time="2025-09-04T00:03:52.278415882Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c Sep 4 00:03:57.386047 systemd[1]: Started sshd@12-10.0.0.77:22-10.0.0.1:46592.service - OpenSSH per-connection server daemon (10.0.0.1:46592). Sep 4 00:03:57.428757 sshd[2004]: Accepted publickey for core from 10.0.0.1 port 46592 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:03:57.430445 sshd-session[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:03:57.434738 systemd-logind[1451]: New session 13 of user core. Sep 4 00:03:57.445678 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 4 00:03:57.501753 sshd[2006]: Connection closed by 10.0.0.1 port 46592 Sep 4 00:03:57.502061 sshd-session[2004]: pam_unix(sshd:session): session closed for user core Sep 4 00:03:57.505694 systemd[1]: sshd@12-10.0.0.77:22-10.0.0.1:46592.service: Deactivated successfully. Sep 4 00:03:57.507495 systemd[1]: session-13.scope: Deactivated successfully. Sep 4 00:03:57.508323 systemd-logind[1451]: Session 13 logged out. Waiting for processes to exit. Sep 4 00:03:57.509502 systemd-logind[1451]: Removed session 13. Sep 4 00:04:02.279205 dockerd[1689]: time="2025-09-04T00:04:02.279100588Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c error="context deadline exceeded" Sep 4 00:04:02.280316 systemd[1]: docker-7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c.scope: Deactivated successfully. Sep 4 00:04:03.522251 systemd[1]: Started sshd@13-10.0.0.77:22-10.0.0.1:49336.service - OpenSSH per-connection server daemon (10.0.0.1:49336). Sep 4 00:04:03.561858 sshd[2012]: Accepted publickey for core from 10.0.0.1 port 49336 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:03.563575 sshd-session[2012]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:03.568385 systemd-logind[1451]: New session 14 of user core. Sep 4 00:04:03.585788 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 4 00:04:03.641260 sshd[2014]: Connection closed by 10.0.0.1 port 49336 Sep 4 00:04:03.641659 sshd-session[2012]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:03.644750 systemd[1]: sshd@13-10.0.0.77:22-10.0.0.1:49336.service: Deactivated successfully. Sep 4 00:04:03.646797 systemd[1]: session-14.scope: Deactivated successfully. Sep 4 00:04:03.649073 systemd-logind[1451]: Session 14 logged out. Waiting for processes to exit. Sep 4 00:04:03.649972 systemd-logind[1451]: Removed session 14. Sep 4 00:04:05.278031 dockerd[1689]: time="2025-09-04T00:04:05.277974669Z" level=error msg="Force shutdown daemon" Sep 4 00:04:05.278392 dockerd[1689]: time="2025-09-04T00:04:05.278111225Z" level=info msg="Daemon shutdown complete" Sep 4 00:04:05.282909 systemd[1]: docker.service: Deactivated successfully. Sep 4 00:04:05.283264 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 4 00:04:05.283323 systemd[1]: docker.service: Consumed 1.126s CPU time, 127.2M memory peak. Sep 4 00:04:05.283839 systemd[1]: docker.socket: Deactivated successfully. Sep 4 00:04:05.284229 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 4 00:04:05.284272 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 4 00:04:05.286196 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 00:04:05.286397 systemd[1]: containerd.service: Found left-over process 1920 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 00:04:05.286404 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 00:04:05.296878 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 00:04:05.297653 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 00:04:05.308877 systemd[1]: containerd.service: Found left-over process 1920 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 00:04:05.308886 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 00:04:05.313553 (ntainerd)[2025]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 00:04:05.328198 containerd[2025]: time="2025-09-04T00:04:05Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 4 00:04:05.328783 containerd[2025]: time="2025-09-04T00:04:05.328753275Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Sep 4 00:04:05.337097 containerd[2025]: time="2025-09-04T00:04:05.337062761Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.414µs" Sep 4 00:04:05.337097 containerd[2025]: time="2025-09-04T00:04:05.337085614Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 4 00:04:05.337187 containerd[2025]: time="2025-09-04T00:04:05.337101233Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 4 00:04:05.337187 containerd[2025]: time="2025-09-04T00:04:05.337126691Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 4 00:04:05.337187 containerd[2025]: time="2025-09-04T00:04:05.337136740Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 4 00:04:05.337345 containerd[2025]: time="2025-09-04T00:04:05.337324261Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337367 containerd[2025]: time="2025-09-04T00:04:05.337350681Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337367 containerd[2025]: time="2025-09-04T00:04:05.337359257Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337677 containerd[2025]: time="2025-09-04T00:04:05.337599357Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337677 containerd[2025]: time="2025-09-04T00:04:05.337612863Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337677 containerd[2025]: time="2025-09-04T00:04:05.337622832Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337677 containerd[2025]: time="2025-09-04T00:04:05.337630536Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337677 containerd[2025]: time="2025-09-04T00:04:05.337647608Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337813 containerd[2025]: time="2025-09-04T00:04:05.337731706Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337813 containerd[2025]: time="2025-09-04T00:04:05.337753627Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:04:05.337813 containerd[2025]: time="2025-09-04T00:04:05.337762063Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 4 00:04:05.337813 containerd[2025]: time="2025-09-04T00:04:05.337788983Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 4 00:04:05.337975 containerd[2025]: time="2025-09-04T00:04:05.337950095Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 4 00:04:05.337975 containerd[2025]: time="2025-09-04T00:04:05.337972507Z" level=info msg="metadata content store policy set" policy=shared Sep 4 00:04:05.338126 containerd[2025]: time="2025-09-04T00:04:05.338106018Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 4 00:04:05.338156 containerd[2025]: time="2025-09-04T00:04:05.338135243Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 4 00:04:05.338156 containerd[2025]: time="2025-09-04T00:04:05.338149670Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 4 00:04:05.338202 containerd[2025]: time="2025-09-04T00:04:05.338162784Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 4 00:04:05.338202 containerd[2025]: time="2025-09-04T00:04:05.338175178Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 4 00:04:05.338202 containerd[2025]: time="2025-09-04T00:04:05.338189625Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 4 00:04:05.338202 containerd[2025]: time="2025-09-04T00:04:05.338200024Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 4 00:04:05.338317 containerd[2025]: time="2025-09-04T00:04:05.338212798Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 4 00:04:05.338317 containerd[2025]: time="2025-09-04T00:04:05.338224630Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 4 00:04:05.338317 containerd[2025]: time="2025-09-04T00:04:05.338236042Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 4 00:04:05.338317 containerd[2025]: time="2025-09-04T00:04:05.338247283Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 4 00:04:05.338317 containerd[2025]: time="2025-09-04T00:04:05.338260478Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 4 00:04:05.338508 containerd[2025]: time="2025-09-04T00:04:05.338484528Z" level=info msg="connecting to shim 7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c" address="unix:///run/containerd/s/f00ea59031d75a647aaf2a0a6d0eed37d3d1e7e0e645ed7cd7ee6f79c4d901b2" namespace=moby protocol=ttrpc version=3 Sep 4 00:04:05.346397 containerd[2025]: time="2025-09-04T00:04:05.346357205Z" level=info msg="cleaning leaked shim process" id=7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c namespace=moby Sep 4 00:04:05.355741 containerd[2025]: time="2025-09-04T00:04:05.355665044Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 4 00:04:05.356154 containerd[2025]: time="2025-09-04T00:04:05.356123283Z" level=info msg="shim disconnected" id=7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c namespace=moby Sep 4 00:04:05.356198 containerd[2025]: time="2025-09-04T00:04:05.356155574Z" level=warning msg="cleaning up after shim disconnected" id=7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c namespace=moby Sep 4 00:04:05.356198 containerd[2025]: time="2025-09-04T00:04:05.356165282Z" level=info msg="cleaning up dead shim" namespace=moby Sep 4 00:04:05.367630 containerd[2025]: time="2025-09-04T00:04:05.367552461Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Sep 4 00:04:05.367737 containerd[2025]: time="2025-09-04T00:04:05.367689768Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 4 00:04:05.367737 containerd[2025]: time="2025-09-04T00:04:05.367717390Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 4 00:04:05.367737 containerd[2025]: time="2025-09-04T00:04:05.367735043Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367746014Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367755672Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367764649Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367775740Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367785167Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367796459Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 4 00:04:05.367812 containerd[2025]: time="2025-09-04T00:04:05.367805996Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 4 00:04:05.367951 containerd[2025]: time="2025-09-04T00:04:05.367815013Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 4 00:04:05.367951 containerd[2025]: time="2025-09-04T00:04:05.367873463Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 4 00:04:05.367951 containerd[2025]: time="2025-09-04T00:04:05.367884995Z" level=info msg="Start snapshots syncer" Sep 4 00:04:05.367951 containerd[2025]: time="2025-09-04T00:04:05.367912536Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 4 00:04:05.368186 containerd[2025]: time="2025-09-04T00:04:05.368144852Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 4 00:04:05.368271 containerd[2025]: time="2025-09-04T00:04:05.368195748Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 4 00:04:05.368271 containerd[2025]: time="2025-09-04T00:04:05.368263234Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 4 00:04:05.368344 containerd[2025]: time="2025-09-04T00:04:05.368308369Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 4 00:04:05.368381 containerd[2025]: time="2025-09-04T00:04:05.368350167Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 4 00:04:05.368381 containerd[2025]: time="2025-09-04T00:04:05.368362230Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 4 00:04:05.368381 containerd[2025]: time="2025-09-04T00:04:05.368373110Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 4 00:04:05.368467 containerd[2025]: time="2025-09-04T00:04:05.368385584Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 4 00:04:05.368467 containerd[2025]: time="2025-09-04T00:04:05.368400752Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 4 00:04:05.368467 containerd[2025]: time="2025-09-04T00:04:05.368412214Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 4 00:04:05.368467 containerd[2025]: time="2025-09-04T00:04:05.368434576Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 4 00:04:05.368467 containerd[2025]: time="2025-09-04T00:04:05.368444314Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 4 00:04:05.368467 containerd[2025]: time="2025-09-04T00:04:05.368453331Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 4 00:04:05.368672 containerd[2025]: time="2025-09-04T00:04:05.368648346Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:04:05.368738 containerd[2025]: time="2025-09-04T00:04:05.368719380Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:04:05.368776 containerd[2025]: time="2025-09-04T00:04:05.368734628Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:04:05.368776 containerd[2025]: time="2025-09-04T00:04:05.368752201Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:04:05.368776 containerd[2025]: time="2025-09-04T00:04:05.368767310Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 4 00:04:05.368847 containerd[2025]: time="2025-09-04T00:04:05.368781176Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 4 00:04:05.368847 containerd[2025]: time="2025-09-04T00:04:05.368799650Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 4 00:04:05.368903 containerd[2025]: time="2025-09-04T00:04:05.368861015Z" level=info msg="runtime interface created" Sep 4 00:04:05.368903 containerd[2025]: time="2025-09-04T00:04:05.368878769Z" level=info msg="created NRI interface" Sep 4 00:04:05.368903 containerd[2025]: time="2025-09-04T00:04:05.368890511Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 4 00:04:05.368973 containerd[2025]: time="2025-09-04T00:04:05.368907723Z" level=info msg="Connect containerd service" Sep 4 00:04:05.368973 containerd[2025]: time="2025-09-04T00:04:05.368939262Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 00:04:05.369668 containerd[2025]: time="2025-09-04T00:04:05.369482341Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 4 00:04:05.379663 containerd[2025]: time="2025-09-04T00:04:05.379602463Z" level=info msg="Start subscribing containerd event" Sep 4 00:04:05.379663 containerd[2025]: time="2025-09-04T00:04:05.379656865Z" level=info msg="Start recovering state" Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379753426Z" level=info msg="Start event monitor" Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379770949Z" level=info msg="Start cni network conf syncer for default" Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379783773Z" level=info msg="Start streaming server" Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379801497Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379809572Z" level=info msg="runtime interface starting up..." Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379817136Z" level=info msg="starting plugins..." Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379828076Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 4 00:04:05.379852 containerd[2025]: time="2025-09-04T00:04:05.379834849Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 00:04:05.380046 containerd[2025]: time="2025-09-04T00:04:05.379895333Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 00:04:05.380046 containerd[2025]: time="2025-09-04T00:04:05.379967418Z" level=info msg="containerd successfully booted in 0.051941s" Sep 4 00:04:05.380091 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 00:04:05.381964 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 4 00:04:05.401909 (dockerd)[2073]: 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 Sep 4 00:04:05.429305 dockerd[2073]: time="2025-09-04T00:04:05.429214561Z" level=info msg="Starting up" Sep 4 00:04:05.430043 dockerd[2073]: time="2025-09-04T00:04:05.430008911Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 4 00:04:06.415016 dockerd[2073]: time="2025-09-04T00:04:06.414938548Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 4 00:04:06.439957 dockerd[2073]: time="2025-09-04T00:04:06.439904236Z" level=info msg="Loading containers: start." Sep 4 00:04:06.950077 systemd[1]: var-lib-docker-overlay2-57b7a99c4240ea6b098dd1f95924283438b715738245c2c71a17ae844a32d9ba-merged.mount: Deactivated successfully. Sep 4 00:04:07.510207 systemd-networkd[1412]: veth53eb0ec: Link DOWN Sep 4 00:04:07.510221 systemd-networkd[1412]: veth53eb0ec: Lost carrier Sep 4 00:04:07.511174 systemd[1]: run-docker-netns-26e5a7ed4a67.mount: Deactivated successfully. Sep 4 00:04:07.512965 kernel: docker0: port 1(veth53eb0ec) entered disabled state Sep 4 00:04:07.513023 kernel: veth53eb0ec (unregistering): left allmulticast mode Sep 4 00:04:07.513042 kernel: veth53eb0ec (unregistering): left promiscuous mode Sep 4 00:04:07.513703 kernel: docker0: port 1(veth53eb0ec) entered disabled state Sep 4 00:04:07.515014 systemd-networkd[1412]: docker0: Lost carrier Sep 4 00:04:07.518453 dockerd[2073]: time="2025-09-04T00:04:07.517939753Z" level=info msg="Removing stale sandbox 26e5a7ed4a6774125c01d9d7ece441bd9d4a8fbcc4d048e5c2631f73f7eba23e (7b2c660d683aa445cde58598b5201f4cdd1bc1d11283aa8e9f2c9f37fda9dd1c)" Sep 4 00:04:07.672621 dockerd[2073]: time="2025-09-04T00:04:07.672383044Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 4 00:04:07.672751 dockerd[2073]: time="2025-09-04T00:04:07.672650837Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 2adbbcb1b1a347689ec352de9b3bc9018f1573829720930ecbcd5172d3f9f619 52524524cc424290e773011c74f383d665516c25d58ed1fe5a13abb2eb86310d], retrying...." Sep 4 00:04:07.950173 systemd[1]: run-docker-netns-26e5a7ed4a67.mount: Deactivated successfully. Sep 4 00:04:08.356495 dockerd[2073]: time="2025-09-04T00:04:08.356429648Z" level=warning msg="error locating sandbox id 26e5a7ed4a6774125c01d9d7ece441bd9d4a8fbcc4d048e5c2631f73f7eba23e: sandbox 26e5a7ed4a6774125c01d9d7ece441bd9d4a8fbcc4d048e5c2631f73f7eba23e not found" Sep 4 00:04:08.356776 dockerd[2073]: time="2025-09-04T00:04:08.356709447Z" level=info msg="Loading containers: done." Sep 4 00:04:08.369987 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck449258527-merged.mount: Deactivated successfully. Sep 4 00:04:08.393886 dockerd[2073]: time="2025-09-04T00:04:08.393728942Z" 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 Sep 4 00:04:08.393886 dockerd[2073]: time="2025-09-04T00:04:08.393829025Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Sep 4 00:04:08.393886 dockerd[2073]: time="2025-09-04T00:04:08.393885183Z" level=info msg="Initializing buildkit" Sep 4 00:04:08.414385 dockerd[2073]: time="2025-09-04T00:04:08.414322798Z" level=info msg="Completed buildkit initialization" Sep 4 00:04:08.419992 dockerd[2073]: time="2025-09-04T00:04:08.419933089Z" level=info msg="Daemon has completed initialization" Sep 4 00:04:08.420152 dockerd[2073]: time="2025-09-04T00:04:08.420076305Z" level=info msg="API listen on /run/docker.sock" Sep 4 00:04:08.420267 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 4 00:04:09.661045 systemd[1]: Started sshd@14-10.0.0.77:22-10.0.0.1:49340.service - OpenSSH per-connection server daemon (10.0.0.1:49340). Sep 4 00:04:09.714568 sshd[2294]: Accepted publickey for core from 10.0.0.1 port 49340 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:09.716199 sshd-session[2294]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:09.720652 systemd-logind[1451]: New session 15 of user core. Sep 4 00:04:09.731724 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 4 00:04:09.789405 sshd[2296]: Connection closed by 10.0.0.1 port 49340 Sep 4 00:04:09.789689 sshd-session[2294]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:09.805581 systemd[1]: sshd@14-10.0.0.77:22-10.0.0.1:49340.service: Deactivated successfully. Sep 4 00:04:09.807399 systemd[1]: session-15.scope: Deactivated successfully. Sep 4 00:04:09.808163 systemd-logind[1451]: Session 15 logged out. Waiting for processes to exit. Sep 4 00:04:09.810615 systemd[1]: Started sshd@15-10.0.0.77:22-10.0.0.1:49352.service - OpenSSH per-connection server daemon (10.0.0.1:49352). Sep 4 00:04:09.811210 systemd-logind[1451]: Removed session 15. Sep 4 00:04:09.861492 sshd[2302]: Accepted publickey for core from 10.0.0.1 port 49352 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:09.862689 sshd-session[2302]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:09.867215 systemd-logind[1451]: New session 16 of user core. Sep 4 00:04:09.876677 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 4 00:04:09.931348 sshd[2304]: Connection closed by 10.0.0.1 port 49352 Sep 4 00:04:09.931912 sshd-session[2302]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:09.945270 systemd[1]: sshd@15-10.0.0.77:22-10.0.0.1:49352.service: Deactivated successfully. Sep 4 00:04:09.947023 systemd[1]: session-16.scope: Deactivated successfully. Sep 4 00:04:09.947799 systemd-logind[1451]: Session 16 logged out. Waiting for processes to exit. Sep 4 00:04:09.950482 systemd[1]: Started sshd@16-10.0.0.77:22-10.0.0.1:60954.service - OpenSSH per-connection server daemon (10.0.0.1:60954). Sep 4 00:04:09.951206 systemd-logind[1451]: Removed session 16. Sep 4 00:04:10.008575 sshd[2310]: Accepted publickey for core from 10.0.0.1 port 60954 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:10.010055 sshd-session[2310]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:10.014735 systemd-logind[1451]: New session 17 of user core. Sep 4 00:04:10.024701 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 4 00:04:10.085738 sshd[2312]: Connection closed by 10.0.0.1 port 60954 Sep 4 00:04:10.086109 sshd-session[2310]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:10.102300 systemd[1]: sshd@16-10.0.0.77:22-10.0.0.1:60954.service: Deactivated successfully. Sep 4 00:04:10.104608 systemd[1]: session-17.scope: Deactivated successfully. Sep 4 00:04:10.105480 systemd-logind[1451]: Session 17 logged out. Waiting for processes to exit. Sep 4 00:04:10.109392 systemd[1]: Started sshd@17-10.0.0.77:22-10.0.0.1:60968.service - OpenSSH per-connection server daemon (10.0.0.1:60968). Sep 4 00:04:10.110101 systemd-logind[1451]: Removed session 17. Sep 4 00:04:10.160704 sshd[2325]: Accepted publickey for core from 10.0.0.1 port 60968 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:10.162405 sshd-session[2325]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:10.167602 systemd-logind[1451]: New session 18 of user core. Sep 4 00:04:10.177725 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 4 00:04:10.515964 systemd[1]: var-lib-docker-overlay2-70f3e730c7925eec02d58948d9afab8815dbb683bbcae24693b3305c8402ae39\x2dinit-merged.mount: Deactivated successfully. Sep 4 00:04:10.582439 containerd[2025]: time="2025-09-04T00:04:10.582381409Z" level=info msg="connecting to shim b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf" address="unix:///run/containerd/s/ba341ebd175738871a933b1b89307c28582174e240fb9bf89c33c97abb63f9eb" namespace=moby protocol=ttrpc version=3 Sep 4 00:04:10.613800 systemd[1]: Started docker-b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf.scope - libcontainer container b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf. Sep 4 00:04:10.631809 systemd-resolved[1350]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 4 00:04:10.657154 kernel: docker0: port 1(veth2bd31b3) entered blocking state Sep 4 00:04:10.657265 kernel: docker0: port 1(veth2bd31b3) entered disabled state Sep 4 00:04:10.657284 kernel: veth2bd31b3: entered allmulticast mode Sep 4 00:04:10.658699 kernel: veth2bd31b3: entered promiscuous mode Sep 4 00:04:10.659684 systemd-networkd[1412]: veth2bd31b3: Link UP Sep 4 00:04:10.666591 kernel: eth0: renamed from vethd120a29 Sep 4 00:04:10.669250 kernel: docker0: port 1(veth2bd31b3) entered blocking state Sep 4 00:04:10.669287 kernel: docker0: port 1(veth2bd31b3) entered forwarding state Sep 4 00:04:10.669757 systemd-networkd[1412]: veth2bd31b3: Gained carrier Sep 4 00:04:10.670112 systemd-networkd[1412]: docker0: Gained carrier Sep 4 00:04:10.698151 sshd[2327]: Connection closed by 10.0.0.1 port 60968 Sep 4 00:04:10.698491 sshd-session[2325]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:10.712771 systemd[1]: sshd@17-10.0.0.77:22-10.0.0.1:60968.service: Deactivated successfully. Sep 4 00:04:10.714927 systemd[1]: session-18.scope: Deactivated successfully. Sep 4 00:04:10.715792 systemd-logind[1451]: Session 18 logged out. Waiting for processes to exit. Sep 4 00:04:10.719101 systemd[1]: Started sshd@18-10.0.0.77:22-10.0.0.1:60976.service - OpenSSH per-connection server daemon (10.0.0.1:60976). Sep 4 00:04:10.719860 systemd-logind[1451]: Removed session 18. Sep 4 00:04:10.769457 sshd[2397]: Accepted publickey for core from 10.0.0.1 port 60976 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:10.771208 sshd-session[2397]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:10.775379 systemd-logind[1451]: New session 19 of user core. Sep 4 00:04:10.785711 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 4 00:04:10.840602 sshd[2399]: Connection closed by 10.0.0.1 port 60976 Sep 4 00:04:10.840908 sshd-session[2397]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:10.859165 systemd[1]: sshd@18-10.0.0.77:22-10.0.0.1:60976.service: Deactivated successfully. Sep 4 00:04:10.860759 systemd[1]: session-19.scope: Deactivated successfully. Sep 4 00:04:10.861434 systemd-logind[1451]: Session 19 logged out. Waiting for processes to exit. Sep 4 00:04:10.863921 systemd[1]: Started sshd@19-10.0.0.77:22-10.0.0.1:60982.service - OpenSSH per-connection server daemon (10.0.0.1:60982). Sep 4 00:04:10.864450 systemd-logind[1451]: Removed session 19. Sep 4 00:04:10.922123 sshd[2405]: Accepted publickey for core from 10.0.0.1 port 60982 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:10.923561 sshd-session[2405]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:10.928558 systemd-logind[1451]: New session 20 of user core. Sep 4 00:04:10.946833 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 4 00:04:11.001309 sudo[2408]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2025 Sep 4 00:04:11.001667 sudo[2408]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:04:11.005355 sudo[2408]: pam_unix(sudo:session): session closed for user root Sep 4 00:04:11.007163 sshd[2407]: Connection closed by 10.0.0.1 port 60982 Sep 4 00:04:11.007696 sshd-session[2405]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:11.010403 dockerd[2073]: time="2025-09-04T00:04:11.010344248Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 4 00:04:11.010403 dockerd[2073]: time="2025-09-04T00:04:11.010389204Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 4 00:04:11.010789 dockerd[2073]: time="2025-09-04T00:04:11.010496060Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 4 00:04:11.010789 dockerd[2073]: time="2025-09-04T00:04:11.010511138Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 4 00:04:11.020402 systemd[1]: containerd.service: Deactivated successfully. Sep 4 00:04:11.020588 systemd[1]: containerd.service: Unit process 2346 (containerd-shim) remains running after unit stopped. Sep 4 00:04:11.020960 systemd[1]: containerd.service: Consumed 171ms CPU time, 137.2M memory peak. Sep 4 00:04:11.021506 systemd[1]: sshd@19-10.0.0.77:22-10.0.0.1:60982.service: Deactivated successfully. Sep 4 00:04:11.023455 systemd[1]: session-20.scope: Deactivated successfully. Sep 4 00:04:11.024359 systemd-logind[1451]: Session 20 logged out. Waiting for processes to exit. Sep 4 00:04:11.028625 systemd[1]: Started sshd@20-10.0.0.77:22-10.0.0.1:60996.service - OpenSSH per-connection server daemon (10.0.0.1:60996). Sep 4 00:04:11.029346 systemd-logind[1451]: Removed session 20. Sep 4 00:04:11.087424 sshd[2415]: Accepted publickey for core from 10.0.0.1 port 60996 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:11.089303 sshd-session[2415]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:11.094831 systemd-logind[1451]: New session 21 of user core. Sep 4 00:04:11.104716 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 4 00:04:11.163982 sshd[2417]: Connection closed by 10.0.0.1 port 60996 Sep 4 00:04:11.164301 sshd-session[2415]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:11.167866 systemd[1]: sshd@20-10.0.0.77:22-10.0.0.1:60996.service: Deactivated successfully. Sep 4 00:04:11.169955 systemd[1]: session-21.scope: Deactivated successfully. Sep 4 00:04:11.171461 systemd-logind[1451]: Session 21 logged out. Waiting for processes to exit. Sep 4 00:04:11.173007 systemd-logind[1451]: Removed session 21. Sep 4 00:04:11.861806 systemd-networkd[1412]: veth2bd31b3: Gained IPv6LL Sep 4 00:04:16.026902 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 4 00:04:16.027257 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 4 00:04:16.027484 dockerd[2073]: time="2025-09-04T00:04:16.027423222Z" level=info msg="Processing signal 'terminated'" Sep 4 00:04:17.189045 systemd[1]: Started sshd@21-10.0.0.77:22-10.0.0.1:32778.service - OpenSSH per-connection server daemon (10.0.0.1:32778). Sep 4 00:04:17.231282 sshd[2423]: Accepted publickey for core from 10.0.0.1 port 32778 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:17.232940 sshd-session[2423]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:17.237427 systemd-logind[1451]: New session 22 of user core. Sep 4 00:04:17.251838 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 4 00:04:17.309086 sshd[2425]: Connection closed by 10.0.0.1 port 32778 Sep 4 00:04:17.309374 sshd-session[2423]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:17.314008 systemd[1]: sshd@21-10.0.0.77:22-10.0.0.1:32778.service: Deactivated successfully. Sep 4 00:04:17.315924 systemd[1]: session-22.scope: Deactivated successfully. Sep 4 00:04:17.316864 systemd-logind[1451]: Session 22 logged out. Waiting for processes to exit. Sep 4 00:04:17.318043 systemd-logind[1451]: Removed session 22. Sep 4 00:04:18.029474 dockerd[2073]: time="2025-09-04T00:04:18.029304994Z" level=error msg="Error sending stop (signal 15) to container" container=b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf error="Cannot kill container b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Sep 4 00:04:18.029474 dockerd[2073]: time="2025-09-04T00:04:18.029421285Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf Sep 4 00:04:20.441888 update_engine[1452]: I20250904 00:04:20.441768 1452 update_attempter.cc:509] Updating boot flags... Sep 4 00:04:23.333059 systemd[1]: Started sshd@22-10.0.0.77:22-10.0.0.1:58172.service - OpenSSH per-connection server daemon (10.0.0.1:58172). Sep 4 00:04:23.410024 sshd[2447]: Accepted publickey for core from 10.0.0.1 port 58172 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:23.412087 sshd-session[2447]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:23.431839 systemd-logind[1451]: New session 23 of user core. Sep 4 00:04:23.443146 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 4 00:04:23.520467 sshd[2449]: Connection closed by 10.0.0.1 port 58172 Sep 4 00:04:23.521351 sshd-session[2447]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:23.526596 systemd[1]: sshd@22-10.0.0.77:22-10.0.0.1:58172.service: Deactivated successfully. Sep 4 00:04:23.529637 systemd[1]: session-23.scope: Deactivated successfully. Sep 4 00:04:23.530843 systemd-logind[1451]: Session 23 logged out. Waiting for processes to exit. Sep 4 00:04:23.533304 systemd-logind[1451]: Removed session 23. Sep 4 00:04:28.029989 dockerd[2073]: time="2025-09-04T00:04:28.029895999Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf error="context deadline exceeded" Sep 4 00:04:28.031080 systemd[1]: docker-b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf.scope: Deactivated successfully. Sep 4 00:04:29.539302 systemd[1]: Started sshd@23-10.0.0.77:22-10.0.0.1:58176.service - OpenSSH per-connection server daemon (10.0.0.1:58176). Sep 4 00:04:29.610679 sshd[2455]: Accepted publickey for core from 10.0.0.1 port 58176 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:29.613800 sshd-session[2455]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:29.621951 systemd-logind[1451]: New session 24 of user core. Sep 4 00:04:29.631870 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 4 00:04:29.695627 sshd[2457]: Connection closed by 10.0.0.1 port 58176 Sep 4 00:04:29.695419 sshd-session[2455]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:29.700671 systemd[1]: sshd@23-10.0.0.77:22-10.0.0.1:58176.service: Deactivated successfully. Sep 4 00:04:29.706141 systemd[1]: session-24.scope: Deactivated successfully. Sep 4 00:04:29.715315 systemd-logind[1451]: Session 24 logged out. Waiting for processes to exit. Sep 4 00:04:29.721212 systemd-logind[1451]: Removed session 24. Sep 4 00:04:31.028008 dockerd[2073]: time="2025-09-04T00:04:31.027921600Z" level=error msg="Force shutdown daemon" Sep 4 00:04:31.028499 dockerd[2073]: time="2025-09-04T00:04:31.028122630Z" level=info msg="Daemon shutdown complete" Sep 4 00:04:31.036769 systemd[1]: docker.service: Deactivated successfully. Sep 4 00:04:31.037202 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 4 00:04:31.037851 systemd[1]: docker.socket: Deactivated successfully. Sep 4 00:04:31.038263 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 4 00:04:31.039304 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 4 00:04:31.042108 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 00:04:31.042341 systemd[1]: containerd.service: Found left-over process 2346 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 00:04:31.042352 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 00:04:31.049327 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 00:04:31.050186 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 00:04:31.067389 systemd[1]: containerd.service: Found left-over process 2346 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 00:04:31.067402 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 00:04:31.086099 (ntainerd)[2468]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 00:04:31.107318 containerd[2468]: time="2025-09-04T00:04:31Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 4 00:04:31.108104 containerd[2468]: time="2025-09-04T00:04:31.108056731Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Sep 4 00:04:31.120242 containerd[2468]: time="2025-09-04T00:04:31.120170858Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.498µs" Sep 4 00:04:31.120242 containerd[2468]: time="2025-09-04T00:04:31.120213219Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 4 00:04:31.120242 containerd[2468]: time="2025-09-04T00:04:31.120233446Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 4 00:04:31.120485 containerd[2468]: time="2025-09-04T00:04:31.120271348Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 4 00:04:31.120485 containerd[2468]: time="2025-09-04T00:04:31.120282298Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 4 00:04:31.120572 containerd[2468]: time="2025-09-04T00:04:31.120514487Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:04:31.120572 containerd[2468]: time="2025-09-04T00:04:31.120560584Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:04:31.120572 containerd[2468]: time="2025-09-04T00:04:31.120571334Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:04:31.120876 containerd[2468]: time="2025-09-04T00:04:31.120840833Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:04:31.120876 containerd[2468]: time="2025-09-04T00:04:31.120857013Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:04:31.120876 containerd[2468]: time="2025-09-04T00:04:31.120866972Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:04:31.120876 containerd[2468]: time="2025-09-04T00:04:31.120875087Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 4 00:04:31.121005 containerd[2468]: time="2025-09-04T00:04:31.120894124Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 4 00:04:31.121005 containerd[2468]: time="2025-09-04T00:04:31.120974556Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:04:31.121005 containerd[2468]: time="2025-09-04T00:04:31.120995725Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:04:31.121005 containerd[2468]: time="2025-09-04T00:04:31.121004111Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 4 00:04:31.121122 containerd[2468]: time="2025-09-04T00:04:31.121035430Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 4 00:04:31.121319 containerd[2468]: time="2025-09-04T00:04:31.121271686Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 4 00:04:31.121319 containerd[2468]: time="2025-09-04T00:04:31.121301793Z" level=info msg="metadata content store policy set" policy=shared Sep 4 00:04:31.121497 containerd[2468]: time="2025-09-04T00:04:31.121456805Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 4 00:04:31.121563 containerd[2468]: time="2025-09-04T00:04:31.121497262Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 4 00:04:31.121596 containerd[2468]: time="2025-09-04T00:04:31.121522489Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 4 00:04:31.121596 containerd[2468]: time="2025-09-04T00:04:31.121587061Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 4 00:04:31.121664 containerd[2468]: time="2025-09-04T00:04:31.121608722Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 4 00:04:31.121664 containerd[2468]: time="2025-09-04T00:04:31.121626586Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 4 00:04:31.121664 containerd[2468]: time="2025-09-04T00:04:31.121649490Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 4 00:04:31.121755 containerd[2468]: time="2025-09-04T00:04:31.121668706Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 4 00:04:31.121755 containerd[2468]: time="2025-09-04T00:04:31.121689595Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 4 00:04:31.121755 containerd[2468]: time="2025-09-04T00:04:31.121712227Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 4 00:04:31.121755 containerd[2468]: time="2025-09-04T00:04:31.121724371Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 4 00:04:31.121755 containerd[2468]: time="2025-09-04T00:04:31.121740211Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 4 00:04:31.122093 containerd[2468]: time="2025-09-04T00:04:31.122051148Z" level=info msg="connecting to shim b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf" address="unix:///run/containerd/s/ba341ebd175738871a933b1b89307c28582174e240fb9bf89c33c97abb63f9eb" namespace=moby protocol=ttrpc version=3 Sep 4 00:04:31.130844 containerd[2468]: time="2025-09-04T00:04:31.130791848Z" level=info msg="cleaning leaked shim process" id=b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf namespace=moby Sep 4 00:04:31.141895 containerd[2468]: time="2025-09-04T00:04:31.141785219Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 4 00:04:31.142071 containerd[2468]: time="2025-09-04T00:04:31.142041734Z" level=info msg="shim disconnected" id=b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf namespace=moby Sep 4 00:04:31.142071 containerd[2468]: time="2025-09-04T00:04:31.142068003Z" level=warning msg="cleaning up after shim disconnected" id=b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf namespace=moby Sep 4 00:04:31.142142 containerd[2468]: time="2025-09-04T00:04:31.142075317Z" level=info msg="cleaning up dead shim" namespace=moby Sep 4 00:04:31.154030 containerd[2468]: time="2025-09-04T00:04:31.153962547Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Sep 4 00:04:31.154154 containerd[2468]: time="2025-09-04T00:04:31.154092822Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 4 00:04:31.154154 containerd[2468]: time="2025-09-04T00:04:31.154117919Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 4 00:04:31.154154 containerd[2468]: time="2025-09-04T00:04:31.154136295Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 4 00:04:31.154154 containerd[2468]: time="2025-09-04T00:04:31.154148357Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154160360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154173234Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154185086Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154196528Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154209012Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154221175Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 4 00:04:31.154311 containerd[2468]: time="2025-09-04T00:04:31.154233658Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 4 00:04:31.154510 containerd[2468]: time="2025-09-04T00:04:31.154310964Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 4 00:04:31.154510 containerd[2468]: time="2025-09-04T00:04:31.154332334Z" level=info msg="Start snapshots syncer" Sep 4 00:04:31.154510 containerd[2468]: time="2025-09-04T00:04:31.154366699Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 4 00:04:31.154702 containerd[2468]: time="2025-09-04T00:04:31.154648702Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 4 00:04:31.154836 containerd[2468]: time="2025-09-04T00:04:31.154714276Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 4 00:04:31.154836 containerd[2468]: time="2025-09-04T00:04:31.154797543Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 4 00:04:31.154906 containerd[2468]: time="2025-09-04T00:04:31.154839081Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 4 00:04:31.154906 containerd[2468]: time="2025-09-04T00:04:31.154867414Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 4 00:04:31.154906 containerd[2468]: time="2025-09-04T00:04:31.154878987Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 4 00:04:31.154906 containerd[2468]: time="2025-09-04T00:04:31.154889957Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 4 00:04:31.154906 containerd[2468]: time="2025-09-04T00:04:31.154902130Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.154913642Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.154925414Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.154950802Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.154961833Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.154973195Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.155008010Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.155022497Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.155032456Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.155042455Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.155051793Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 4 00:04:31.155065 containerd[2468]: time="2025-09-04T00:04:31.155062233Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 4 00:04:31.155380 containerd[2468]: time="2025-09-04T00:04:31.155074866Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 4 00:04:31.155380 containerd[2468]: time="2025-09-04T00:04:31.155095525Z" level=info msg="runtime interface created" Sep 4 00:04:31.155380 containerd[2468]: time="2025-09-04T00:04:31.155101566Z" level=info msg="created NRI interface" Sep 4 00:04:31.155380 containerd[2468]: time="2025-09-04T00:04:31.155110824Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 4 00:04:31.155380 containerd[2468]: time="2025-09-04T00:04:31.155123028Z" level=info msg="Connect containerd service" Sep 4 00:04:31.155380 containerd[2468]: time="2025-09-04T00:04:31.155165487Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 00:04:31.155736 containerd[2468]: time="2025-09-04T00:04:31.155703563Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 4 00:04:31.167591 containerd[2468]: time="2025-09-04T00:04:31.167465065Z" level=info msg="Start subscribing containerd event" Sep 4 00:04:31.167769 containerd[2468]: time="2025-09-04T00:04:31.167609417Z" level=info msg="Start recovering state" Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.167927788Z" level=info msg="Start event monitor" Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.167957545Z" level=info msg="Start cni network conf syncer for default" Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.167969017Z" level=info msg="Start streaming server" Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.167979657Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.168000355Z" level=info msg="runtime interface starting up..." Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.168013230Z" level=info msg="starting plugins..." Sep 4 00:04:31.168036 containerd[2468]: time="2025-09-04T00:04:31.168029390Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 4 00:04:31.168214 containerd[2468]: time="2025-09-04T00:04:31.168146151Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 00:04:31.168268 containerd[2468]: time="2025-09-04T00:04:31.168248774Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 00:04:31.168356 containerd[2468]: time="2025-09-04T00:04:31.168326571Z" level=info msg="containerd successfully booted in 0.061241s" Sep 4 00:04:31.168427 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 00:04:31.170363 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 4 00:04:31.188204 (dockerd)[2514]: 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 Sep 4 00:04:31.224847 dockerd[2514]: time="2025-09-04T00:04:31.224767766Z" level=info msg="Starting up" Sep 4 00:04:31.225676 dockerd[2514]: time="2025-09-04T00:04:31.225630564Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 4 00:04:31.250332 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport1933286388-merged.mount: Deactivated successfully. Sep 4 00:04:31.274062 dockerd[2514]: time="2025-09-04T00:04:31.274001133Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 4 00:04:31.298805 dockerd[2514]: time="2025-09-04T00:04:31.298624855Z" level=info msg="Loading containers: start." Sep 4 00:04:31.320963 systemd[1]: var-lib-docker-overlay2-70f3e730c7925eec02d58948d9afab8815dbb683bbcae24693b3305c8402ae39-merged.mount: Deactivated successfully. Sep 4 00:04:31.736612 systemd-networkd[1412]: veth2bd31b3: Link DOWN Sep 4 00:04:31.736621 systemd-networkd[1412]: veth2bd31b3: Lost carrier Sep 4 00:04:31.738598 kernel: docker0: port 1(veth2bd31b3) entered disabled state Sep 4 00:04:31.740122 kernel: veth2bd31b3 (unregistering): left allmulticast mode Sep 4 00:04:31.740172 kernel: veth2bd31b3 (unregistering): left promiscuous mode Sep 4 00:04:31.740195 kernel: docker0: port 1(veth2bd31b3) entered disabled state Sep 4 00:04:31.741659 systemd-networkd[1412]: docker0: Lost carrier Sep 4 00:04:31.744062 dockerd[2514]: time="2025-09-04T00:04:31.744016187Z" level=info msg="Removing stale sandbox d78f8c2c2747f3e21fe0ba9c818a3108d4ffd8268bc859666589999f03d1d366 (b8f236f7aa197c8fb6cdc250332801ca85ade7afc6d90cc8ab4c95d55e2e7fdf)" Sep 4 00:04:31.751229 dockerd[2514]: time="2025-09-04T00:04:31.751179679Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 4 00:04:31.751229 dockerd[2514]: time="2025-09-04T00:04:31.751222671Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint e565bc05c5e8779235a84b32b136a832741d5a92a13af602c20996814d858ab8 0322de4196b100d14772785e05f000678daafccf53eec90d7ca3f12b5e02e030], retrying...." Sep 4 00:04:31.943946 dockerd[2514]: time="2025-09-04T00:04:31.943884146Z" level=warning msg="error locating sandbox id d78f8c2c2747f3e21fe0ba9c818a3108d4ffd8268bc859666589999f03d1d366: sandbox d78f8c2c2747f3e21fe0ba9c818a3108d4ffd8268bc859666589999f03d1d366 not found" Sep 4 00:04:31.943946 dockerd[2514]: time="2025-09-04T00:04:31.943934872Z" level=warning msg="error locating sandbox id 26e5a7ed4a6774125c01d9d7ece441bd9d4a8fbcc4d048e5c2631f73f7eba23e: sandbox 26e5a7ed4a6774125c01d9d7ece441bd9d4a8fbcc4d048e5c2631f73f7eba23e not found" Sep 4 00:04:31.944151 dockerd[2514]: time="2025-09-04T00:04:31.944106326Z" level=info msg="Loading containers: done." Sep 4 00:04:31.963850 dockerd[2514]: time="2025-09-04T00:04:31.963782288Z" 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 Sep 4 00:04:31.964084 dockerd[2514]: time="2025-09-04T00:04:31.963877758Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Sep 4 00:04:31.964084 dockerd[2514]: time="2025-09-04T00:04:31.963973739Z" level=info msg="Initializing buildkit" Sep 4 00:04:31.982257 dockerd[2514]: time="2025-09-04T00:04:31.982187141Z" level=info msg="Completed buildkit initialization" Sep 4 00:04:31.987469 dockerd[2514]: time="2025-09-04T00:04:31.987389661Z" level=info msg="Daemon has completed initialization" Sep 4 00:04:31.987558 dockerd[2514]: time="2025-09-04T00:04:31.987452680Z" level=info msg="API listen on /run/docker.sock" Sep 4 00:04:31.987682 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 4 00:04:32.247250 systemd[1]: run-docker-netns-d78f8c2c2747.mount: Deactivated successfully. Sep 4 00:04:35.709182 systemd[1]: Started sshd@24-10.0.0.77:22-10.0.0.1:54798.service - OpenSSH per-connection server daemon (10.0.0.1:54798). Sep 4 00:04:35.754824 sshd[2735]: Accepted publickey for core from 10.0.0.1 port 54798 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:35.756566 sshd-session[2735]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:35.761579 systemd-logind[1451]: New session 25 of user core. Sep 4 00:04:35.769661 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 4 00:04:35.826065 sshd[2737]: Connection closed by 10.0.0.1 port 54798 Sep 4 00:04:35.826365 sshd-session[2735]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:35.836181 systemd[1]: sshd@24-10.0.0.77:22-10.0.0.1:54798.service: Deactivated successfully. Sep 4 00:04:35.838273 systemd[1]: session-25.scope: Deactivated successfully. Sep 4 00:04:35.839170 systemd-logind[1451]: Session 25 logged out. Waiting for processes to exit. Sep 4 00:04:35.842782 systemd[1]: Started sshd@25-10.0.0.77:22-10.0.0.1:54810.service - OpenSSH per-connection server daemon (10.0.0.1:54810). Sep 4 00:04:35.843467 systemd-logind[1451]: Removed session 25. Sep 4 00:04:35.899450 sshd[2743]: Accepted publickey for core from 10.0.0.1 port 54810 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:35.901203 sshd-session[2743]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:35.906087 systemd-logind[1451]: New session 26 of user core. Sep 4 00:04:35.915693 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 4 00:04:35.974763 sshd[2745]: Connection closed by 10.0.0.1 port 54810 Sep 4 00:04:35.975666 sshd-session[2743]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:35.987480 systemd[1]: sshd@25-10.0.0.77:22-10.0.0.1:54810.service: Deactivated successfully. Sep 4 00:04:35.989682 systemd[1]: session-26.scope: Deactivated successfully. Sep 4 00:04:35.990563 systemd-logind[1451]: Session 26 logged out. Waiting for processes to exit. Sep 4 00:04:35.994369 systemd[1]: Started sshd@26-10.0.0.77:22-10.0.0.1:54818.service - OpenSSH per-connection server daemon (10.0.0.1:54818). Sep 4 00:04:35.995118 systemd-logind[1451]: Removed session 26. Sep 4 00:04:36.041048 sshd[2751]: Accepted publickey for core from 10.0.0.1 port 54818 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:36.043138 sshd-session[2751]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:36.048111 systemd-logind[1451]: New session 27 of user core. Sep 4 00:04:36.057871 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 4 00:04:36.122578 sshd[2753]: Connection closed by 10.0.0.1 port 54818 Sep 4 00:04:36.123084 sshd-session[2751]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:36.136905 systemd[1]: sshd@26-10.0.0.77:22-10.0.0.1:54818.service: Deactivated successfully. Sep 4 00:04:36.138771 systemd[1]: session-27.scope: Deactivated successfully. Sep 4 00:04:36.139648 systemd-logind[1451]: Session 27 logged out. Waiting for processes to exit. Sep 4 00:04:36.142831 systemd[1]: Started sshd@27-10.0.0.77:22-10.0.0.1:54822.service - OpenSSH per-connection server daemon (10.0.0.1:54822). Sep 4 00:04:36.143618 systemd-logind[1451]: Removed session 27. Sep 4 00:04:36.193960 sshd[2766]: Accepted publickey for core from 10.0.0.1 port 54822 ssh2: RSA SHA256:1o0Rn/iFE2HG+o4C2c8UWdMz6TCxmTa3FwGAPCIw01A Sep 4 00:04:36.196104 sshd-session[2766]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:04:36.201306 systemd-logind[1451]: New session 28 of user core. Sep 4 00:04:36.210720 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 4 00:04:36.306152 systemd[1]: var-lib-docker-overlay2-90a3e3fe450b108a701e41b55f43dbeb4f8c72d325ee4130a7595c613be7e49e\x2dinit-merged.mount: Deactivated successfully. Sep 4 00:04:36.411521 containerd[2468]: time="2025-09-04T00:04:36.411424851Z" level=info msg="connecting to shim f1d7d5c4bf2c21cbea479e4216e836814b09628516f081c3cddb963547bf42ed" address="unix:///run/containerd/s/626bd8425f5c401019f9dc84ffb9f580b3b6a9afd759d6c0faf7dde329579802" namespace=moby protocol=ttrpc version=3 Sep 4 00:04:36.444817 systemd[1]: Started docker-f1d7d5c4bf2c21cbea479e4216e836814b09628516f081c3cddb963547bf42ed.scope - libcontainer container f1d7d5c4bf2c21cbea479e4216e836814b09628516f081c3cddb963547bf42ed. Sep 4 00:04:36.461115 systemd-resolved[1350]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 4 00:04:36.490235 kernel: docker0: port 1(veth0895eb3) entered blocking state Sep 4 00:04:36.490348 kernel: docker0: port 1(veth0895eb3) entered disabled state Sep 4 00:04:36.490374 kernel: veth0895eb3: entered allmulticast mode Sep 4 00:04:36.493267 kernel: veth0895eb3: entered promiscuous mode Sep 4 00:04:36.492523 systemd-networkd[1412]: veth0895eb3: Link UP Sep 4 00:04:36.501574 kernel: eth0: renamed from vethe589d1d Sep 4 00:04:36.504057 kernel: docker0: port 1(veth0895eb3) entered blocking state Sep 4 00:04:36.504099 kernel: docker0: port 1(veth0895eb3) entered forwarding state Sep 4 00:04:36.504277 systemd-networkd[1412]: veth0895eb3: Gained carrier Sep 4 00:04:36.504944 systemd-networkd[1412]: docker0: Gained carrier Sep 4 00:04:36.544316 sshd[2768]: Connection closed by 10.0.0.1 port 54822 Sep 4 00:04:36.544667 sshd-session[2766]: pam_unix(sshd:session): session closed for user core Sep 4 00:04:36.549137 systemd[1]: sshd@27-10.0.0.77:22-10.0.0.1:54822.service: Deactivated successfully. Sep 4 00:04:36.551113 systemd[1]: session-28.scope: Deactivated successfully. Sep 4 00:04:36.551843 systemd-logind[1451]: Session 28 logged out. Waiting for processes to exit. Sep 4 00:04:36.552958 systemd-logind[1451]: Removed session 28. Sep 4 00:04:38.037766 systemd-networkd[1412]: veth0895eb3: Gained IPv6LL