Jun 21 05:01:08.841177 kernel: Linux version 6.12.34-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 Fri Jun 20 23:59:04 -00 2025 Jun 21 05:01:08.841205 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 05:01:08.841219 kernel: BIOS-provided physical RAM map: Jun 21 05:01:08.841228 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000002ffff] usable Jun 21 05:01:08.841236 kernel: BIOS-e820: [mem 0x0000000000030000-0x000000000004ffff] reserved Jun 21 05:01:08.841245 kernel: BIOS-e820: [mem 0x0000000000050000-0x000000000009efff] usable Jun 21 05:01:08.841255 kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved Jun 21 05:01:08.841264 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009b8ecfff] usable Jun 21 05:01:08.841272 kernel: BIOS-e820: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Jun 21 05:01:08.841281 kernel: BIOS-e820: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Jun 21 05:01:08.841290 kernel: BIOS-e820: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Jun 21 05:01:08.841301 kernel: BIOS-e820: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Jun 21 05:01:08.841310 kernel: BIOS-e820: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Jun 21 05:01:08.841319 kernel: BIOS-e820: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Jun 21 05:01:08.841329 kernel: BIOS-e820: [mem 0x000000009bfb7000-0x000000009bffffff] usable Jun 21 05:01:08.841339 kernel: BIOS-e820: [mem 0x000000009c000000-0x000000009cffffff] reserved Jun 21 05:01:08.841350 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Jun 21 05:01:08.841360 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jun 21 05:01:08.841369 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jun 21 05:01:08.841378 kernel: NX (Execute Disable) protection: active Jun 21 05:01:08.841387 kernel: APIC: Static calls initialized Jun 21 05:01:08.841397 kernel: e820: update [mem 0x9a13f018-0x9a148c57] usable ==> usable Jun 21 05:01:08.841406 kernel: e820: update [mem 0x9a102018-0x9a13ee57] usable ==> usable Jun 21 05:01:08.841415 kernel: extended physical RAM map: Jun 21 05:01:08.841425 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000002ffff] usable Jun 21 05:01:08.841434 kernel: reserve setup_data: [mem 0x0000000000030000-0x000000000004ffff] reserved Jun 21 05:01:08.841444 kernel: reserve setup_data: [mem 0x0000000000050000-0x000000000009efff] usable Jun 21 05:01:08.841455 kernel: reserve setup_data: [mem 0x000000000009f000-0x000000000009ffff] reserved Jun 21 05:01:08.841465 kernel: reserve setup_data: [mem 0x0000000000100000-0x000000009a102017] usable Jun 21 05:01:08.841474 kernel: reserve setup_data: [mem 0x000000009a102018-0x000000009a13ee57] usable Jun 21 05:01:08.841483 kernel: reserve setup_data: [mem 0x000000009a13ee58-0x000000009a13f017] usable Jun 21 05:01:08.841492 kernel: reserve setup_data: [mem 0x000000009a13f018-0x000000009a148c57] usable Jun 21 05:01:08.841501 kernel: reserve setup_data: [mem 0x000000009a148c58-0x000000009b8ecfff] usable Jun 21 05:01:08.841511 kernel: reserve setup_data: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Jun 21 05:01:08.841520 kernel: reserve setup_data: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Jun 21 05:01:08.841529 kernel: reserve setup_data: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Jun 21 05:01:08.841538 kernel: reserve setup_data: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Jun 21 05:01:08.841548 kernel: reserve setup_data: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Jun 21 05:01:08.841559 kernel: reserve setup_data: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Jun 21 05:01:08.841569 kernel: reserve setup_data: [mem 0x000000009bfb7000-0x000000009bffffff] usable Jun 21 05:01:08.841583 kernel: reserve setup_data: [mem 0x000000009c000000-0x000000009cffffff] reserved Jun 21 05:01:08.841592 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Jun 21 05:01:08.841602 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jun 21 05:01:08.841612 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jun 21 05:01:08.841624 kernel: efi: EFI v2.7 by EDK II Jun 21 05:01:08.841634 kernel: efi: SMBIOS=0x9b9d5000 ACPI=0x9bb7e000 ACPI 2.0=0x9bb7e014 MEMATTR=0x9a1af018 RNG=0x9bb73018 Jun 21 05:01:08.841644 kernel: random: crng init done Jun 21 05:01:08.841654 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Jun 21 05:01:08.841663 kernel: secureboot: Secure boot enabled Jun 21 05:01:08.841673 kernel: SMBIOS 2.8 present. Jun 21 05:01:08.841682 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Jun 21 05:01:08.841702 kernel: DMI: Memory slots populated: 1/1 Jun 21 05:01:08.841711 kernel: Hypervisor detected: KVM Jun 21 05:01:08.841721 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jun 21 05:01:08.841731 kernel: kvm-clock: using sched offset of 4905686102 cycles Jun 21 05:01:08.841744 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jun 21 05:01:08.841754 kernel: tsc: Detected 2794.746 MHz processor Jun 21 05:01:08.841764 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 21 05:01:08.841789 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 21 05:01:08.841799 kernel: last_pfn = 0x9c000 max_arch_pfn = 0x400000000 Jun 21 05:01:08.841809 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jun 21 05:01:08.841819 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 21 05:01:08.841829 kernel: Using GB pages for direct mapping Jun 21 05:01:08.841839 kernel: ACPI: Early table checksum verification disabled Jun 21 05:01:08.841853 kernel: ACPI: RSDP 0x000000009BB7E014 000024 (v02 BOCHS ) Jun 21 05:01:08.841863 kernel: ACPI: XSDT 0x000000009BB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Jun 21 05:01:08.841873 kernel: ACPI: FACP 0x000000009BB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 05:01:08.841883 kernel: ACPI: DSDT 0x000000009BB7A000 002237 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 05:01:08.841893 kernel: ACPI: FACS 0x000000009BBDD000 000040 Jun 21 05:01:08.841903 kernel: ACPI: APIC 0x000000009BB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 05:01:08.841913 kernel: ACPI: HPET 0x000000009BB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 05:01:08.841923 kernel: ACPI: MCFG 0x000000009BB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 05:01:08.841933 kernel: ACPI: WAET 0x000000009BB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 05:01:08.841946 kernel: ACPI: BGRT 0x000000009BB74000 000038 (v01 INTEL EDK2 00000002 01000013) Jun 21 05:01:08.841956 kernel: ACPI: Reserving FACP table memory at [mem 0x9bb79000-0x9bb790f3] Jun 21 05:01:08.841966 kernel: ACPI: Reserving DSDT table memory at [mem 0x9bb7a000-0x9bb7c236] Jun 21 05:01:08.841976 kernel: ACPI: Reserving FACS table memory at [mem 0x9bbdd000-0x9bbdd03f] Jun 21 05:01:08.841986 kernel: ACPI: Reserving APIC table memory at [mem 0x9bb78000-0x9bb7808f] Jun 21 05:01:08.841996 kernel: ACPI: Reserving HPET table memory at [mem 0x9bb77000-0x9bb77037] Jun 21 05:01:08.842005 kernel: ACPI: Reserving MCFG table memory at [mem 0x9bb76000-0x9bb7603b] Jun 21 05:01:08.842015 kernel: ACPI: Reserving WAET table memory at [mem 0x9bb75000-0x9bb75027] Jun 21 05:01:08.842025 kernel: ACPI: Reserving BGRT table memory at [mem 0x9bb74000-0x9bb74037] Jun 21 05:01:08.842038 kernel: No NUMA configuration found Jun 21 05:01:08.842048 kernel: Faking a node at [mem 0x0000000000000000-0x000000009bffffff] Jun 21 05:01:08.842058 kernel: NODE_DATA(0) allocated [mem 0x9bf57dc0-0x9bf5efff] Jun 21 05:01:08.842068 kernel: Zone ranges: Jun 21 05:01:08.842078 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 21 05:01:08.842088 kernel: DMA32 [mem 0x0000000001000000-0x000000009bffffff] Jun 21 05:01:08.842098 kernel: Normal empty Jun 21 05:01:08.842108 kernel: Device empty Jun 21 05:01:08.842117 kernel: Movable zone start for each node Jun 21 05:01:08.842130 kernel: Early memory node ranges Jun 21 05:01:08.842140 kernel: node 0: [mem 0x0000000000001000-0x000000000002ffff] Jun 21 05:01:08.842150 kernel: node 0: [mem 0x0000000000050000-0x000000000009efff] Jun 21 05:01:08.842159 kernel: node 0: [mem 0x0000000000100000-0x000000009b8ecfff] Jun 21 05:01:08.842169 kernel: node 0: [mem 0x000000009bbff000-0x000000009bfb0fff] Jun 21 05:01:08.842179 kernel: node 0: [mem 0x000000009bfb7000-0x000000009bffffff] Jun 21 05:01:08.842189 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009bffffff] Jun 21 05:01:08.842199 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 21 05:01:08.842209 kernel: On node 0, zone DMA: 32 pages in unavailable ranges Jun 21 05:01:08.842219 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jun 21 05:01:08.842231 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Jun 21 05:01:08.842241 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Jun 21 05:01:08.842251 kernel: On node 0, zone DMA32: 16384 pages in unavailable ranges Jun 21 05:01:08.842261 kernel: ACPI: PM-Timer IO Port: 0x608 Jun 21 05:01:08.842271 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jun 21 05:01:08.842281 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jun 21 05:01:08.842291 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jun 21 05:01:08.842301 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jun 21 05:01:08.842311 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 21 05:01:08.842324 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jun 21 05:01:08.842334 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jun 21 05:01:08.842344 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 21 05:01:08.842354 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jun 21 05:01:08.842364 kernel: TSC deadline timer available Jun 21 05:01:08.842374 kernel: CPU topo: Max. logical packages: 1 Jun 21 05:01:08.842383 kernel: CPU topo: Max. logical dies: 1 Jun 21 05:01:08.842393 kernel: CPU topo: Max. dies per package: 1 Jun 21 05:01:08.842414 kernel: CPU topo: Max. threads per core: 1 Jun 21 05:01:08.842424 kernel: CPU topo: Num. cores per package: 4 Jun 21 05:01:08.842434 kernel: CPU topo: Num. threads per package: 4 Jun 21 05:01:08.842444 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Jun 21 05:01:08.842457 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jun 21 05:01:08.842467 kernel: kvm-guest: KVM setup pv remote TLB flush Jun 21 05:01:08.842477 kernel: kvm-guest: setup PV sched yield Jun 21 05:01:08.842488 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Jun 21 05:01:08.842498 kernel: Booting paravirtualized kernel on KVM Jun 21 05:01:08.842511 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jun 21 05:01:08.842522 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jun 21 05:01:08.842532 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Jun 21 05:01:08.842542 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Jun 21 05:01:08.842552 kernel: pcpu-alloc: [0] 0 1 2 3 Jun 21 05:01:08.842562 kernel: kvm-guest: PV spinlocks enabled Jun 21 05:01:08.842573 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jun 21 05:01:08.842585 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 05:01:08.842599 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jun 21 05:01:08.842609 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 21 05:01:08.842620 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 21 05:01:08.842629 kernel: Fallback order for Node 0: 0 Jun 21 05:01:08.842640 kernel: Built 1 zonelists, mobility grouping on. Total pages: 638054 Jun 21 05:01:08.842650 kernel: Policy zone: DMA32 Jun 21 05:01:08.842660 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 21 05:01:08.842671 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 21 05:01:08.842682 kernel: ftrace: allocating 40093 entries in 157 pages Jun 21 05:01:08.842708 kernel: ftrace: allocated 157 pages with 5 groups Jun 21 05:01:08.842718 kernel: Dynamic Preempt: voluntary Jun 21 05:01:08.842729 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 21 05:01:08.842741 kernel: rcu: RCU event tracing is enabled. Jun 21 05:01:08.842752 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jun 21 05:01:08.842763 kernel: Trampoline variant of Tasks RCU enabled. Jun 21 05:01:08.842801 kernel: Rude variant of Tasks RCU enabled. Jun 21 05:01:08.842812 kernel: Tracing variant of Tasks RCU enabled. Jun 21 05:01:08.842823 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 21 05:01:08.842837 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 21 05:01:08.842848 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 05:01:08.842858 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 05:01:08.842869 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 05:01:08.842880 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jun 21 05:01:08.842891 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 21 05:01:08.842901 kernel: Console: colour dummy device 80x25 Jun 21 05:01:08.842914 kernel: printk: legacy console [ttyS0] enabled Jun 21 05:01:08.842925 kernel: ACPI: Core revision 20240827 Jun 21 05:01:08.842939 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jun 21 05:01:08.842950 kernel: APIC: Switch to symmetric I/O mode setup Jun 21 05:01:08.842960 kernel: x2apic enabled Jun 21 05:01:08.842971 kernel: APIC: Switched APIC routing to: physical x2apic Jun 21 05:01:08.842981 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jun 21 05:01:08.842992 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jun 21 05:01:08.843002 kernel: kvm-guest: setup PV IPIs Jun 21 05:01:08.843013 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jun 21 05:01:08.843024 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns Jun 21 05:01:08.843038 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794746) Jun 21 05:01:08.843048 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jun 21 05:01:08.843059 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jun 21 05:01:08.843069 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jun 21 05:01:08.843080 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 21 05:01:08.843090 kernel: Spectre V2 : Mitigation: Retpolines Jun 21 05:01:08.843101 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jun 21 05:01:08.843111 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Jun 21 05:01:08.843122 kernel: RETBleed: Mitigation: untrained return thunk Jun 21 05:01:08.843135 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jun 21 05:01:08.843146 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jun 21 05:01:08.843156 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Jun 21 05:01:08.843167 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Jun 21 05:01:08.843178 kernel: x86/bugs: return thunk changed Jun 21 05:01:08.843189 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Jun 21 05:01:08.843200 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 21 05:01:08.843210 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 21 05:01:08.843224 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jun 21 05:01:08.843234 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jun 21 05:01:08.843245 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jun 21 05:01:08.843255 kernel: Freeing SMP alternatives memory: 32K Jun 21 05:01:08.843265 kernel: pid_max: default: 32768 minimum: 301 Jun 21 05:01:08.843276 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jun 21 05:01:08.843286 kernel: landlock: Up and running. Jun 21 05:01:08.843296 kernel: SELinux: Initializing. Jun 21 05:01:08.843304 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 21 05:01:08.843315 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 21 05:01:08.843323 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Jun 21 05:01:08.843334 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Jun 21 05:01:08.843344 kernel: ... version: 0 Jun 21 05:01:08.843354 kernel: ... bit width: 48 Jun 21 05:01:08.843364 kernel: ... generic registers: 6 Jun 21 05:01:08.843374 kernel: ... value mask: 0000ffffffffffff Jun 21 05:01:08.843385 kernel: ... max period: 00007fffffffffff Jun 21 05:01:08.843395 kernel: ... fixed-purpose events: 0 Jun 21 05:01:08.843408 kernel: ... event mask: 000000000000003f Jun 21 05:01:08.843418 kernel: signal: max sigframe size: 1776 Jun 21 05:01:08.843429 kernel: rcu: Hierarchical SRCU implementation. Jun 21 05:01:08.843439 kernel: rcu: Max phase no-delay instances is 400. Jun 21 05:01:08.843450 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jun 21 05:01:08.843460 kernel: smp: Bringing up secondary CPUs ... Jun 21 05:01:08.843470 kernel: smpboot: x86: Booting SMP configuration: Jun 21 05:01:08.843480 kernel: .... node #0, CPUs: #1 #2 #3 Jun 21 05:01:08.843490 kernel: smp: Brought up 1 node, 4 CPUs Jun 21 05:01:08.843500 kernel: smpboot: Total of 4 processors activated (22357.96 BogoMIPS) Jun 21 05:01:08.843514 kernel: Memory: 2409216K/2552216K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54424K init, 2544K bss, 137064K reserved, 0K cma-reserved) Jun 21 05:01:08.843525 kernel: devtmpfs: initialized Jun 21 05:01:08.843535 kernel: x86/mm: Memory block size: 128MB Jun 21 05:01:08.843545 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bb7f000-0x9bbfefff] (524288 bytes) Jun 21 05:01:08.843556 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bfb5000-0x9bfb6fff] (8192 bytes) Jun 21 05:01:08.843566 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 21 05:01:08.843577 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 21 05:01:08.843587 kernel: pinctrl core: initialized pinctrl subsystem Jun 21 05:01:08.843600 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 21 05:01:08.843610 kernel: audit: initializing netlink subsys (disabled) Jun 21 05:01:08.843621 kernel: audit: type=2000 audit(1750482066.563:1): state=initialized audit_enabled=0 res=1 Jun 21 05:01:08.843631 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 21 05:01:08.843642 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 21 05:01:08.843652 kernel: cpuidle: using governor menu Jun 21 05:01:08.843662 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 21 05:01:08.843673 kernel: dca service started, version 1.12.1 Jun 21 05:01:08.843683 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Jun 21 05:01:08.843710 kernel: PCI: Using configuration type 1 for base access Jun 21 05:01:08.843721 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 21 05:01:08.843732 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 21 05:01:08.843743 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jun 21 05:01:08.843753 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 21 05:01:08.843763 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 21 05:01:08.843804 kernel: ACPI: Added _OSI(Module Device) Jun 21 05:01:08.843832 kernel: ACPI: Added _OSI(Processor Device) Jun 21 05:01:08.843844 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 21 05:01:08.843859 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 21 05:01:08.843869 kernel: ACPI: Interpreter enabled Jun 21 05:01:08.843880 kernel: ACPI: PM: (supports S0 S5) Jun 21 05:01:08.843890 kernel: ACPI: Using IOAPIC for interrupt routing Jun 21 05:01:08.843901 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 21 05:01:08.843912 kernel: PCI: Using E820 reservations for host bridge windows Jun 21 05:01:08.843922 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jun 21 05:01:08.843933 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 21 05:01:08.844137 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jun 21 05:01:08.844296 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jun 21 05:01:08.844447 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jun 21 05:01:08.844463 kernel: PCI host bridge to bus 0000:00 Jun 21 05:01:08.844616 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jun 21 05:01:08.844778 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 21 05:01:08.844939 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jun 21 05:01:08.845078 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Jun 21 05:01:08.845210 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Jun 21 05:01:08.845341 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Jun 21 05:01:08.845476 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 21 05:01:08.845640 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Jun 21 05:01:08.845848 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Jun 21 05:01:08.846003 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Jun 21 05:01:08.846148 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Jun 21 05:01:08.846295 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Jun 21 05:01:08.846443 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 21 05:01:08.846603 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jun 21 05:01:08.846763 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Jun 21 05:01:08.846945 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Jun 21 05:01:08.847097 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Jun 21 05:01:08.847264 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Jun 21 05:01:08.847413 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Jun 21 05:01:08.847560 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Jun 21 05:01:08.847721 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Jun 21 05:01:08.847903 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Jun 21 05:01:08.848057 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Jun 21 05:01:08.848211 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Jun 21 05:01:08.848356 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Jun 21 05:01:08.848501 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Jun 21 05:01:08.848655 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Jun 21 05:01:08.848844 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jun 21 05:01:08.849002 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Jun 21 05:01:08.849154 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Jun 21 05:01:08.849306 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Jun 21 05:01:08.849464 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Jun 21 05:01:08.849612 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Jun 21 05:01:08.849628 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jun 21 05:01:08.849638 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jun 21 05:01:08.849649 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jun 21 05:01:08.849659 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jun 21 05:01:08.849674 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jun 21 05:01:08.849684 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jun 21 05:01:08.849706 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jun 21 05:01:08.849717 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jun 21 05:01:08.849727 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jun 21 05:01:08.849738 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jun 21 05:01:08.849748 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jun 21 05:01:08.849758 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jun 21 05:01:08.849803 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jun 21 05:01:08.849818 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jun 21 05:01:08.849829 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jun 21 05:01:08.849839 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jun 21 05:01:08.849850 kernel: iommu: Default domain type: Translated Jun 21 05:01:08.849860 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 21 05:01:08.849871 kernel: efivars: Registered efivars operations Jun 21 05:01:08.849881 kernel: PCI: Using ACPI for IRQ routing Jun 21 05:01:08.849892 kernel: PCI: pci_cache_line_size set to 64 bytes Jun 21 05:01:08.849902 kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] Jun 21 05:01:08.849913 kernel: e820: reserve RAM buffer [mem 0x9a102018-0x9bffffff] Jun 21 05:01:08.849926 kernel: e820: reserve RAM buffer [mem 0x9a13f018-0x9bffffff] Jun 21 05:01:08.849936 kernel: e820: reserve RAM buffer [mem 0x9b8ed000-0x9bffffff] Jun 21 05:01:08.849946 kernel: e820: reserve RAM buffer [mem 0x9bfb1000-0x9bffffff] Jun 21 05:01:08.850097 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jun 21 05:01:08.850244 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jun 21 05:01:08.850390 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 21 05:01:08.850405 kernel: vgaarb: loaded Jun 21 05:01:08.850416 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jun 21 05:01:08.850430 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jun 21 05:01:08.850441 kernel: clocksource: Switched to clocksource kvm-clock Jun 21 05:01:08.850452 kernel: VFS: Disk quotas dquot_6.6.0 Jun 21 05:01:08.850463 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 21 05:01:08.850473 kernel: pnp: PnP ACPI init Jun 21 05:01:08.850616 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Jun 21 05:01:08.850629 kernel: pnp: PnP ACPI: found 6 devices Jun 21 05:01:08.850637 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 21 05:01:08.850648 kernel: NET: Registered PF_INET protocol family Jun 21 05:01:08.850656 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jun 21 05:01:08.850664 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jun 21 05:01:08.850672 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 21 05:01:08.850679 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 21 05:01:08.850687 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jun 21 05:01:08.850705 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jun 21 05:01:08.850713 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 21 05:01:08.850721 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 21 05:01:08.850731 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 21 05:01:08.850738 kernel: NET: Registered PF_XDP protocol family Jun 21 05:01:08.850878 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Jun 21 05:01:08.850996 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Jun 21 05:01:08.851101 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jun 21 05:01:08.851204 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jun 21 05:01:08.851307 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jun 21 05:01:08.851410 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Jun 21 05:01:08.851516 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Jun 21 05:01:08.851619 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Jun 21 05:01:08.851629 kernel: PCI: CLS 0 bytes, default 64 Jun 21 05:01:08.851637 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns Jun 21 05:01:08.851645 kernel: Initialise system trusted keyrings Jun 21 05:01:08.851653 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jun 21 05:01:08.851660 kernel: Key type asymmetric registered Jun 21 05:01:08.851668 kernel: Asymmetric key parser 'x509' registered Jun 21 05:01:08.851676 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jun 21 05:01:08.851705 kernel: io scheduler mq-deadline registered Jun 21 05:01:08.851716 kernel: io scheduler kyber registered Jun 21 05:01:08.851724 kernel: io scheduler bfq registered Jun 21 05:01:08.851734 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jun 21 05:01:08.851744 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jun 21 05:01:08.851752 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jun 21 05:01:08.851760 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jun 21 05:01:08.851788 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 21 05:01:08.851800 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jun 21 05:01:08.851812 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jun 21 05:01:08.851820 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jun 21 05:01:08.851828 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jun 21 05:01:08.851953 kernel: rtc_cmos 00:04: RTC can wake from S4 Jun 21 05:01:08.851965 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jun 21 05:01:08.852073 kernel: rtc_cmos 00:04: registered as rtc0 Jun 21 05:01:08.852180 kernel: rtc_cmos 00:04: setting system clock to 2025-06-21T05:01:08 UTC (1750482068) Jun 21 05:01:08.852290 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Jun 21 05:01:08.852301 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jun 21 05:01:08.852309 kernel: efifb: probing for efifb Jun 21 05:01:08.852317 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Jun 21 05:01:08.852325 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Jun 21 05:01:08.852333 kernel: efifb: scrolling: redraw Jun 21 05:01:08.852340 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jun 21 05:01:08.852348 kernel: Console: switching to colour frame buffer device 160x50 Jun 21 05:01:08.852356 kernel: fb0: EFI VGA frame buffer device Jun 21 05:01:08.852364 kernel: pstore: Using crash dump compression: deflate Jun 21 05:01:08.852375 kernel: pstore: Registered efi_pstore as persistent store backend Jun 21 05:01:08.852385 kernel: NET: Registered PF_INET6 protocol family Jun 21 05:01:08.852393 kernel: Segment Routing with IPv6 Jun 21 05:01:08.852400 kernel: In-situ OAM (IOAM) with IPv6 Jun 21 05:01:08.852408 kernel: NET: Registered PF_PACKET protocol family Jun 21 05:01:08.852418 kernel: Key type dns_resolver registered Jun 21 05:01:08.852426 kernel: IPI shorthand broadcast: enabled Jun 21 05:01:08.852434 kernel: sched_clock: Marking stable (2884006061, 140552983)->(3039151235, -14592191) Jun 21 05:01:08.852442 kernel: registered taskstats version 1 Jun 21 05:01:08.852450 kernel: Loading compiled-in X.509 certificates Jun 21 05:01:08.852458 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.34-flatcar: ec4617d162e00e1890f71f252cdf44036a7b66f7' Jun 21 05:01:08.852466 kernel: Demotion targets for Node 0: null Jun 21 05:01:08.852474 kernel: Key type .fscrypt registered Jun 21 05:01:08.852482 kernel: Key type fscrypt-provisioning registered Jun 21 05:01:08.852491 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 21 05:01:08.852499 kernel: ima: Allocated hash algorithm: sha1 Jun 21 05:01:08.852507 kernel: ima: No architecture policies found Jun 21 05:01:08.852515 kernel: clk: Disabling unused clocks Jun 21 05:01:08.852523 kernel: Warning: unable to open an initial console. Jun 21 05:01:08.852531 kernel: Freeing unused kernel image (initmem) memory: 54424K Jun 21 05:01:08.852539 kernel: Write protecting the kernel read-only data: 24576k Jun 21 05:01:08.852547 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jun 21 05:01:08.852555 kernel: Run /init as init process Jun 21 05:01:08.852564 kernel: with arguments: Jun 21 05:01:08.852572 kernel: /init Jun 21 05:01:08.852580 kernel: with environment: Jun 21 05:01:08.852587 kernel: HOME=/ Jun 21 05:01:08.852595 kernel: TERM=linux Jun 21 05:01:08.852603 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jun 21 05:01:08.852612 systemd[1]: Successfully made /usr/ read-only. Jun 21 05:01:08.852623 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) Jun 21 05:01:08.852634 systemd[1]: Detected virtualization kvm. Jun 21 05:01:08.852642 systemd[1]: Detected architecture x86-64. Jun 21 05:01:08.852650 systemd[1]: Running in initrd. Jun 21 05:01:08.852658 systemd[1]: No hostname configured, using default hostname. Jun 21 05:01:08.852667 systemd[1]: Hostname set to . Jun 21 05:01:08.852676 systemd[1]: Initializing machine ID from VM UUID. Jun 21 05:01:08.852684 systemd[1]: Queued start job for default target initrd.target. Jun 21 05:01:08.852703 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 05:01:08.852712 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 05:01:08.852721 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jun 21 05:01:08.852730 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 05:01:08.852738 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jun 21 05:01:08.852748 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jun 21 05:01:08.852758 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jun 21 05:01:08.852785 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jun 21 05:01:08.852797 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 05:01:08.852806 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 05:01:08.852814 systemd[1]: Reached target paths.target - Path Units. Jun 21 05:01:08.852823 systemd[1]: Reached target slices.target - Slice Units. Jun 21 05:01:08.852831 systemd[1]: Reached target swap.target - Swaps. Jun 21 05:01:08.852839 systemd[1]: Reached target timers.target - Timer Units. Jun 21 05:01:08.852848 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 05:01:08.852856 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 05:01:08.852868 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jun 21 05:01:08.852876 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jun 21 05:01:08.852885 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 05:01:08.852893 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 05:01:08.852902 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 05:01:08.852910 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 05:01:08.852920 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jun 21 05:01:08.852930 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 05:01:08.852942 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jun 21 05:01:08.852951 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). Jun 21 05:01:08.852960 systemd[1]: Starting systemd-fsck-usr.service... Jun 21 05:01:08.852969 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 05:01:08.852977 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 05:01:08.852986 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 05:01:08.852994 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jun 21 05:01:08.853005 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 05:01:08.853013 systemd[1]: Finished systemd-fsck-usr.service. Jun 21 05:01:08.853022 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 21 05:01:08.853054 systemd-journald[220]: Collecting audit messages is disabled. Jun 21 05:01:08.853076 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 05:01:08.853085 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 05:01:08.853094 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 05:01:08.853102 systemd-journald[220]: Journal started Jun 21 05:01:08.853122 systemd-journald[220]: Runtime Journal (/run/log/journal/b00b084060264b82ae47f969253e972e) is 6M, max 48.2M, 42.2M free. Jun 21 05:01:08.833765 systemd-modules-load[221]: Inserted module 'overlay' Jun 21 05:01:08.857441 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 21 05:01:08.860343 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 05:01:08.862813 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jun 21 05:01:08.864932 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 05:01:08.869440 kernel: Bridge firewalling registered Jun 21 05:01:08.864954 systemd-modules-load[221]: Inserted module 'br_netfilter' Jun 21 05:01:08.865622 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 05:01:08.866444 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 05:01:08.869970 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 05:01:08.879727 systemd-tmpfiles[242]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jun 21 05:01:08.884967 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 05:01:08.886792 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 05:01:08.888414 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jun 21 05:01:08.891325 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 05:01:08.895279 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 05:01:08.918275 dracut-cmdline[259]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 05:01:08.939408 systemd-resolved[261]: Positive Trust Anchors: Jun 21 05:01:08.939425 systemd-resolved[261]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 05:01:08.939458 systemd-resolved[261]: 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 Jun 21 05:01:08.941906 systemd-resolved[261]: Defaulting to hostname 'linux'. Jun 21 05:01:08.943038 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 05:01:08.952211 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 05:01:09.022808 kernel: SCSI subsystem initialized Jun 21 05:01:09.031806 kernel: Loading iSCSI transport class v2.0-870. Jun 21 05:01:09.042803 kernel: iscsi: registered transport (tcp) Jun 21 05:01:09.063903 kernel: iscsi: registered transport (qla4xxx) Jun 21 05:01:09.063933 kernel: QLogic iSCSI HBA Driver Jun 21 05:01:09.084267 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 05:01:09.112809 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 05:01:09.115069 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 05:01:09.167059 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jun 21 05:01:09.168826 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jun 21 05:01:09.236803 kernel: raid6: avx2x4 gen() 30229 MB/s Jun 21 05:01:09.253805 kernel: raid6: avx2x2 gen() 30833 MB/s Jun 21 05:01:09.270882 kernel: raid6: avx2x1 gen() 25945 MB/s Jun 21 05:01:09.270908 kernel: raid6: using algorithm avx2x2 gen() 30833 MB/s Jun 21 05:01:09.288892 kernel: raid6: .... xor() 19915 MB/s, rmw enabled Jun 21 05:01:09.288930 kernel: raid6: using avx2x2 recovery algorithm Jun 21 05:01:09.308796 kernel: xor: automatically using best checksumming function avx Jun 21 05:01:09.474814 kernel: Btrfs loaded, zoned=no, fsverity=no Jun 21 05:01:09.483506 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jun 21 05:01:09.485421 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 05:01:09.515916 systemd-udevd[471]: Using default interface naming scheme 'v255'. Jun 21 05:01:09.521487 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 05:01:09.526319 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jun 21 05:01:09.558119 dracut-pre-trigger[484]: rd.md=0: removing MD RAID activation Jun 21 05:01:09.586238 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 05:01:09.589758 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 05:01:09.663781 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 05:01:09.667875 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jun 21 05:01:09.702800 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jun 21 05:01:09.713304 kernel: cryptd: max_cpu_qlen set to 1000 Jun 21 05:01:09.732204 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jun 21 05:01:09.738792 kernel: AES CTR mode by8 optimization enabled Jun 21 05:01:09.740305 kernel: libata version 3.00 loaded. Jun 21 05:01:09.740340 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 05:01:09.747808 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Jun 21 05:01:09.748524 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 05:01:09.749552 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 05:01:09.754039 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 05:01:09.757325 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 05:01:09.765530 kernel: ahci 0000:00:1f.2: version 3.0 Jun 21 05:01:09.765727 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jun 21 05:01:09.775960 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Jun 21 05:01:09.776135 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Jun 21 05:01:09.776271 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jun 21 05:01:09.782797 kernel: scsi host0: ahci Jun 21 05:01:09.783797 kernel: scsi host1: ahci Jun 21 05:01:09.790935 kernel: scsi host2: ahci Jun 21 05:01:09.792795 kernel: scsi host3: ahci Jun 21 05:01:09.793784 kernel: scsi host4: ahci Jun 21 05:01:09.795616 kernel: scsi host5: ahci Jun 21 05:01:09.795794 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 0 Jun 21 05:01:09.795806 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 0 Jun 21 05:01:09.796290 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 05:01:09.802789 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 0 Jun 21 05:01:09.802818 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 0 Jun 21 05:01:09.802831 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 0 Jun 21 05:01:09.802844 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 0 Jun 21 05:01:09.811648 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jun 21 05:01:09.820094 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jun 21 05:01:09.827455 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jun 21 05:01:09.828126 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jun 21 05:01:09.836543 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 21 05:01:09.839180 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jun 21 05:01:09.962813 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 05:01:10.063806 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 05:01:10.122801 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jun 21 05:01:10.122851 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jun 21 05:01:10.123815 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jun 21 05:01:10.123865 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jun 21 05:01:10.124803 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jun 21 05:01:10.126502 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jun 21 05:01:10.126525 kernel: ata3.00: applying bridge limits Jun 21 05:01:10.126814 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jun 21 05:01:10.130683 kernel: ata3.00: configured for UDMA/100 Jun 21 05:01:10.132787 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jun 21 05:01:10.181805 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jun 21 05:01:10.182018 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jun 21 05:01:10.210800 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jun 21 05:01:10.583521 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jun 21 05:01:10.585420 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 05:01:10.587180 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 05:01:10.589667 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 05:01:10.592891 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jun 21 05:01:10.615363 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jun 21 05:01:11.068805 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 05:01:11.068990 disk-uuid[635]: The operation has completed successfully. Jun 21 05:01:11.099013 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 21 05:01:11.099131 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jun 21 05:01:11.136401 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jun 21 05:01:11.166968 sh[664]: Success Jun 21 05:01:11.185526 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jun 21 05:01:11.185563 kernel: device-mapper: uevent: version 1.0.3 Jun 21 05:01:11.185581 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jun 21 05:01:11.194802 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jun 21 05:01:11.230266 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jun 21 05:01:11.232854 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jun 21 05:01:11.249015 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jun 21 05:01:11.258895 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jun 21 05:01:11.258985 kernel: BTRFS: device fsid bfb8168c-5be0-428c-83e7-820ccaf1f8e9 devid 1 transid 41 /dev/mapper/usr (253:0) scanned by mount (676) Jun 21 05:01:11.263132 kernel: BTRFS info (device dm-0): first mount of filesystem bfb8168c-5be0-428c-83e7-820ccaf1f8e9 Jun 21 05:01:11.263160 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jun 21 05:01:11.263173 kernel: BTRFS info (device dm-0): using free-space-tree Jun 21 05:01:11.268438 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jun 21 05:01:11.269761 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jun 21 05:01:11.270841 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jun 21 05:01:11.272759 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jun 21 05:01:11.274100 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jun 21 05:01:11.305812 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (710) Jun 21 05:01:11.308000 kernel: BTRFS info (device vda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 05:01:11.308059 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 05:01:11.308074 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 05:01:11.314787 kernel: BTRFS info (device vda6): last unmount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 05:01:11.316522 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jun 21 05:01:11.319848 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jun 21 05:01:11.406297 ignition[752]: Ignition 2.21.0 Jun 21 05:01:11.406320 ignition[752]: Stage: fetch-offline Jun 21 05:01:11.406386 ignition[752]: no configs at "/usr/lib/ignition/base.d" Jun 21 05:01:11.406399 ignition[752]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 05:01:11.406548 ignition[752]: parsed url from cmdline: "" Jun 21 05:01:11.406557 ignition[752]: no config URL provided Jun 21 05:01:11.406564 ignition[752]: reading system config file "/usr/lib/ignition/user.ign" Jun 21 05:01:11.406576 ignition[752]: no config at "/usr/lib/ignition/user.ign" Jun 21 05:01:11.406607 ignition[752]: op(1): [started] loading QEMU firmware config module Jun 21 05:01:11.406631 ignition[752]: op(1): executing: "modprobe" "qemu_fw_cfg" Jun 21 05:01:11.414980 ignition[752]: op(1): [finished] loading QEMU firmware config module Jun 21 05:01:11.415245 ignition[752]: parsing config with SHA512: 8ecdab3b7ca4bd713560266a3b6f49c53239c9fea89dd77854850d06c3448a89f672f42d3689559bcd99c6ae6b98cae92af404b69d25f646325aac040d2c5590 Jun 21 05:01:11.419162 unknown[752]: fetched base config from "system" Jun 21 05:01:11.419173 unknown[752]: fetched user config from "qemu" Jun 21 05:01:11.419335 ignition[752]: fetch-offline: fetch-offline passed Jun 21 05:01:11.422796 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 05:01:11.419541 ignition[752]: Ignition finished successfully Jun 21 05:01:11.424328 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 05:01:11.428664 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 05:01:11.479678 systemd-networkd[856]: lo: Link UP Jun 21 05:01:11.479688 systemd-networkd[856]: lo: Gained carrier Jun 21 05:01:11.481166 systemd-networkd[856]: Enumeration completed Jun 21 05:01:11.481507 systemd-networkd[856]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 05:01:11.481511 systemd-networkd[856]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 05:01:11.482574 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 05:01:11.483008 systemd-networkd[856]: eth0: Link UP Jun 21 05:01:11.483012 systemd-networkd[856]: eth0: Gained carrier Jun 21 05:01:11.483020 systemd-networkd[856]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 05:01:11.497651 systemd[1]: Reached target network.target - Network. Jun 21 05:01:11.499322 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jun 21 05:01:11.501929 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jun 21 05:01:11.555902 systemd-networkd[856]: eth0: DHCPv4 address 10.0.0.41/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 21 05:01:11.575687 ignition[859]: Ignition 2.21.0 Jun 21 05:01:11.575699 ignition[859]: Stage: kargs Jun 21 05:01:11.575829 ignition[859]: no configs at "/usr/lib/ignition/base.d" Jun 21 05:01:11.575838 ignition[859]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 05:01:11.576622 ignition[859]: kargs: kargs passed Jun 21 05:01:11.576688 ignition[859]: Ignition finished successfully Jun 21 05:01:11.582596 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jun 21 05:01:11.584266 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jun 21 05:01:11.620421 ignition[868]: Ignition 2.21.0 Jun 21 05:01:11.620433 ignition[868]: Stage: disks Jun 21 05:01:11.620550 ignition[868]: no configs at "/usr/lib/ignition/base.d" Jun 21 05:01:11.620560 ignition[868]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 05:01:11.621012 ignition[868]: disks: disks passed Jun 21 05:01:11.621051 ignition[868]: Ignition finished successfully Jun 21 05:01:11.625435 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jun 21 05:01:11.626587 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jun 21 05:01:11.638638 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jun 21 05:01:11.638977 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 05:01:11.639360 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 05:01:11.639712 systemd[1]: Reached target basic.target - Basic System. Jun 21 05:01:11.641272 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jun 21 05:01:11.672175 systemd-fsck[878]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jun 21 05:01:11.710703 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jun 21 05:01:11.712264 systemd[1]: Mounting sysroot.mount - /sysroot... Jun 21 05:01:11.817801 kernel: EXT4-fs (vda9): mounted filesystem 6d18c974-0fd6-4e4a-98cf-62524fcf9e99 r/w with ordered data mode. Quota mode: none. Jun 21 05:01:11.818264 systemd[1]: Mounted sysroot.mount - /sysroot. Jun 21 05:01:11.819122 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jun 21 05:01:11.822173 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 05:01:11.823989 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jun 21 05:01:11.826543 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jun 21 05:01:11.826588 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jun 21 05:01:11.826619 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 05:01:11.839889 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jun 21 05:01:11.841406 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jun 21 05:01:11.845824 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (886) Jun 21 05:01:11.845857 kernel: BTRFS info (device vda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 05:01:11.847787 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 05:01:11.848947 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 05:01:11.853025 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 05:01:11.878961 initrd-setup-root[910]: cut: /sysroot/etc/passwd: No such file or directory Jun 21 05:01:11.884026 initrd-setup-root[917]: cut: /sysroot/etc/group: No such file or directory Jun 21 05:01:11.888745 initrd-setup-root[924]: cut: /sysroot/etc/shadow: No such file or directory Jun 21 05:01:11.892278 initrd-setup-root[931]: cut: /sysroot/etc/gshadow: No such file or directory Jun 21 05:01:11.974922 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jun 21 05:01:11.977435 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jun 21 05:01:11.978377 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jun 21 05:01:11.998813 kernel: BTRFS info (device vda6): last unmount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 05:01:12.010901 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jun 21 05:01:12.027684 ignition[1000]: INFO : Ignition 2.21.0 Jun 21 05:01:12.027684 ignition[1000]: INFO : Stage: mount Jun 21 05:01:12.029337 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 05:01:12.029337 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 05:01:12.032474 ignition[1000]: INFO : mount: mount passed Jun 21 05:01:12.033284 ignition[1000]: INFO : Ignition finished successfully Jun 21 05:01:12.036554 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jun 21 05:01:12.038580 systemd[1]: Starting ignition-files.service - Ignition (files)... Jun 21 05:01:12.258731 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jun 21 05:01:12.260483 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 05:01:12.291228 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (1012) Jun 21 05:01:12.291259 kernel: BTRFS info (device vda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 05:01:12.291271 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 05:01:12.292115 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 05:01:12.296133 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 05:01:12.325717 ignition[1029]: INFO : Ignition 2.21.0 Jun 21 05:01:12.325717 ignition[1029]: INFO : Stage: files Jun 21 05:01:12.327843 ignition[1029]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 05:01:12.327843 ignition[1029]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 05:01:12.327843 ignition[1029]: DEBUG : files: compiled without relabeling support, skipping Jun 21 05:01:12.327843 ignition[1029]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jun 21 05:01:12.327843 ignition[1029]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jun 21 05:01:12.335422 ignition[1029]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jun 21 05:01:12.337215 ignition[1029]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jun 21 05:01:12.339393 unknown[1029]: wrote ssh authorized keys file for user: core Jun 21 05:01:12.340733 ignition[1029]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jun 21 05:01:12.345778 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 05:01:12.348042 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 05:01:12.348042 ignition[1029]: INFO : files: op(4): [started] processing unit "docker.service" Jun 21 05:01:12.348042 ignition[1029]: INFO : files: op(4): [finished] processing unit "docker.service" Jun 21 05:01:12.348042 ignition[1029]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Jun 21 05:01:12.348042 ignition[1029]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 21 05:01:12.357140 ignition[1029]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 21 05:01:12.357140 ignition[1029]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Jun 21 05:01:12.357140 ignition[1029]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Jun 21 05:01:12.370935 ignition[1029]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Jun 21 05:01:12.374446 ignition[1029]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jun 21 05:01:12.376341 ignition[1029]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Jun 21 05:01:12.376341 ignition[1029]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Jun 21 05:01:12.376341 ignition[1029]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Jun 21 05:01:12.376341 ignition[1029]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Jun 21 05:01:12.376341 ignition[1029]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Jun 21 05:01:12.376341 ignition[1029]: INFO : files: files passed Jun 21 05:01:12.376341 ignition[1029]: INFO : Ignition finished successfully Jun 21 05:01:12.384300 systemd[1]: Finished ignition-files.service - Ignition (files). Jun 21 05:01:12.386088 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jun 21 05:01:12.393071 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jun 21 05:01:12.402037 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 21 05:01:12.402178 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jun 21 05:01:12.407399 initrd-setup-root-after-ignition[1059]: grep: /sysroot/oem/oem-release: No such file or directory Jun 21 05:01:12.411741 initrd-setup-root-after-ignition[1061]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 05:01:12.413596 initrd-setup-root-after-ignition[1061]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jun 21 05:01:12.415157 initrd-setup-root-after-ignition[1065]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 05:01:12.418485 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 05:01:12.419277 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jun 21 05:01:12.421905 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jun 21 05:01:12.466890 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 21 05:01:12.467028 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jun 21 05:01:12.470362 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jun 21 05:01:12.472396 systemd[1]: Reached target initrd.target - Initrd Default Target. Jun 21 05:01:12.473073 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jun 21 05:01:12.473952 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jun 21 05:01:12.506678 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 05:01:12.508377 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jun 21 05:01:12.532737 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jun 21 05:01:12.533129 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 05:01:12.535610 systemd[1]: Stopped target timers.target - Timer Units. Jun 21 05:01:12.538237 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 21 05:01:12.538370 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 05:01:12.541974 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jun 21 05:01:12.542569 systemd[1]: Stopped target basic.target - Basic System. Jun 21 05:01:12.543138 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jun 21 05:01:12.543504 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 05:01:12.549561 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jun 21 05:01:12.551786 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jun 21 05:01:12.552111 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jun 21 05:01:12.552438 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 05:01:12.552814 systemd[1]: Stopped target sysinit.target - System Initialization. Jun 21 05:01:12.560410 systemd[1]: Stopped target local-fs.target - Local File Systems. Jun 21 05:01:12.561156 systemd[1]: Stopped target swap.target - Swaps. Jun 21 05:01:12.561446 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 21 05:01:12.561568 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jun 21 05:01:12.566592 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jun 21 05:01:12.568647 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 05:01:12.570730 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jun 21 05:01:12.571901 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 05:01:12.572495 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 21 05:01:12.572629 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jun 21 05:01:12.576002 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jun 21 05:01:12.576130 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 05:01:12.578718 systemd[1]: Stopped target paths.target - Path Units. Jun 21 05:01:12.580684 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 21 05:01:12.585826 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 05:01:12.587162 systemd[1]: Stopped target slices.target - Slice Units. Jun 21 05:01:12.587786 systemd[1]: Stopped target sockets.target - Socket Units. Jun 21 05:01:12.588282 systemd[1]: iscsid.socket: Deactivated successfully. Jun 21 05:01:12.588359 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 05:01:12.592360 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 21 05:01:12.592462 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 05:01:12.594095 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jun 21 05:01:12.594226 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 05:01:12.596098 systemd[1]: ignition-files.service: Deactivated successfully. Jun 21 05:01:12.596220 systemd[1]: Stopped ignition-files.service - Ignition (files). Jun 21 05:01:12.600551 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jun 21 05:01:12.601883 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jun 21 05:01:12.603984 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 21 05:01:12.604130 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 05:01:12.608040 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 21 05:01:12.608174 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 05:01:12.612680 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 21 05:01:12.619919 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jun 21 05:01:12.635851 ignition[1085]: INFO : Ignition 2.21.0 Jun 21 05:01:12.635851 ignition[1085]: INFO : Stage: umount Jun 21 05:01:12.637982 ignition[1085]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 05:01:12.637982 ignition[1085]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 05:01:12.640872 ignition[1085]: INFO : umount: umount passed Jun 21 05:01:12.640872 ignition[1085]: INFO : Ignition finished successfully Jun 21 05:01:12.643734 systemd[1]: ignition-mount.service: Deactivated successfully. Jun 21 05:01:12.643883 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jun 21 05:01:12.644447 systemd[1]: Stopped target network.target - Network. Jun 21 05:01:12.647510 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 21 05:01:12.647564 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jun 21 05:01:12.649213 systemd[1]: ignition-kargs.service: Deactivated successfully. Jun 21 05:01:12.649259 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jun 21 05:01:12.649546 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 21 05:01:12.649600 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jun 21 05:01:12.650063 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jun 21 05:01:12.650109 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jun 21 05:01:12.650487 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jun 21 05:01:12.650845 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jun 21 05:01:12.652411 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 21 05:01:12.661964 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 21 05:01:12.662079 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jun 21 05:01:12.666946 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jun 21 05:01:12.667211 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 21 05:01:12.667317 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jun 21 05:01:12.669117 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 21 05:01:12.669210 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jun 21 05:01:12.670358 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jun 21 05:01:12.670404 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 05:01:12.674724 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jun 21 05:01:12.679180 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 21 05:01:12.679311 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jun 21 05:01:12.682472 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jun 21 05:01:12.682790 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 21 05:01:12.682830 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jun 21 05:01:12.687978 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jun 21 05:01:12.689941 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jun 21 05:01:12.690041 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 05:01:12.690619 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 21 05:01:12.690661 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jun 21 05:01:12.695213 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jun 21 05:01:12.695260 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jun 21 05:01:12.695735 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 05:01:12.713671 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 21 05:01:12.719991 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 05:01:12.720570 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 21 05:01:12.720625 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jun 21 05:01:12.723055 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 21 05:01:12.723089 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 05:01:12.723362 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 21 05:01:12.723404 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jun 21 05:01:12.724195 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 21 05:01:12.724237 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jun 21 05:01:12.725036 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 21 05:01:12.725076 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 05:01:12.726479 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jun 21 05:01:12.734975 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jun 21 05:01:12.735026 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 05:01:12.742431 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 21 05:01:12.742485 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 05:01:12.745859 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jun 21 05:01:12.745909 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 05:01:12.749529 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 21 05:01:12.749584 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 05:01:12.750315 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 05:01:12.750355 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 05:01:12.755316 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 21 05:01:12.755420 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jun 21 05:01:12.756310 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 21 05:01:12.756405 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jun 21 05:01:12.759032 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jun 21 05:01:12.760724 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jun 21 05:01:12.797229 systemd[1]: Switching root. Jun 21 05:01:12.837072 systemd-journald[220]: Journal stopped Jun 21 05:01:13.694071 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Jun 21 05:01:13.694136 kernel: SELinux: policy capability network_peer_controls=1 Jun 21 05:01:13.694158 kernel: SELinux: policy capability open_perms=1 Jun 21 05:01:13.694169 kernel: SELinux: policy capability extended_socket_class=1 Jun 21 05:01:13.694184 kernel: SELinux: policy capability always_check_network=0 Jun 21 05:01:13.694199 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 21 05:01:13.694211 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 21 05:01:13.694222 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 21 05:01:13.694232 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jun 21 05:01:13.694246 kernel: SELinux: policy capability userspace_initial_context=0 Jun 21 05:01:13.694261 kernel: audit: type=1403 audit(1750482072.933:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 21 05:01:13.694277 systemd[1]: Successfully loaded SELinux policy in 50.252ms. Jun 21 05:01:13.694291 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 12.405ms. Jun 21 05:01:13.694304 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) Jun 21 05:01:13.694316 systemd[1]: Detected virtualization kvm. Jun 21 05:01:13.694328 systemd[1]: Detected architecture x86-64. Jun 21 05:01:13.694339 systemd[1]: Detected first boot. Jun 21 05:01:13.694351 systemd[1]: Initializing machine ID from VM UUID. Jun 21 05:01:13.694364 zram_generator::config[1131]: No configuration found. Jun 21 05:01:13.694377 kernel: Guest personality initialized and is inactive Jun 21 05:01:13.694389 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Jun 21 05:01:13.694399 kernel: Initialized host personality Jun 21 05:01:13.694410 kernel: NET: Registered PF_VSOCK protocol family Jun 21 05:01:13.694421 systemd[1]: Populated /etc with preset unit settings. Jun 21 05:01:13.694436 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jun 21 05:01:13.694448 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 21 05:01:13.694462 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jun 21 05:01:13.694476 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 21 05:01:13.694488 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jun 21 05:01:13.694500 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jun 21 05:01:13.694511 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 21 05:01:13.694525 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jun 21 05:01:13.694537 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jun 21 05:01:13.694558 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jun 21 05:01:13.694571 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jun 21 05:01:13.694583 systemd[1]: Created slice user.slice - User and Session Slice. Jun 21 05:01:13.694595 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 05:01:13.694607 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 05:01:13.694619 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jun 21 05:01:13.694632 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jun 21 05:01:13.694647 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jun 21 05:01:13.694660 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 05:01:13.694673 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jun 21 05:01:13.694686 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 05:01:13.694698 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 05:01:13.694711 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jun 21 05:01:13.694724 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jun 21 05:01:13.694736 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jun 21 05:01:13.694750 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jun 21 05:01:13.694762 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 05:01:13.694792 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 05:01:13.694804 systemd[1]: Reached target slices.target - Slice Units. Jun 21 05:01:13.694816 systemd[1]: Reached target swap.target - Swaps. Jun 21 05:01:13.694827 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jun 21 05:01:13.694839 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jun 21 05:01:13.694851 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jun 21 05:01:13.694863 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 05:01:13.694877 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 05:01:13.694889 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 05:01:13.694900 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jun 21 05:01:13.694912 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jun 21 05:01:13.694924 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jun 21 05:01:13.694935 systemd[1]: Mounting media.mount - External Media Directory... Jun 21 05:01:13.694948 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 05:01:13.694960 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jun 21 05:01:13.694972 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jun 21 05:01:13.694987 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jun 21 05:01:13.695000 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). Jun 21 05:01:13.695012 systemd[1]: Reached target machines.target - Containers. Jun 21 05:01:13.695024 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jun 21 05:01:13.695036 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 05:01:13.695048 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 05:01:13.695060 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jun 21 05:01:13.695072 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 05:01:13.695086 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 05:01:13.695098 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 05:01:13.695109 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jun 21 05:01:13.695121 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 05:01:13.695133 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jun 21 05:01:13.695145 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 21 05:01:13.695157 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jun 21 05:01:13.695169 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 21 05:01:13.695180 systemd[1]: Stopped systemd-fsck-usr.service. Jun 21 05:01:13.695195 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). Jun 21 05:01:13.695207 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 05:01:13.695220 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 05:01:13.695232 kernel: fuse: init (API version 7.41) Jun 21 05:01:13.695245 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 05:01:13.695257 kernel: loop: module loaded Jun 21 05:01:13.695269 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jun 21 05:01:13.695281 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jun 21 05:01:13.695293 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 05:01:13.695305 systemd[1]: verity-setup.service: Deactivated successfully. Jun 21 05:01:13.695317 systemd[1]: Stopped verity-setup.service. Jun 21 05:01:13.695329 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 05:01:13.695341 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jun 21 05:01:13.695354 kernel: ACPI: bus type drm_connector registered Jun 21 05:01:13.695366 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jun 21 05:01:13.695378 systemd[1]: Mounted media.mount - External Media Directory. Jun 21 05:01:13.695391 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jun 21 05:01:13.695403 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jun 21 05:01:13.695414 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jun 21 05:01:13.695426 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jun 21 05:01:13.695463 systemd-journald[1202]: Collecting audit messages is disabled. Jun 21 05:01:13.695485 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 05:01:13.695498 systemd-journald[1202]: Journal started Jun 21 05:01:13.695520 systemd-journald[1202]: Runtime Journal (/run/log/journal/b00b084060264b82ae47f969253e972e) is 6M, max 48.2M, 42.2M free. Jun 21 05:01:13.441884 systemd[1]: Queued start job for default target multi-user.target. Jun 21 05:01:13.465574 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jun 21 05:01:13.466004 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 21 05:01:13.696904 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 05:01:13.698585 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 21 05:01:13.698982 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jun 21 05:01:13.700581 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 05:01:13.700907 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 05:01:13.702376 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 05:01:13.702599 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 05:01:13.704008 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 05:01:13.704222 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 05:01:13.705866 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 21 05:01:13.706074 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jun 21 05:01:13.707453 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 05:01:13.707675 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 05:01:13.709120 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 05:01:13.710542 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 05:01:13.712117 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jun 21 05:01:13.713687 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jun 21 05:01:13.729866 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 05:01:13.732512 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jun 21 05:01:13.735872 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jun 21 05:01:13.737107 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jun 21 05:01:13.737140 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 05:01:13.739151 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jun 21 05:01:13.746851 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jun 21 05:01:13.748226 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 05:01:13.749642 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jun 21 05:01:13.753621 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jun 21 05:01:13.754846 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 05:01:13.755946 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jun 21 05:01:13.757107 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 05:01:13.758067 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 05:01:13.761965 systemd-journald[1202]: Time spent on flushing to /var/log/journal/b00b084060264b82ae47f969253e972e is 21.935ms for 999 entries. Jun 21 05:01:13.761965 systemd-journald[1202]: System Journal (/var/log/journal/b00b084060264b82ae47f969253e972e) is 8M, max 195.6M, 187.6M free. Jun 21 05:01:13.803765 systemd-journald[1202]: Received client request to flush runtime journal. Jun 21 05:01:13.803840 kernel: loop0: detected capacity change from 0 to 113872 Jun 21 05:01:13.762258 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jun 21 05:01:13.765947 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 21 05:01:13.768955 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jun 21 05:01:13.770342 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jun 21 05:01:13.781986 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jun 21 05:01:13.783306 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jun 21 05:01:13.789309 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jun 21 05:01:13.791307 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 05:01:13.800678 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 05:01:13.809139 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jun 21 05:01:13.823819 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 21 05:01:13.824797 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jun 21 05:01:13.830690 systemd-tmpfiles[1251]: ACLs are not supported, ignoring. Jun 21 05:01:13.830710 systemd-tmpfiles[1251]: ACLs are not supported, ignoring. Jun 21 05:01:13.837135 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 05:01:13.840333 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jun 21 05:01:13.841920 kernel: loop1: detected capacity change from 0 to 146240 Jun 21 05:01:13.871802 kernel: loop2: detected capacity change from 0 to 113872 Jun 21 05:01:13.882346 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jun 21 05:01:13.882800 kernel: loop3: detected capacity change from 0 to 146240 Jun 21 05:01:13.885637 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 05:01:13.903615 (sd-merge)[1271]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jun 21 05:01:13.904106 (sd-merge)[1271]: Merged extensions into '/usr'. Jun 21 05:01:13.908375 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jun 21 05:01:13.912520 systemd[1]: Starting ensure-sysext.service... Jun 21 05:01:13.914991 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 05:01:13.915914 systemd-tmpfiles[1273]: ACLs are not supported, ignoring. Jun 21 05:01:13.915929 systemd-tmpfiles[1273]: ACLs are not supported, ignoring. Jun 21 05:01:13.927573 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 05:01:13.936003 systemd[1]: Reload requested from client PID 1276 ('systemctl') (unit ensure-sysext.service)... Jun 21 05:01:13.936166 systemd[1]: Reloading... Jun 21 05:01:13.944536 systemd-tmpfiles[1277]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jun 21 05:01:13.944830 systemd-tmpfiles[1277]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jun 21 05:01:13.945074 systemd-tmpfiles[1277]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 21 05:01:13.945278 systemd-tmpfiles[1277]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 21 05:01:13.946130 systemd-tmpfiles[1277]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 21 05:01:13.946499 systemd-tmpfiles[1277]: ACLs are not supported, ignoring. Jun 21 05:01:13.946633 systemd-tmpfiles[1277]: ACLs are not supported, ignoring. Jun 21 05:01:13.952483 systemd-tmpfiles[1277]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 05:01:13.952560 systemd-tmpfiles[1277]: Skipping /boot Jun 21 05:01:13.965363 systemd-tmpfiles[1277]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 05:01:13.965374 systemd-tmpfiles[1277]: Skipping /boot Jun 21 05:01:14.000886 zram_generator::config[1307]: No configuration found. Jun 21 05:01:14.105331 ldconfig[1245]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 21 05:01:14.107611 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. Jun 21 05:01:14.186628 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 21 05:01:14.187300 systemd[1]: Reloading finished in 250 ms. Jun 21 05:01:14.217262 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jun 21 05:01:14.232760 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 05:01:14.241613 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jun 21 05:01:14.243847 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jun 21 05:01:14.247057 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jun 21 05:01:14.252973 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 05:01:14.255174 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jun 21 05:01:14.260055 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 05:01:14.261509 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 05:01:14.265202 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 05:01:14.274839 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 05:01:14.275972 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 05:01:14.276105 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). Jun 21 05:01:14.277171 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 05:01:14.277375 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 05:01:14.279124 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 05:01:14.279321 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 05:01:14.285258 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 05:01:14.285483 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 05:01:14.290302 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 05:01:14.291513 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 05:01:14.293638 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 05:01:14.295954 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 05:01:14.305059 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 05:01:14.306322 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 05:01:14.307868 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). Jun 21 05:01:14.309931 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jun 21 05:01:14.312762 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jun 21 05:01:14.315089 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 05:01:14.315367 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 05:01:14.317676 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 05:01:14.330626 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 05:01:14.332374 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 05:01:14.332820 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 05:01:14.335397 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 05:01:14.335735 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 05:01:14.336281 augenrules[1381]: No rules Jun 21 05:01:14.337735 systemd[1]: audit-rules.service: Deactivated successfully. Jun 21 05:01:14.338200 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jun 21 05:01:14.343179 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jun 21 05:01:14.348245 systemd[1]: Finished ensure-sysext.service. Jun 21 05:01:14.353153 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jun 21 05:01:14.357350 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 05:01:14.357596 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 05:01:14.359939 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jun 21 05:01:14.362929 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 05:01:14.365889 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jun 21 05:01:14.366940 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). Jun 21 05:01:14.374961 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jun 21 05:01:14.376611 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jun 21 05:01:14.388174 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jun 21 05:01:14.405880 systemd-udevd[1396]: Using default interface naming scheme 'v255'. Jun 21 05:01:14.424060 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 05:01:14.428821 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 05:01:14.449279 systemd-resolved[1348]: Positive Trust Anchors: Jun 21 05:01:14.449294 systemd-resolved[1348]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 05:01:14.449324 systemd-resolved[1348]: 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 Jun 21 05:01:14.454221 systemd-resolved[1348]: Defaulting to hostname 'linux'. Jun 21 05:01:14.455956 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 05:01:14.457609 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 05:01:14.461416 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jun 21 05:01:14.462966 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 05:01:14.465144 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jun 21 05:01:14.466842 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 21 05:01:14.468802 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jun 21 05:01:14.469959 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 21 05:01:14.472136 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jun 21 05:01:14.472164 systemd[1]: Reached target paths.target - Path Units. Jun 21 05:01:14.473245 systemd[1]: Reached target time-set.target - System Time Set. Jun 21 05:01:14.474826 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jun 21 05:01:14.476225 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jun 21 05:01:14.477492 systemd[1]: Reached target timers.target - Timer Units. Jun 21 05:01:14.479438 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jun 21 05:01:14.485119 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 21 05:01:14.488536 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jun 21 05:01:14.490584 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jun 21 05:01:14.493895 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jun 21 05:01:14.511430 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jun 21 05:01:14.513249 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jun 21 05:01:14.516610 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 21 05:01:14.525018 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jun 21 05:01:14.530460 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 05:01:14.532522 systemd[1]: Reached target basic.target - Basic System. Jun 21 05:01:14.533654 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 05:01:14.533682 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jun 21 05:01:14.533702 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jun 21 05:01:14.538932 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jun 21 05:01:14.541142 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jun 21 05:01:14.545689 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jun 21 05:01:14.549507 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jun 21 05:01:14.549786 systemd-networkd[1413]: lo: Link UP Jun 21 05:01:14.549790 systemd-networkd[1413]: lo: Gained carrier Jun 21 05:01:14.550569 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). Jun 21 05:01:14.552325 systemd-networkd[1413]: Enumeration completed Jun 21 05:01:14.560157 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jun 21 05:01:14.562820 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jun 21 05:01:14.562962 systemd-networkd[1413]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 05:01:14.562966 systemd-networkd[1413]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 05:01:14.564571 systemd-networkd[1413]: eth0: Link UP Jun 21 05:01:14.564735 systemd-networkd[1413]: eth0: Gained carrier Jun 21 05:01:14.564753 systemd-networkd[1413]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 05:01:14.567972 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jun 21 05:01:14.573685 oslogin_cache_refresh[1452]: Refreshing passwd entry cache Jun 21 05:01:14.575108 jq[1449]: false Jun 21 05:01:14.575258 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Refreshing passwd entry cache Jun 21 05:01:14.570874 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jun 21 05:01:14.579377 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Failure getting users, quitting Jun 21 05:01:14.579377 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jun 21 05:01:14.579377 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Refreshing group entry cache Jun 21 05:01:14.579377 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Failure getting groups, quitting Jun 21 05:01:14.579377 google_oslogin_nss_cache[1452]: oslogin_cache_refresh[1452]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jun 21 05:01:14.575950 oslogin_cache_refresh[1452]: Failure getting users, quitting Jun 21 05:01:14.576678 systemd[1]: Starting systemd-logind.service - User Login Management... Jun 21 05:01:14.575962 oslogin_cache_refresh[1452]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jun 21 05:01:14.578540 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jun 21 05:01:14.575997 oslogin_cache_refresh[1452]: Refreshing group entry cache Jun 21 05:01:14.578816 systemd-networkd[1413]: eth0: DHCPv4 address 10.0.0.41/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 21 05:01:14.576432 oslogin_cache_refresh[1452]: Failure getting groups, quitting Jun 21 05:01:14.579013 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 21 05:01:14.576440 oslogin_cache_refresh[1452]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jun 21 05:01:14.580242 systemd-timesyncd[1395]: Network configuration changed, trying to establish connection. Jun 21 05:01:14.580685 systemd[1]: Starting update-engine.service - Update Engine... Jun 21 05:01:15.550205 systemd-timesyncd[1395]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jun 21 05:01:15.550292 systemd-timesyncd[1395]: Initial clock synchronization to Sat 2025-06-21 05:01:15.550119 UTC. Jun 21 05:01:15.550330 systemd-resolved[1348]: Clock change detected. Flushing caches. Jun 21 05:01:15.553399 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jun 21 05:01:15.554578 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 05:01:15.555067 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 05:01:15.556962 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jun 21 05:01:15.558596 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jun 21 05:01:15.571397 kernel: mousedev: PS/2 mouse device common for all mice Jun 21 05:01:15.564423 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jun 21 05:01:15.571552 jq[1459]: true Jun 21 05:01:15.564805 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jun 21 05:01:15.565050 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jun 21 05:01:15.566558 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 21 05:01:15.566789 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jun 21 05:01:15.576766 extend-filesystems[1450]: Found /dev/vda6 Jun 21 05:01:15.589378 update_engine[1458]: I20250621 05:01:15.584566 1458 main.cc:92] Flatcar Update Engine starting Jun 21 05:01:15.592870 extend-filesystems[1450]: Found /dev/vda9 Jun 21 05:01:15.600117 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 21 05:01:15.604457 extend-filesystems[1450]: Checking size of /dev/vda9 Jun 21 05:01:15.601455 systemd[1]: Reached target network.target - Network. Jun 21 05:01:15.605467 systemd[1]: Starting containerd.service - containerd container runtime... Jun 21 05:01:15.609500 dbus-daemon[1447]: [system] SELinux support is enabled Jun 21 05:01:15.613511 jq[1466]: true Jun 21 05:01:15.609652 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jun 21 05:01:15.614808 update_engine[1458]: I20250621 05:01:15.614022 1458 update_check_scheduler.cc:74] Next update check in 10m28s Jun 21 05:01:15.612743 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jun 21 05:01:15.616732 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Jun 21 05:01:15.616499 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jun 21 05:01:15.617877 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jun 21 05:01:15.621693 systemd[1]: motdgen.service: Deactivated successfully. Jun 21 05:01:15.622125 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jun 21 05:01:15.626906 extend-filesystems[1450]: Old size kept for /dev/vda9 Jun 21 05:01:15.627621 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 21 05:01:15.639716 kernel: ACPI: button: Power Button [PWRF] Jun 21 05:01:15.628381 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jun 21 05:01:15.635452 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). Jun 21 05:01:15.635480 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jun 21 05:01:15.636970 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). Jun 21 05:01:15.636986 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jun 21 05:01:15.638451 systemd[1]: Started update-engine.service - Update Engine. Jun 21 05:01:15.640040 (ntainerd)[1493]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 21 05:01:15.643960 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jun 21 05:01:15.656786 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jun 21 05:01:15.662136 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jun 21 05:01:15.689097 bash[1513]: Updated "/home/core/.ssh/authorized_keys" Jun 21 05:01:15.696273 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jun 21 05:01:15.698155 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jun 21 05:01:15.703057 sshd_keygen[1465]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jun 21 05:01:15.706486 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Jun 21 05:01:15.706803 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jun 21 05:01:15.706965 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jun 21 05:01:15.720443 systemd-logind[1457]: New seat seat0. Jun 21 05:01:15.722641 systemd[1]: Started systemd-logind.service - User Login Management. Jun 21 05:01:15.742295 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jun 21 05:01:15.749343 systemd[1]: Starting issuegen.service - Generate /run/issue... Jun 21 05:01:15.761329 locksmithd[1501]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 21 05:01:15.775591 systemd[1]: issuegen.service: Deactivated successfully. Jun 21 05:01:15.775903 systemd[1]: Finished issuegen.service - Generate /run/issue. Jun 21 05:01:15.779106 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jun 21 05:01:15.809061 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jun 21 05:01:15.814108 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 21 05:01:15.819864 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jun 21 05:01:15.821529 systemd[1]: Reached target getty.target - Login Prompts. Jun 21 05:01:15.829799 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 05:01:15.861900 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 05:01:15.862170 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 05:01:15.862858 containerd[1493]: time="2025-06-21T05:01:15Z" 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 Jun 21 05:01:15.863678 containerd[1493]: time="2025-06-21T05:01:15.863644545Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jun 21 05:01:15.865889 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jun 21 05:01:15.875489 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878606915Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.117µs" Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878630139Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878646389Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878789287Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878801851Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878821808Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878877383Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.878886710Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.879095853Z" 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 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.879108987Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.879118655Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879280 containerd[1493]: time="2025-06-21T05:01:15.879126370Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879507 containerd[1493]: time="2025-06-21T05:01:15.879219675Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879804 containerd[1493]: time="2025-06-21T05:01:15.879786889Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 05:01:15.879874 containerd[1493]: time="2025-06-21T05:01:15.879860868Z" 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 Jun 21 05:01:15.879916 containerd[1493]: time="2025-06-21T05:01:15.879905421Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jun 21 05:01:15.879988 containerd[1493]: time="2025-06-21T05:01:15.879976835Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jun 21 05:01:15.880728 containerd[1493]: time="2025-06-21T05:01:15.880711754Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jun 21 05:01:15.880838 containerd[1493]: time="2025-06-21T05:01:15.880824876Z" level=info msg="metadata content store policy set" policy=shared Jun 21 05:01:15.886637 containerd[1493]: time="2025-06-21T05:01:15.886620229Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jun 21 05:01:15.886732 containerd[1493]: time="2025-06-21T05:01:15.886718794Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jun 21 05:01:15.886817 containerd[1493]: time="2025-06-21T05:01:15.886805126Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jun 21 05:01:15.886866 containerd[1493]: time="2025-06-21T05:01:15.886855210Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jun 21 05:01:15.886911 containerd[1493]: time="2025-06-21T05:01:15.886901336Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jun 21 05:01:15.886955 containerd[1493]: time="2025-06-21T05:01:15.886945188Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jun 21 05:01:15.887015 containerd[1493]: time="2025-06-21T05:01:15.887002967Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jun 21 05:01:15.887073 containerd[1493]: time="2025-06-21T05:01:15.887061166Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jun 21 05:01:15.887116 containerd[1493]: time="2025-06-21T05:01:15.887106331Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jun 21 05:01:15.887158 containerd[1493]: time="2025-06-21T05:01:15.887148340Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jun 21 05:01:15.887204 containerd[1493]: time="2025-06-21T05:01:15.887194095Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jun 21 05:01:15.887263 containerd[1493]: time="2025-06-21T05:01:15.887239681Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jun 21 05:01:15.887401 containerd[1493]: time="2025-06-21T05:01:15.887385895Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jun 21 05:01:15.887461 containerd[1493]: time="2025-06-21T05:01:15.887450597Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jun 21 05:01:15.887524 containerd[1493]: time="2025-06-21T05:01:15.887512883Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jun 21 05:01:15.887570 containerd[1493]: time="2025-06-21T05:01:15.887559160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jun 21 05:01:15.887612 containerd[1493]: time="2025-06-21T05:01:15.887602882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jun 21 05:01:15.887655 containerd[1493]: time="2025-06-21T05:01:15.887645212Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jun 21 05:01:15.887711 containerd[1493]: time="2025-06-21T05:01:15.887698852Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jun 21 05:01:15.887763 containerd[1493]: time="2025-06-21T05:01:15.887751862Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jun 21 05:01:15.887813 containerd[1493]: time="2025-06-21T05:01:15.887803038Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jun 21 05:01:15.887862 containerd[1493]: time="2025-06-21T05:01:15.887849846Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jun 21 05:01:15.887910 containerd[1493]: time="2025-06-21T05:01:15.887900020Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jun 21 05:01:15.888012 containerd[1493]: time="2025-06-21T05:01:15.887990229Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jun 21 05:01:15.888087 containerd[1493]: time="2025-06-21T05:01:15.888061543Z" level=info msg="Start snapshots syncer" Jun 21 05:01:15.888141 containerd[1493]: time="2025-06-21T05:01:15.888129851Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jun 21 05:01:15.888549 containerd[1493]: time="2025-06-21T05:01:15.888461533Z" 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\"}" Jun 21 05:01:15.888549 containerd[1493]: time="2025-06-21T05:01:15.888506457Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jun 21 05:01:15.889474 containerd[1493]: time="2025-06-21T05:01:15.889421895Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889587736Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889609747Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889620578Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889637439Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889647869Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889657767Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889667215Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889685209Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889694106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jun 21 05:01:15.889736 containerd[1493]: time="2025-06-21T05:01:15.889704415Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jun 21 05:01:15.889997 containerd[1493]: time="2025-06-21T05:01:15.889949214Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 05:01:15.889997 containerd[1493]: time="2025-06-21T05:01:15.889967859Z" 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 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.889975463Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890101340Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890110186Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890118983Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890129222Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890145232Z" level=info msg="runtime interface created" Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890149871Z" level=info msg="created NRI interface" Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890156784Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890166271Z" level=info msg="Connect containerd service" Jun 21 05:01:15.890213 containerd[1493]: time="2025-06-21T05:01:15.890186539Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 21 05:01:15.891258 containerd[1493]: time="2025-06-21T05:01:15.891158413Z" 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" Jun 21 05:01:15.918823 systemd-logind[1457]: Watching system buttons on /dev/input/event2 (Power Button) Jun 21 05:01:15.923921 systemd-logind[1457]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jun 21 05:01:15.950212 kernel: kvm_amd: TSC scaling supported Jun 21 05:01:15.950308 kernel: kvm_amd: Nested Virtualization enabled Jun 21 05:01:15.950332 kernel: kvm_amd: Nested Paging enabled Jun 21 05:01:15.950348 kernel: kvm_amd: LBR virtualization supported Jun 21 05:01:15.953725 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Jun 21 05:01:15.953752 kernel: kvm_amd: Virtual GIF supported Jun 21 05:01:15.986542 kernel: EDAC MC: Ver: 3.0.0 Jun 21 05:01:15.987955 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 05:01:16.033420 containerd[1493]: time="2025-06-21T05:01:16.033330398Z" level=info msg="Start subscribing containerd event" Jun 21 05:01:16.033579 containerd[1493]: time="2025-06-21T05:01:16.033522227Z" level=info msg="Start recovering state" Jun 21 05:01:16.033689 containerd[1493]: time="2025-06-21T05:01:16.033673902Z" level=info msg="Start event monitor" Jun 21 05:01:16.033735 containerd[1493]: time="2025-06-21T05:01:16.033543928Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 21 05:01:16.033793 containerd[1493]: time="2025-06-21T05:01:16.033781083Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 21 05:01:16.034067 containerd[1493]: time="2025-06-21T05:01:16.034042343Z" level=info msg="Start cni network conf syncer for default" Jun 21 05:01:16.034067 containerd[1493]: time="2025-06-21T05:01:16.034057291Z" level=info msg="Start streaming server" Jun 21 05:01:16.034106 containerd[1493]: time="2025-06-21T05:01:16.034069274Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jun 21 05:01:16.034106 containerd[1493]: time="2025-06-21T05:01:16.034087879Z" level=info msg="runtime interface starting up..." Jun 21 05:01:16.034106 containerd[1493]: time="2025-06-21T05:01:16.034093710Z" level=info msg="starting plugins..." Jun 21 05:01:16.034163 containerd[1493]: time="2025-06-21T05:01:16.034117154Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jun 21 05:01:16.034411 containerd[1493]: time="2025-06-21T05:01:16.034388272Z" level=info msg="containerd successfully booted in 0.172040s" Jun 21 05:01:16.034520 systemd[1]: Started containerd.service - containerd container runtime. Jun 21 05:01:16.842412 systemd-networkd[1413]: eth0: Gained IPv6LL Jun 21 05:01:16.845712 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jun 21 05:01:16.847893 systemd[1]: Reached target network-online.target - Network is Online. Jun 21 05:01:16.850885 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 21 05:01:16.853453 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jun 21 05:01:16.900471 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jun 21 05:01:16.902640 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 21 05:01:16.902958 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 21 05:01:16.905726 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jun 21 05:01:16.906036 systemd[1]: Reached target multi-user.target - Multi-User System. Jun 21 05:01:16.907714 systemd[1]: Startup finished in 2.942s (kernel) + 4.307s (initrd) + 3.053s (userspace) = 10.303s. Jun 21 05:01:22.769240 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jun 21 05:01:22.770412 systemd[1]: Started sshd@0-10.0.0.41:22-10.0.0.1:38356.service - OpenSSH per-connection server daemon (10.0.0.1:38356). Jun 21 05:01:22.824218 sshd[1605]: Accepted publickey for core from 10.0.0.1 port 38356 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:22.826003 sshd-session[1605]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:22.832059 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jun 21 05:01:22.833107 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jun 21 05:01:22.839033 systemd-logind[1457]: New session 1 of user core. Jun 21 05:01:22.857369 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jun 21 05:01:22.860236 systemd[1]: Starting user@500.service - User Manager for UID 500... Jun 21 05:01:22.887393 (systemd)[1609]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 21 05:01:22.890004 systemd-logind[1457]: New session c1 of user core. Jun 21 05:01:23.033919 systemd[1609]: Queued start job for default target default.target. Jun 21 05:01:23.052446 systemd[1609]: Created slice app.slice - User Application Slice. Jun 21 05:01:23.052469 systemd[1609]: Reached target paths.target - Paths. Jun 21 05:01:23.052506 systemd[1609]: Reached target timers.target - Timers. Jun 21 05:01:23.053919 systemd[1609]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 21 05:01:23.064801 systemd[1609]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 21 05:01:23.064920 systemd[1609]: Reached target sockets.target - Sockets. Jun 21 05:01:23.064959 systemd[1609]: Reached target basic.target - Basic System. Jun 21 05:01:23.064997 systemd[1609]: Reached target default.target - Main User Target. Jun 21 05:01:23.065028 systemd[1609]: Startup finished in 169ms. Jun 21 05:01:23.065463 systemd[1]: Started user@500.service - User Manager for UID 500. Jun 21 05:01:23.067214 systemd[1]: Started session-1.scope - Session 1 of User core. Jun 21 05:01:23.134155 systemd[1]: Started sshd@1-10.0.0.41:22-10.0.0.1:38368.service - OpenSSH per-connection server daemon (10.0.0.1:38368). Jun 21 05:01:23.187945 sshd[1620]: Accepted publickey for core from 10.0.0.1 port 38368 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:23.189549 sshd-session[1620]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:23.194429 systemd-logind[1457]: New session 2 of user core. Jun 21 05:01:23.209379 systemd[1]: Started session-2.scope - Session 2 of User core. Jun 21 05:01:23.263192 sshd[1622]: Connection closed by 10.0.0.1 port 38368 Jun 21 05:01:23.263532 sshd-session[1620]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:23.271886 systemd[1]: sshd@1-10.0.0.41:22-10.0.0.1:38368.service: Deactivated successfully. Jun 21 05:01:23.273659 systemd[1]: session-2.scope: Deactivated successfully. Jun 21 05:01:23.274579 systemd-logind[1457]: Session 2 logged out. Waiting for processes to exit. Jun 21 05:01:23.277167 systemd[1]: Started sshd@2-10.0.0.41:22-10.0.0.1:38372.service - OpenSSH per-connection server daemon (10.0.0.1:38372). Jun 21 05:01:23.277937 systemd-logind[1457]: Removed session 2. Jun 21 05:01:23.330564 sshd[1628]: Accepted publickey for core from 10.0.0.1 port 38372 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:23.331987 sshd-session[1628]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:23.336294 systemd-logind[1457]: New session 3 of user core. Jun 21 05:01:23.350362 systemd[1]: Started session-3.scope - Session 3 of User core. Jun 21 05:01:23.399143 sshd[1630]: Connection closed by 10.0.0.1 port 38372 Jun 21 05:01:23.399473 sshd-session[1628]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:23.407813 systemd[1]: sshd@2-10.0.0.41:22-10.0.0.1:38372.service: Deactivated successfully. Jun 21 05:01:23.409584 systemd[1]: session-3.scope: Deactivated successfully. Jun 21 05:01:23.410298 systemd-logind[1457]: Session 3 logged out. Waiting for processes to exit. Jun 21 05:01:23.413054 systemd[1]: Started sshd@3-10.0.0.41:22-10.0.0.1:38376.service - OpenSSH per-connection server daemon (10.0.0.1:38376). Jun 21 05:01:23.413586 systemd-logind[1457]: Removed session 3. Jun 21 05:01:23.465257 sshd[1636]: Accepted publickey for core from 10.0.0.1 port 38376 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:23.466711 sshd-session[1636]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:23.470901 systemd-logind[1457]: New session 4 of user core. Jun 21 05:01:23.481383 systemd[1]: Started session-4.scope - Session 4 of User core. Jun 21 05:01:23.535428 sshd[1638]: Connection closed by 10.0.0.1 port 38376 Jun 21 05:01:23.535685 sshd-session[1636]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:23.546170 systemd[1]: sshd@3-10.0.0.41:22-10.0.0.1:38376.service: Deactivated successfully. Jun 21 05:01:23.548615 systemd[1]: session-4.scope: Deactivated successfully. Jun 21 05:01:23.549493 systemd-logind[1457]: Session 4 logged out. Waiting for processes to exit. Jun 21 05:01:23.553483 systemd[1]: Started sshd@4-10.0.0.41:22-10.0.0.1:38384.service - OpenSSH per-connection server daemon (10.0.0.1:38384). Jun 21 05:01:23.554172 systemd-logind[1457]: Removed session 4. Jun 21 05:01:23.613750 sshd[1644]: Accepted publickey for core from 10.0.0.1 port 38384 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:23.615351 sshd-session[1644]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:23.620151 systemd-logind[1457]: New session 5 of user core. Jun 21 05:01:23.633556 systemd[1]: Started session-5.scope - Session 5 of User core. Jun 21 05:01:23.694065 sudo[1648]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jun 21 05:01:23.694490 sudo[1648]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 05:01:23.712013 sudo[1648]: pam_unix(sudo:session): session closed for user root Jun 21 05:01:23.714000 sshd[1647]: Connection closed by 10.0.0.1 port 38384 Jun 21 05:01:23.714391 sshd-session[1644]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:23.723485 systemd[1]: sshd@4-10.0.0.41:22-10.0.0.1:38384.service: Deactivated successfully. Jun 21 05:01:23.725150 systemd[1]: session-5.scope: Deactivated successfully. Jun 21 05:01:23.725971 systemd-logind[1457]: Session 5 logged out. Waiting for processes to exit. Jun 21 05:01:23.728841 systemd[1]: Started sshd@5-10.0.0.41:22-10.0.0.1:38394.service - OpenSSH per-connection server daemon (10.0.0.1:38394). Jun 21 05:01:23.729382 systemd-logind[1457]: Removed session 5. Jun 21 05:01:23.780925 sshd[1654]: Accepted publickey for core from 10.0.0.1 port 38394 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:23.782520 sshd-session[1654]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:23.787065 systemd-logind[1457]: New session 6 of user core. Jun 21 05:01:23.800378 systemd[1]: Started session-6.scope - Session 6 of User core. Jun 21 05:01:23.853371 sudo[1658]: 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 Jun 21 05:01:23.853670 sudo[1658]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 05:01:23.860413 sudo[1658]: pam_unix(sudo:session): session closed for user root Jun 21 05:01:23.866292 sudo[1657]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jun 21 05:01:23.866586 sudo[1657]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 05:01:23.876172 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jun 21 05:01:23.928452 augenrules[1680]: No rules Jun 21 05:01:23.930142 systemd[1]: audit-rules.service: Deactivated successfully. Jun 21 05:01:23.930431 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jun 21 05:01:23.931625 sudo[1657]: pam_unix(sudo:session): session closed for user root Jun 21 05:01:23.933088 sshd[1656]: Connection closed by 10.0.0.1 port 38394 Jun 21 05:01:23.933460 sshd-session[1654]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:23.946069 systemd[1]: sshd@5-10.0.0.41:22-10.0.0.1:38394.service: Deactivated successfully. Jun 21 05:01:23.948160 systemd[1]: session-6.scope: Deactivated successfully. Jun 21 05:01:23.948910 systemd-logind[1457]: Session 6 logged out. Waiting for processes to exit. Jun 21 05:01:23.952121 systemd[1]: Started sshd@6-10.0.0.41:22-10.0.0.1:38410.service - OpenSSH per-connection server daemon (10.0.0.1:38410). Jun 21 05:01:23.952683 systemd-logind[1457]: Removed session 6. Jun 21 05:01:24.005587 sshd[1689]: Accepted publickey for core from 10.0.0.1 port 38410 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:24.006837 sshd-session[1689]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:24.011034 systemd-logind[1457]: New session 7 of user core. Jun 21 05:01:24.020382 systemd[1]: Started session-7.scope - Session 7 of User core. Jun 21 05:01:24.075581 systemd[1]: Starting docker.service - Docker Application Container Engine... Jun 21 05:01:24.099850 (dockerd)[1693]: 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 Jun 21 05:01:24.333373 dockerd[1693]: time="2025-06-21T05:01:24.333223149Z" level=info msg="Starting up" Jun 21 05:01:24.334789 dockerd[1693]: time="2025-06-21T05:01:24.334765983Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jun 21 05:01:24.408527 dockerd[1693]: time="2025-06-21T05:01:24.408461872Z" level=info msg="Loading containers: start." Jun 21 05:01:24.419273 kernel: Initializing XFRM netlink socket Jun 21 05:01:24.665184 systemd-networkd[1413]: docker0: Link UP Jun 21 05:01:24.670985 dockerd[1693]: time="2025-06-21T05:01:24.670946121Z" level=info msg="Loading containers: done." Jun 21 05:01:24.684460 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2998604789-merged.mount: Deactivated successfully. Jun 21 05:01:24.685797 dockerd[1693]: time="2025-06-21T05:01:24.685757198Z" 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 Jun 21 05:01:24.685858 dockerd[1693]: time="2025-06-21T05:01:24.685831557Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jun 21 05:01:24.685953 dockerd[1693]: time="2025-06-21T05:01:24.685934170Z" level=info msg="Initializing buildkit" Jun 21 05:01:24.715329 dockerd[1693]: time="2025-06-21T05:01:24.715292999Z" level=info msg="Completed buildkit initialization" Jun 21 05:01:24.721827 dockerd[1693]: time="2025-06-21T05:01:24.721797392Z" level=info msg="Daemon has completed initialization" Jun 21 05:01:24.721925 dockerd[1693]: time="2025-06-21T05:01:24.721862724Z" level=info msg="API listen on /run/docker.sock" Jun 21 05:01:24.721971 systemd[1]: Started docker.service - Docker Application Container Engine. Jun 21 05:01:24.730986 sshd[1691]: Connection closed by 10.0.0.1 port 38410 Jun 21 05:01:24.731296 sshd-session[1689]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:24.747172 systemd[1]: sshd@6-10.0.0.41:22-10.0.0.1:38410.service: Deactivated successfully. Jun 21 05:01:24.748877 systemd[1]: session-7.scope: Deactivated successfully. Jun 21 05:01:24.749580 systemd-logind[1457]: Session 7 logged out. Waiting for processes to exit. Jun 21 05:01:24.752292 systemd[1]: Started sshd@7-10.0.0.41:22-10.0.0.1:38426.service - OpenSSH per-connection server daemon (10.0.0.1:38426). Jun 21 05:01:24.752899 systemd-logind[1457]: Removed session 7. Jun 21 05:01:24.817486 sshd[1898]: Accepted publickey for core from 10.0.0.1 port 38426 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:24.818851 sshd-session[1898]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:24.823048 systemd-logind[1457]: New session 8 of user core. Jun 21 05:01:24.838367 systemd[1]: Started session-8.scope - Session 8 of User core. Jun 21 05:01:26.299963 systemd[1]: var-lib-docker-overlay2-31f53a82a2dfb20f7adea13feae3e10007ab82d31661898109a18ffe3f7c2e5a\x2dinit-merged.mount: Deactivated successfully. Jun 21 05:01:26.352911 containerd[1493]: time="2025-06-21T05:01:26.352864350Z" level=info msg="connecting to shim cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541" address="unix:///run/containerd/s/137aed2abe23e18fb6955366ca52314bd50071919fbafa108ad4e33c9bb11477" namespace=moby protocol=ttrpc version=3 Jun 21 05:01:26.388472 systemd[1]: Started docker-cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541.scope - libcontainer container cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541. Jun 21 05:01:26.404561 systemd-resolved[1348]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 05:01:26.433301 kernel: docker0: port 1(veth9f2fbec) entered blocking state Jun 21 05:01:26.433394 kernel: docker0: port 1(veth9f2fbec) entered disabled state Jun 21 05:01:26.433408 kernel: veth9f2fbec: entered allmulticast mode Jun 21 05:01:26.434448 kernel: veth9f2fbec: entered promiscuous mode Jun 21 05:01:26.435079 systemd-networkd[1413]: veth9f2fbec: Link UP Jun 21 05:01:26.446279 kernel: eth0: renamed from vethdcd2185 Jun 21 05:01:26.446338 kernel: docker0: port 1(veth9f2fbec) entered blocking state Jun 21 05:01:26.447487 kernel: docker0: port 1(veth9f2fbec) entered forwarding state Jun 21 05:01:26.447559 systemd-networkd[1413]: veth9f2fbec: Gained carrier Jun 21 05:01:26.447879 systemd-networkd[1413]: docker0: Gained carrier Jun 21 05:01:26.478962 sshd[1900]: Connection closed by 10.0.0.1 port 38426 Jun 21 05:01:26.479307 sshd-session[1898]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:26.493117 systemd[1]: sshd@7-10.0.0.41:22-10.0.0.1:38426.service: Deactivated successfully. Jun 21 05:01:26.495468 systemd[1]: session-8.scope: Deactivated successfully. Jun 21 05:01:26.496293 systemd-logind[1457]: Session 8 logged out. Waiting for processes to exit. Jun 21 05:01:26.499732 systemd[1]: Started sshd@8-10.0.0.41:22-10.0.0.1:49146.service - OpenSSH per-connection server daemon (10.0.0.1:49146). Jun 21 05:01:26.500625 systemd-logind[1457]: Removed session 8. Jun 21 05:01:26.557495 sshd[1975]: Accepted publickey for core from 10.0.0.1 port 49146 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:26.559007 sshd-session[1975]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:26.563489 systemd-logind[1457]: New session 9 of user core. Jun 21 05:01:26.578395 systemd[1]: Started session-9.scope - Session 9 of User core. Jun 21 05:01:26.637272 sshd[1977]: Connection closed by 10.0.0.1 port 49146 Jun 21 05:01:26.637726 sshd-session[1975]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:26.647140 systemd[1]: sshd@8-10.0.0.41:22-10.0.0.1:49146.service: Deactivated successfully. Jun 21 05:01:26.648925 systemd[1]: session-9.scope: Deactivated successfully. Jun 21 05:01:26.649789 systemd-logind[1457]: Session 9 logged out. Waiting for processes to exit. Jun 21 05:01:26.652633 systemd[1]: Started sshd@9-10.0.0.41:22-10.0.0.1:49156.service - OpenSSH per-connection server daemon (10.0.0.1:49156). Jun 21 05:01:26.653381 systemd-logind[1457]: Removed session 9. Jun 21 05:01:26.721066 sshd[1983]: Accepted publickey for core from 10.0.0.1 port 49156 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:26.722401 sshd-session[1983]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:26.726506 systemd-logind[1457]: New session 10 of user core. Jun 21 05:01:26.741379 systemd[1]: Started session-10.scope - Session 10 of User core. Jun 21 05:01:26.795056 sudo[1986]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1493 Jun 21 05:01:26.795374 sudo[1986]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 05:01:26.799223 dockerd[1693]: time="2025-06-21T05:01:26.798886559Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jun 21 05:01:26.799223 dockerd[1693]: time="2025-06-21T05:01:26.798922777Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jun 21 05:01:26.799568 containerd[1493]: time="2025-06-21T05:01:26.799143051Z" level=info msg="Stop CRI service" Jun 21 05:01:26.798925 sudo[1986]: pam_unix(sudo:session): session closed for user root Jun 21 05:01:26.799644 dockerd[1693]: time="2025-06-21T05:01:26.799197893Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jun 21 05:01:26.799644 dockerd[1693]: time="2025-06-21T05:01:26.799262956Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jun 21 05:01:26.800416 containerd[1493]: time="2025-06-21T05:01:26.800359503Z" level=info msg="Stop CRI service" Jun 21 05:01:26.800541 containerd[1493]: time="2025-06-21T05:01:26.800420617Z" level=info msg="Event monitor stopped" Jun 21 05:01:26.800541 containerd[1493]: time="2025-06-21T05:01:26.800429915Z" level=info msg="Stream server stopped" Jun 21 05:01:26.800928 sshd[1985]: Connection closed by 10.0.0.1 port 49156 Jun 21 05:01:26.801261 sshd-session[1983]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:26.809466 systemd[1]: containerd.service: Deactivated successfully. Jun 21 05:01:26.809574 systemd[1]: containerd.service: Unit process 1926 (containerd-shim) remains running after unit stopped. Jun 21 05:01:26.809846 systemd[1]: containerd.service: Consumed 320ms CPU time, 137.5M memory peak. Jun 21 05:01:26.810273 systemd[1]: sshd@9-10.0.0.41:22-10.0.0.1:49156.service: Deactivated successfully. Jun 21 05:01:26.812094 systemd[1]: session-10.scope: Deactivated successfully. Jun 21 05:01:26.813698 systemd-logind[1457]: Session 10 logged out. Waiting for processes to exit. Jun 21 05:01:26.817041 systemd[1]: Started sshd@10-10.0.0.41:22-10.0.0.1:49162.service - OpenSSH per-connection server daemon (10.0.0.1:49162). Jun 21 05:01:26.817630 systemd-logind[1457]: Removed session 10. Jun 21 05:01:26.885510 sshd[1993]: Accepted publickey for core from 10.0.0.1 port 49162 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:26.887028 sshd-session[1993]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:26.891540 systemd-logind[1457]: New session 11 of user core. Jun 21 05:01:26.899366 systemd[1]: Started session-11.scope - Session 11 of User core. Jun 21 05:01:26.956684 sshd[1995]: Connection closed by 10.0.0.1 port 49162 Jun 21 05:01:26.957040 sshd-session[1993]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:26.962092 systemd[1]: sshd@10-10.0.0.41:22-10.0.0.1:49162.service: Deactivated successfully. Jun 21 05:01:26.963982 systemd[1]: session-11.scope: Deactivated successfully. Jun 21 05:01:26.964668 systemd-logind[1457]: Session 11 logged out. Waiting for processes to exit. Jun 21 05:01:26.965804 systemd-logind[1457]: Removed session 11. Jun 21 05:01:27.594401 systemd-networkd[1413]: docker0: Gained IPv6LL Jun 21 05:01:27.722367 systemd-networkd[1413]: veth9f2fbec: Gained IPv6LL Jun 21 05:01:31.817304 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Jun 21 05:01:31.817780 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jun 21 05:01:31.817861 dockerd[1693]: time="2025-06-21T05:01:31.817804878Z" level=info msg="Processing signal 'terminated'" Jun 21 05:01:32.973017 systemd[1]: Started sshd@11-10.0.0.41:22-10.0.0.1:49172.service - OpenSSH per-connection server daemon (10.0.0.1:49172). Jun 21 05:01:33.023905 sshd[2001]: Accepted publickey for core from 10.0.0.1 port 49172 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:33.025132 sshd-session[2001]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:33.029205 systemd-logind[1457]: New session 12 of user core. Jun 21 05:01:33.040381 systemd[1]: Started session-12.scope - Session 12 of User core. Jun 21 05:01:33.095285 sshd[2003]: Connection closed by 10.0.0.1 port 49172 Jun 21 05:01:33.095599 sshd-session[2001]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:33.099959 systemd[1]: sshd@11-10.0.0.41:22-10.0.0.1:49172.service: Deactivated successfully. Jun 21 05:01:33.101871 systemd[1]: session-12.scope: Deactivated successfully. Jun 21 05:01:33.102751 systemd-logind[1457]: Session 12 logged out. Waiting for processes to exit. Jun 21 05:01:33.103871 systemd-logind[1457]: Removed session 12. Jun 21 05:01:33.819168 dockerd[1693]: time="2025-06-21T05:01:33.819089591Z" level=error msg="Error sending stop (signal 15) to container" container=cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541 error="Cannot kill container cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" Jun 21 05:01:33.819168 dockerd[1693]: time="2025-06-21T05:01:33.819137090Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541 Jun 21 05:01:39.111991 systemd[1]: Started sshd@12-10.0.0.41:22-10.0.0.1:47860.service - OpenSSH per-connection server daemon (10.0.0.1:47860). Jun 21 05:01:39.156077 sshd[2009]: Accepted publickey for core from 10.0.0.1 port 47860 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:39.157616 sshd-session[2009]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:39.161962 systemd-logind[1457]: New session 13 of user core. Jun 21 05:01:39.173389 systemd[1]: Started session-13.scope - Session 13 of User core. Jun 21 05:01:39.227134 sshd[2011]: Connection closed by 10.0.0.1 port 47860 Jun 21 05:01:39.227418 sshd-session[2009]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:39.231387 systemd[1]: sshd@12-10.0.0.41:22-10.0.0.1:47860.service: Deactivated successfully. Jun 21 05:01:39.233185 systemd[1]: session-13.scope: Deactivated successfully. Jun 21 05:01:39.233925 systemd-logind[1457]: Session 13 logged out. Waiting for processes to exit. Jun 21 05:01:39.235128 systemd-logind[1457]: Removed session 13. Jun 21 05:01:43.819924 dockerd[1693]: time="2025-06-21T05:01:43.819858077Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541 error="context deadline exceeded" Jun 21 05:01:43.820656 systemd[1]: docker-cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541.scope: Deactivated successfully. Jun 21 05:01:45.248816 systemd[1]: Started sshd@13-10.0.0.41:22-10.0.0.1:47876.service - OpenSSH per-connection server daemon (10.0.0.1:47876). Jun 21 05:01:45.303287 sshd[2017]: Accepted publickey for core from 10.0.0.1 port 47876 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:45.304488 sshd-session[2017]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:45.308430 systemd-logind[1457]: New session 14 of user core. Jun 21 05:01:45.318358 systemd[1]: Started session-14.scope - Session 14 of User core. Jun 21 05:01:45.371764 sshd[2019]: Connection closed by 10.0.0.1 port 47876 Jun 21 05:01:45.372037 sshd-session[2017]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:45.375261 systemd[1]: sshd@13-10.0.0.41:22-10.0.0.1:47876.service: Deactivated successfully. Jun 21 05:01:45.376997 systemd[1]: session-14.scope: Deactivated successfully. Jun 21 05:01:45.377711 systemd-logind[1457]: Session 14 logged out. Waiting for processes to exit. Jun 21 05:01:45.378710 systemd-logind[1457]: Removed session 14. Jun 21 05:01:46.818068 dockerd[1693]: time="2025-06-21T05:01:46.818003903Z" level=error msg="Force shutdown daemon" Jun 21 05:01:46.818532 dockerd[1693]: time="2025-06-21T05:01:46.818186044Z" level=info msg="Daemon shutdown complete" Jun 21 05:01:46.818532 dockerd[1693]: time="2025-06-21T05:01:46.818287454Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" Jun 21 05:01:46.823396 systemd[1]: docker.service: Deactivated successfully. Jun 21 05:01:46.823844 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jun 21 05:01:46.823908 systemd[1]: docker.service: Consumed 928ms CPU time, 125.2M memory peak. Jun 21 05:01:46.824406 systemd[1]: docker.socket: Deactivated successfully. Jun 21 05:01:46.824771 systemd[1]: Closed docker.socket - Docker Socket for the API. Jun 21 05:01:46.824814 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jun 21 05:01:46.826650 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 21 05:01:46.826847 systemd[1]: containerd.service: Found left-over process 1926 (containerd-shim) in control group while starting unit. Ignoring. Jun 21 05:01:46.826856 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jun 21 05:01:46.832682 systemd[1]: Starting containerd.service - containerd container runtime... Jun 21 05:01:46.833376 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 21 05:01:46.845334 systemd[1]: containerd.service: Found left-over process 1926 (containerd-shim) in control group while starting unit. Ignoring. Jun 21 05:01:46.845345 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jun 21 05:01:46.849588 (ntainerd)[2030]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 21 05:01:46.863899 containerd[2030]: time="2025-06-21T05:01:46Z" 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 Jun 21 05:01:46.864430 containerd[2030]: time="2025-06-21T05:01:46.864396989Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jun 21 05:01:46.871906 containerd[2030]: time="2025-06-21T05:01:46.871860391Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.878µs" Jun 21 05:01:46.871906 containerd[2030]: time="2025-06-21T05:01:46.871893944Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jun 21 05:01:46.872002 containerd[2030]: time="2025-06-21T05:01:46.871916516Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jun 21 05:01:46.872002 containerd[2030]: time="2025-06-21T05:01:46.871952103Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jun 21 05:01:46.872002 containerd[2030]: time="2025-06-21T05:01:46.871967512Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jun 21 05:01:46.872230 containerd[2030]: time="2025-06-21T05:01:46.872198596Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872301 containerd[2030]: time="2025-06-21T05:01:46.872260472Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872301 containerd[2030]: time="2025-06-21T05:01:46.872279998Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872606 containerd[2030]: time="2025-06-21T05:01:46.872570123Z" 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 Jun 21 05:01:46.872606 containerd[2030]: time="2025-06-21T05:01:46.872590391Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872606 containerd[2030]: time="2025-06-21T05:01:46.872603395Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872705 containerd[2030]: time="2025-06-21T05:01:46.872613785Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872705 containerd[2030]: time="2025-06-21T05:01:46.872645003Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872767 containerd[2030]: time="2025-06-21T05:01:46.872751613Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 05:01:46.872799 containerd[2030]: time="2025-06-21T05:01:46.872782331Z" 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 Jun 21 05:01:46.872827 containerd[2030]: time="2025-06-21T05:01:46.872796207Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jun 21 05:01:46.872858 containerd[2030]: time="2025-06-21T05:01:46.872844427Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jun 21 05:01:46.873570 containerd[2030]: time="2025-06-21T05:01:46.873532699Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jun 21 05:01:46.873638 containerd[2030]: time="2025-06-21T05:01:46.873610104Z" level=info msg="metadata content store policy set" policy=shared Jun 21 05:01:46.873814 containerd[2030]: time="2025-06-21T05:01:46.873780574Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jun 21 05:01:46.873970 containerd[2030]: time="2025-06-21T05:01:46.873925696Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jun 21 05:01:46.873970 containerd[2030]: time="2025-06-21T05:01:46.873957465Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jun 21 05:01:46.874048 containerd[2030]: time="2025-06-21T05:01:46.873972534Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jun 21 05:01:46.874048 containerd[2030]: time="2025-06-21T05:01:46.873988764Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jun 21 05:01:46.874048 containerd[2030]: time="2025-06-21T05:01:46.873999154Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jun 21 05:01:46.874048 containerd[2030]: time="2025-06-21T05:01:46.874014653Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jun 21 05:01:46.874163 containerd[2030]: time="2025-06-21T05:01:46.874034971Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jun 21 05:01:46.874163 containerd[2030]: time="2025-06-21T05:01:46.874072251Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jun 21 05:01:46.874163 containerd[2030]: time="2025-06-21T05:01:46.874087359Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jun 21 05:01:46.874163 containerd[2030]: time="2025-06-21T05:01:46.874107196Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jun 21 05:01:46.874163 containerd[2030]: time="2025-06-21T05:01:46.874122275Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jun 21 05:01:46.874463 containerd[2030]: time="2025-06-21T05:01:46.874419793Z" level=info msg="connecting to shim cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541" address="unix:///run/containerd/s/137aed2abe23e18fb6955366ca52314bd50071919fbafa108ad4e33c9bb11477" namespace=moby protocol=ttrpc version=3 Jun 21 05:01:46.882491 containerd[2030]: time="2025-06-21T05:01:46.882444758Z" level=info msg="cleaning leaked shim process" id=cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541 namespace=moby Jun 21 05:01:46.892741 containerd[2030]: time="2025-06-21T05:01:46.892671234Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jun 21 05:01:46.893105 containerd[2030]: time="2025-06-21T05:01:46.893013095Z" level=info msg="shim disconnected" id=cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541 namespace=moby Jun 21 05:01:46.893105 containerd[2030]: time="2025-06-21T05:01:46.893083297Z" level=warning msg="cleaning up after shim disconnected" id=cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541 namespace=moby Jun 21 05:01:46.893105 containerd[2030]: time="2025-06-21T05:01:46.893103855Z" level=info msg="cleaning up dead shim" namespace=moby Jun 21 05:01:46.905279 containerd[2030]: time="2025-06-21T05:01:46.905216770Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jun 21 05:01:46.905393 containerd[2030]: time="2025-06-21T05:01:46.905364557Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jun 21 05:01:46.905430 containerd[2030]: time="2025-06-21T05:01:46.905399032Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jun 21 05:01:46.905430 containerd[2030]: time="2025-06-21T05:01:46.905422155Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905437574Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905452522Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905465958Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905499490Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905512605Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905524558Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905535348Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jun 21 05:01:46.905589 containerd[2030]: time="2025-06-21T05:01:46.905547521Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jun 21 05:01:46.905797 containerd[2030]: time="2025-06-21T05:01:46.905621119Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jun 21 05:01:46.905797 containerd[2030]: time="2025-06-21T05:01:46.905638802Z" level=info msg="Start snapshots syncer" Jun 21 05:01:46.905797 containerd[2030]: time="2025-06-21T05:01:46.905681362Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jun 21 05:01:46.905972 containerd[2030]: time="2025-06-21T05:01:46.905928235Z" 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\"}" Jun 21 05:01:46.906081 containerd[2030]: time="2025-06-21T05:01:46.905981375Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jun 21 05:01:46.906132 containerd[2030]: time="2025-06-21T05:01:46.906076733Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jun 21 05:01:46.906167 containerd[2030]: time="2025-06-21T05:01:46.906138990Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jun 21 05:01:46.906197 containerd[2030]: time="2025-06-21T05:01:46.906174747Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jun 21 05:01:46.906197 containerd[2030]: time="2025-06-21T05:01:46.906189094Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jun 21 05:01:46.906279 containerd[2030]: time="2025-06-21T05:01:46.906200926Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jun 21 05:01:46.906279 containerd[2030]: time="2025-06-21T05:01:46.906217908Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jun 21 05:01:46.906279 containerd[2030]: time="2025-06-21T05:01:46.906261771Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jun 21 05:01:46.906279 containerd[2030]: time="2025-06-21T05:01:46.906277490Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jun 21 05:01:46.906409 containerd[2030]: time="2025-06-21T05:01:46.906303439Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jun 21 05:01:46.906409 containerd[2030]: time="2025-06-21T05:01:46.906316734Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jun 21 05:01:46.906409 containerd[2030]: time="2025-06-21T05:01:46.906330630Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jun 21 05:01:46.906409 containerd[2030]: time="2025-06-21T05:01:46.906375334Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 05:01:46.906409 containerd[2030]: time="2025-06-21T05:01:46.906393498Z" 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 Jun 21 05:01:46.906409 containerd[2030]: time="2025-06-21T05:01:46.906404799Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906418905Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906429836Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906449443Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906462437Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906482966Z" level=info msg="runtime interface created" Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906489899Z" level=info msg="created NRI interface" Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906500168Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906512281Z" level=info msg="Connect containerd service" Jun 21 05:01:46.906573 containerd[2030]: time="2025-06-21T05:01:46.906539932Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 21 05:01:46.907132 containerd[2030]: time="2025-06-21T05:01:46.907090004Z" 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" Jun 21 05:01:46.917497 containerd[2030]: time="2025-06-21T05:01:46.917451654Z" level=info msg="Start subscribing containerd event" Jun 21 05:01:46.917577 containerd[2030]: time="2025-06-21T05:01:46.917517507Z" level=info msg="Start recovering state" Jun 21 05:01:46.917655 containerd[2030]: time="2025-06-21T05:01:46.917630619Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 21 05:01:46.917709 containerd[2030]: time="2025-06-21T05:01:46.917641229Z" level=info msg="Start event monitor" Jun 21 05:01:46.917709 containerd[2030]: time="2025-06-21T05:01:46.917690782Z" level=info msg="Start cni network conf syncer for default" Jun 21 05:01:46.917709 containerd[2030]: time="2025-06-21T05:01:46.917706943Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 21 05:01:46.917796 containerd[2030]: time="2025-06-21T05:01:46.917713345Z" level=info msg="Start streaming server" Jun 21 05:01:46.917796 containerd[2030]: time="2025-06-21T05:01:46.917748410Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jun 21 05:01:46.917796 containerd[2030]: time="2025-06-21T05:01:46.917757377Z" level=info msg="runtime interface starting up..." Jun 21 05:01:46.917796 containerd[2030]: time="2025-06-21T05:01:46.917775972Z" level=info msg="starting plugins..." Jun 21 05:01:46.917796 containerd[2030]: time="2025-06-21T05:01:46.917789578Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jun 21 05:01:46.917982 containerd[2030]: time="2025-06-21T05:01:46.917961510Z" level=info msg="containerd successfully booted in 0.054210s" Jun 21 05:01:46.918076 systemd[1]: Started containerd.service - containerd container runtime. Jun 21 05:01:46.920394 systemd[1]: Starting docker.service - Docker Application Container Engine... Jun 21 05:01:46.946563 (dockerd)[2077]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Jun 21 05:01:46.975047 dockerd[2077]: time="2025-06-21T05:01:46.974978037Z" level=info msg="Starting up" Jun 21 05:01:46.975828 dockerd[2077]: time="2025-06-21T05:01:46.975806201Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jun 21 05:01:47.006950 dockerd[2077]: time="2025-06-21T05:01:47.006904323Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jun 21 05:01:47.031550 dockerd[2077]: time="2025-06-21T05:01:47.031491641Z" level=info msg="Loading containers: start." Jun 21 05:01:47.048301 systemd[1]: var-lib-docker-overlay2-31f53a82a2dfb20f7adea13feae3e10007ab82d31661898109a18ffe3f7c2e5a-merged.mount: Deactivated successfully. Jun 21 05:01:47.420425 systemd-networkd[1413]: veth9f2fbec: Link DOWN Jun 21 05:01:47.421356 systemd-networkd[1413]: veth9f2fbec: Lost carrier Jun 21 05:01:47.422784 kernel: docker0: port 1(veth9f2fbec) entered disabled state Jun 21 05:01:47.422844 kernel: veth9f2fbec (unregistering): left allmulticast mode Jun 21 05:01:47.422871 kernel: veth9f2fbec (unregistering): left promiscuous mode Jun 21 05:01:47.423553 kernel: docker0: port 1(veth9f2fbec) entered disabled state Jun 21 05:01:47.425393 systemd-networkd[1413]: docker0: Lost carrier Jun 21 05:01:47.426637 dockerd[2077]: time="2025-06-21T05:01:47.426600243Z" level=info msg="Removing stale sandbox 8d46bc085d8a67b6c3da2489024e7297b4867511d7b33c2892db86587e002b0d (cf16ba1d69c9b03cd6eeb8e4fa4247854fdc1e6fc4b9c53f67f1e2dfd5eaa541)" Jun 21 05:01:47.432983 dockerd[2077]: time="2025-06-21T05:01:47.432933905Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jun 21 05:01:47.433034 dockerd[2077]: time="2025-06-21T05:01:47.432993056Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 4bf5258ade2b6eb9ee956193c279cf6384bc8a8c0fc13193b666a31617a0359c dd972824e23c6408d33e53d3827f4bf1fdfa351fdfd4b8902b3252a649e8fab1], retrying...." Jun 21 05:01:47.584439 dockerd[2077]: time="2025-06-21T05:01:47.584400648Z" level=warning msg="error locating sandbox id 8d46bc085d8a67b6c3da2489024e7297b4867511d7b33c2892db86587e002b0d: sandbox 8d46bc085d8a67b6c3da2489024e7297b4867511d7b33c2892db86587e002b0d not found" Jun 21 05:01:47.584605 dockerd[2077]: time="2025-06-21T05:01:47.584567460Z" level=info msg="Loading containers: done." Jun 21 05:01:47.597436 dockerd[2077]: time="2025-06-21T05:01:47.597394836Z" 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 Jun 21 05:01:47.597566 dockerd[2077]: time="2025-06-21T05:01:47.597473463Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jun 21 05:01:47.597566 dockerd[2077]: time="2025-06-21T05:01:47.597509270Z" level=info msg="Initializing buildkit" Jun 21 05:01:47.613119 dockerd[2077]: time="2025-06-21T05:01:47.613071276Z" level=info msg="Completed buildkit initialization" Jun 21 05:01:47.617778 dockerd[2077]: time="2025-06-21T05:01:47.617751496Z" level=info msg="Daemon has completed initialization" Jun 21 05:01:47.617861 dockerd[2077]: time="2025-06-21T05:01:47.617810647Z" level=info msg="API listen on /run/docker.sock" Jun 21 05:01:47.617989 systemd[1]: Started docker.service - Docker Application Container Engine. Jun 21 05:01:47.995582 systemd[1]: run-docker-netns-8d46bc085d8a.mount: Deactivated successfully. Jun 21 05:01:51.387518 systemd[1]: Started sshd@14-10.0.0.41:22-10.0.0.1:60162.service - OpenSSH per-connection server daemon (10.0.0.1:60162). Jun 21 05:01:51.445066 sshd[2299]: Accepted publickey for core from 10.0.0.1 port 60162 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:51.446546 sshd-session[2299]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:51.450967 systemd-logind[1457]: New session 15 of user core. Jun 21 05:01:51.461385 systemd[1]: Started session-15.scope - Session 15 of User core. Jun 21 05:01:51.515878 sshd[2301]: Connection closed by 10.0.0.1 port 60162 Jun 21 05:01:51.516342 sshd-session[2299]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:51.524920 systemd[1]: sshd@14-10.0.0.41:22-10.0.0.1:60162.service: Deactivated successfully. Jun 21 05:01:51.526707 systemd[1]: session-15.scope: Deactivated successfully. Jun 21 05:01:51.527531 systemd-logind[1457]: Session 15 logged out. Waiting for processes to exit. Jun 21 05:01:51.530727 systemd[1]: Started sshd@15-10.0.0.41:22-10.0.0.1:60172.service - OpenSSH per-connection server daemon (10.0.0.1:60172). Jun 21 05:01:51.531472 systemd-logind[1457]: Removed session 15. Jun 21 05:01:51.589238 sshd[2307]: Accepted publickey for core from 10.0.0.1 port 60172 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:51.590775 sshd-session[2307]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:51.595361 systemd-logind[1457]: New session 16 of user core. Jun 21 05:01:51.603556 systemd[1]: Started session-16.scope - Session 16 of User core. Jun 21 05:01:51.662012 sshd[2309]: Connection closed by 10.0.0.1 port 60172 Jun 21 05:01:51.662351 sshd-session[2307]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:51.677157 systemd[1]: sshd@15-10.0.0.41:22-10.0.0.1:60172.service: Deactivated successfully. Jun 21 05:01:51.678827 systemd[1]: session-16.scope: Deactivated successfully. Jun 21 05:01:51.679642 systemd-logind[1457]: Session 16 logged out. Waiting for processes to exit. Jun 21 05:01:51.682547 systemd[1]: Started sshd@16-10.0.0.41:22-10.0.0.1:60178.service - OpenSSH per-connection server daemon (10.0.0.1:60178). Jun 21 05:01:51.683297 systemd-logind[1457]: Removed session 16. Jun 21 05:01:51.735257 sshd[2315]: Accepted publickey for core from 10.0.0.1 port 60178 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:51.736986 sshd-session[2315]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:51.741585 systemd-logind[1457]: New session 17 of user core. Jun 21 05:01:51.755369 systemd[1]: Started session-17.scope - Session 17 of User core. Jun 21 05:01:51.819578 sshd[2317]: Connection closed by 10.0.0.1 port 60178 Jun 21 05:01:51.819902 sshd-session[2315]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:51.839532 systemd[1]: sshd@16-10.0.0.41:22-10.0.0.1:60178.service: Deactivated successfully. Jun 21 05:01:51.841484 systemd[1]: session-17.scope: Deactivated successfully. Jun 21 05:01:51.842336 systemd-logind[1457]: Session 17 logged out. Waiting for processes to exit. Jun 21 05:01:51.845359 systemd[1]: Started sshd@17-10.0.0.41:22-10.0.0.1:60192.service - OpenSSH per-connection server daemon (10.0.0.1:60192). Jun 21 05:01:51.845984 systemd-logind[1457]: Removed session 17. Jun 21 05:01:51.900829 sshd[2330]: Accepted publickey for core from 10.0.0.1 port 60192 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:51.902434 sshd-session[2330]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:51.907775 systemd-logind[1457]: New session 18 of user core. Jun 21 05:01:51.919406 systemd[1]: Started session-18.scope - Session 18 of User core. Jun 21 05:01:51.997773 systemd[1]: var-lib-docker-overlay2-4bf76ce47ee3e5abf3334babbbdc2b5b8d52ecb6fb3c142ae1945f93abc76909\x2dinit-merged.mount: Deactivated successfully. Jun 21 05:01:52.046363 containerd[2030]: time="2025-06-21T05:01:52.046294279Z" level=info msg="connecting to shim d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456" address="unix:///run/containerd/s/d22e4ce5509f3ab2e8883740477f23a24dcb44702d496bdc14b3d109a6c8a38a" namespace=moby protocol=ttrpc version=3 Jun 21 05:01:52.073396 systemd[1]: Started docker-d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456.scope - libcontainer container d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456. Jun 21 05:01:52.087634 systemd-resolved[1348]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 05:01:52.113682 kernel: docker0: port 1(veth1f9154c) entered blocking state Jun 21 05:01:52.113796 kernel: docker0: port 1(veth1f9154c) entered disabled state Jun 21 05:01:52.113819 kernel: veth1f9154c: entered allmulticast mode Jun 21 05:01:52.113848 kernel: veth1f9154c: entered promiscuous mode Jun 21 05:01:52.114590 systemd-networkd[1413]: veth1f9154c: Link UP Jun 21 05:01:52.123529 kernel: eth0: renamed from vethe3fcb0c Jun 21 05:01:52.123571 kernel: docker0: port 1(veth1f9154c) entered blocking state Jun 21 05:01:52.123590 kernel: docker0: port 1(veth1f9154c) entered forwarding state Jun 21 05:01:52.123490 systemd-networkd[1413]: veth1f9154c: Gained carrier Jun 21 05:01:52.124213 systemd-networkd[1413]: docker0: Gained carrier Jun 21 05:01:52.151395 sshd[2332]: Connection closed by 10.0.0.1 port 60192 Jun 21 05:01:52.151728 sshd-session[2330]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:52.159884 systemd[1]: sshd@17-10.0.0.41:22-10.0.0.1:60192.service: Deactivated successfully. Jun 21 05:01:52.161552 systemd[1]: session-18.scope: Deactivated successfully. Jun 21 05:01:52.162337 systemd-logind[1457]: Session 18 logged out. Waiting for processes to exit. Jun 21 05:01:52.164999 systemd[1]: Started sshd@18-10.0.0.41:22-10.0.0.1:60194.service - OpenSSH per-connection server daemon (10.0.0.1:60194). Jun 21 05:01:52.165575 systemd-logind[1457]: Removed session 18. Jun 21 05:01:52.232374 sshd[2402]: Accepted publickey for core from 10.0.0.1 port 60194 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:52.234037 sshd-session[2402]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:52.238981 systemd-logind[1457]: New session 19 of user core. Jun 21 05:01:52.252486 systemd[1]: Started session-19.scope - Session 19 of User core. Jun 21 05:01:52.309207 sshd[2404]: Connection closed by 10.0.0.1 port 60194 Jun 21 05:01:52.309574 sshd-session[2402]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:52.327076 systemd[1]: sshd@18-10.0.0.41:22-10.0.0.1:60194.service: Deactivated successfully. Jun 21 05:01:52.328983 systemd[1]: session-19.scope: Deactivated successfully. Jun 21 05:01:52.329871 systemd-logind[1457]: Session 19 logged out. Waiting for processes to exit. Jun 21 05:01:52.332659 systemd[1]: Started sshd@19-10.0.0.41:22-10.0.0.1:60210.service - OpenSSH per-connection server daemon (10.0.0.1:60210). Jun 21 05:01:52.333457 systemd-logind[1457]: Removed session 19. Jun 21 05:01:52.399743 sshd[2410]: Accepted publickey for core from 10.0.0.1 port 60210 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:52.401313 sshd-session[2410]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:52.406487 systemd-logind[1457]: New session 20 of user core. Jun 21 05:01:52.422527 systemd[1]: Started session-20.scope - Session 20 of User core. Jun 21 05:01:52.476760 sudo[2413]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2030 Jun 21 05:01:52.477178 sudo[2413]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 05:01:52.481096 sudo[2413]: pam_unix(sudo:session): session closed for user root Jun 21 05:01:52.482652 sshd[2412]: Connection closed by 10.0.0.1 port 60210 Jun 21 05:01:52.483345 sshd-session[2410]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:52.486068 dockerd[2077]: time="2025-06-21T05:01:52.486017318Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jun 21 05:01:52.486068 dockerd[2077]: time="2025-06-21T05:01:52.486060289Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jun 21 05:01:52.486431 dockerd[2077]: time="2025-06-21T05:01:52.486098453Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jun 21 05:01:52.486431 dockerd[2077]: time="2025-06-21T05:01:52.486145403Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jun 21 05:01:52.492795 systemd[1]: containerd.service: Deactivated successfully. Jun 21 05:01:52.492944 systemd[1]: containerd.service: Unit process 2349 (containerd-shim) remains running after unit stopped. Jun 21 05:01:52.493328 systemd[1]: containerd.service: Consumed 186ms CPU time, 137.7M memory peak. Jun 21 05:01:52.493887 systemd[1]: sshd@19-10.0.0.41:22-10.0.0.1:60210.service: Deactivated successfully. Jun 21 05:01:52.496237 systemd[1]: session-20.scope: Deactivated successfully. Jun 21 05:01:52.498212 systemd-logind[1457]: Session 20 logged out. Waiting for processes to exit. Jun 21 05:01:52.502997 systemd[1]: Started sshd@20-10.0.0.41:22-10.0.0.1:60214.service - OpenSSH per-connection server daemon (10.0.0.1:60214). Jun 21 05:01:52.503838 systemd-logind[1457]: Removed session 20. Jun 21 05:01:52.568589 sshd[2420]: Accepted publickey for core from 10.0.0.1 port 60214 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:52.570197 sshd-session[2420]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:52.574871 systemd-logind[1457]: New session 21 of user core. Jun 21 05:01:52.588402 systemd[1]: Started session-21.scope - Session 21 of User core. Jun 21 05:01:52.643930 sshd[2422]: Connection closed by 10.0.0.1 port 60214 Jun 21 05:01:52.644283 sshd-session[2420]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:52.648789 systemd[1]: sshd@20-10.0.0.41:22-10.0.0.1:60214.service: Deactivated successfully. Jun 21 05:01:52.651032 systemd[1]: session-21.scope: Deactivated successfully. Jun 21 05:01:52.651876 systemd-logind[1457]: Session 21 logged out. Waiting for processes to exit. Jun 21 05:01:52.653220 systemd-logind[1457]: Removed session 21. Jun 21 05:01:53.386491 systemd-networkd[1413]: veth1f9154c: Gained IPv6LL Jun 21 05:01:57.567379 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Jun 21 05:01:57.567736 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jun 21 05:01:57.567957 dockerd[2077]: time="2025-06-21T05:01:57.567884618Z" level=info msg="Processing signal 'terminated'" Jun 21 05:01:58.656185 systemd[1]: Started sshd@21-10.0.0.41:22-10.0.0.1:37210.service - OpenSSH per-connection server daemon (10.0.0.1:37210). Jun 21 05:01:58.726661 sshd[2428]: Accepted publickey for core from 10.0.0.1 port 37210 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:01:58.728231 sshd-session[2428]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:01:58.732677 systemd-logind[1457]: New session 22 of user core. Jun 21 05:01:58.742373 systemd[1]: Started session-22.scope - Session 22 of User core. Jun 21 05:01:58.799380 sshd[2430]: Connection closed by 10.0.0.1 port 37210 Jun 21 05:01:58.799686 sshd-session[2428]: pam_unix(sshd:session): session closed for user core Jun 21 05:01:58.804623 systemd[1]: sshd@21-10.0.0.41:22-10.0.0.1:37210.service: Deactivated successfully. Jun 21 05:01:58.806514 systemd[1]: session-22.scope: Deactivated successfully. Jun 21 05:01:58.807411 systemd-logind[1457]: Session 22 logged out. Waiting for processes to exit. Jun 21 05:01:58.808790 systemd-logind[1457]: Removed session 22. Jun 21 05:01:59.569287 dockerd[2077]: time="2025-06-21T05:01:59.569192814Z" level=error msg="Error sending stop (signal 15) to container" container=d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456 error="Cannot kill container d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Jun 21 05:01:59.569287 dockerd[2077]: time="2025-06-21T05:01:59.569285230Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456 Jun 21 05:02:00.606290 update_engine[1458]: I20250621 05:02:00.606158 1458 update_attempter.cc:509] Updating boot flags... Jun 21 05:02:04.815798 systemd[1]: Started sshd@22-10.0.0.41:22-10.0.0.1:37216.service - OpenSSH per-connection server daemon (10.0.0.1:37216). Jun 21 05:02:04.870263 sshd[2454]: Accepted publickey for core from 10.0.0.1 port 37216 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:02:04.871575 sshd-session[2454]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:02:04.875764 systemd-logind[1457]: New session 23 of user core. Jun 21 05:02:04.885360 systemd[1]: Started session-23.scope - Session 23 of User core. Jun 21 05:02:04.938385 sshd[2456]: Connection closed by 10.0.0.1 port 37216 Jun 21 05:02:04.938631 sshd-session[2454]: pam_unix(sshd:session): session closed for user core Jun 21 05:02:04.941460 systemd[1]: sshd@22-10.0.0.41:22-10.0.0.1:37216.service: Deactivated successfully. Jun 21 05:02:04.943055 systemd[1]: session-23.scope: Deactivated successfully. Jun 21 05:02:04.943752 systemd-logind[1457]: Session 23 logged out. Waiting for processes to exit. Jun 21 05:02:04.945390 systemd-logind[1457]: Removed session 23. Jun 21 05:02:09.571151 dockerd[2077]: time="2025-06-21T05:02:09.571067193Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456 error="context deadline exceeded" Jun 21 05:02:09.572057 systemd[1]: docker-d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456.scope: Deactivated successfully. Jun 21 05:02:10.956596 systemd[1]: Started sshd@23-10.0.0.41:22-10.0.0.1:41508.service - OpenSSH per-connection server daemon (10.0.0.1:41508). Jun 21 05:02:11.018272 sshd[2462]: Accepted publickey for core from 10.0.0.1 port 41508 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:02:11.019964 sshd-session[2462]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:02:11.024614 systemd-logind[1457]: New session 24 of user core. Jun 21 05:02:11.031357 systemd[1]: Started session-24.scope - Session 24 of User core. Jun 21 05:02:11.087621 sshd[2464]: Connection closed by 10.0.0.1 port 41508 Jun 21 05:02:11.087946 sshd-session[2462]: pam_unix(sshd:session): session closed for user core Jun 21 05:02:11.093111 systemd[1]: sshd@23-10.0.0.41:22-10.0.0.1:41508.service: Deactivated successfully. Jun 21 05:02:11.095636 systemd[1]: session-24.scope: Deactivated successfully. Jun 21 05:02:11.096549 systemd-logind[1457]: Session 24 logged out. Waiting for processes to exit. Jun 21 05:02:11.098259 systemd-logind[1457]: Removed session 24. Jun 21 05:02:12.568415 dockerd[2077]: time="2025-06-21T05:02:12.568347073Z" level=error msg="Force shutdown daemon" Jun 21 05:02:12.568784 dockerd[2077]: time="2025-06-21T05:02:12.568527594Z" level=info msg="Daemon shutdown complete" Jun 21 05:02:12.576340 systemd[1]: docker.service: Deactivated successfully. Jun 21 05:02:12.576690 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jun 21 05:02:12.577212 systemd[1]: docker.socket: Deactivated successfully. Jun 21 05:02:12.577553 systemd[1]: Closed docker.socket - Docker Socket for the API. Jun 21 05:02:12.577605 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jun 21 05:02:12.579209 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 21 05:02:12.579404 systemd[1]: containerd.service: Found left-over process 2349 (containerd-shim) in control group while starting unit. Ignoring. Jun 21 05:02:12.579411 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jun 21 05:02:12.589633 systemd[1]: Starting containerd.service - containerd container runtime... Jun 21 05:02:12.590721 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 21 05:02:12.603444 systemd[1]: containerd.service: Found left-over process 2349 (containerd-shim) in control group while starting unit. Ignoring. Jun 21 05:02:12.603454 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jun 21 05:02:12.608181 (ntainerd)[2475]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 21 05:02:12.623323 containerd[2475]: time="2025-06-21T05:02:12Z" 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 Jun 21 05:02:12.623856 containerd[2475]: time="2025-06-21T05:02:12.623815026Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jun 21 05:02:12.632066 containerd[2475]: time="2025-06-21T05:02:12.632016435Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.412µs" Jun 21 05:02:12.632066 containerd[2475]: time="2025-06-21T05:02:12.632056611Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jun 21 05:02:12.632132 containerd[2475]: time="2025-06-21T05:02:12.632079544Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jun 21 05:02:12.632132 containerd[2475]: time="2025-06-21T05:02:12.632111565Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jun 21 05:02:12.632132 containerd[2475]: time="2025-06-21T05:02:12.632126042Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jun 21 05:02:12.632396 containerd[2475]: time="2025-06-21T05:02:12.632369511Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632431 containerd[2475]: time="2025-06-21T05:02:12.632407382Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632431 containerd[2475]: time="2025-06-21T05:02:12.632419275Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632761 containerd[2475]: time="2025-06-21T05:02:12.632731704Z" 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 Jun 21 05:02:12.632761 containerd[2475]: time="2025-06-21T05:02:12.632752274Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632813 containerd[2475]: time="2025-06-21T05:02:12.632764226Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632813 containerd[2475]: time="2025-06-21T05:02:12.632775056Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632813 containerd[2475]: time="2025-06-21T05:02:12.632805043Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632919 containerd[2475]: time="2025-06-21T05:02:12.632894211Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 05:02:12.632947 containerd[2475]: time="2025-06-21T05:02:12.632924167Z" 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 Jun 21 05:02:12.632947 containerd[2475]: time="2025-06-21T05:02:12.632935799Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jun 21 05:02:12.633015 containerd[2475]: time="2025-06-21T05:02:12.632980343Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jun 21 05:02:12.633288 containerd[2475]: time="2025-06-21T05:02:12.633260191Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jun 21 05:02:12.633330 containerd[2475]: time="2025-06-21T05:02:12.633288204Z" level=info msg="metadata content store policy set" policy=shared Jun 21 05:02:12.633478 containerd[2475]: time="2025-06-21T05:02:12.633447415Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jun 21 05:02:12.633514 containerd[2475]: time="2025-06-21T05:02:12.633478543Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jun 21 05:02:12.633514 containerd[2475]: time="2025-06-21T05:02:12.633494313Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jun 21 05:02:12.633514 containerd[2475]: time="2025-06-21T05:02:12.633507127Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jun 21 05:02:12.633604 containerd[2475]: time="2025-06-21T05:02:12.633520612Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jun 21 05:02:12.633604 containerd[2475]: time="2025-06-21T05:02:12.633534999Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jun 21 05:02:12.633604 containerd[2475]: time="2025-06-21T05:02:12.633549447Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jun 21 05:02:12.634210 containerd[2475]: time="2025-06-21T05:02:12.633895960Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jun 21 05:02:12.634210 containerd[2475]: time="2025-06-21T05:02:12.633946536Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jun 21 05:02:12.634210 containerd[2475]: time="2025-06-21T05:02:12.633978646Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jun 21 05:02:12.634210 containerd[2475]: time="2025-06-21T05:02:12.634000307Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jun 21 05:02:12.634210 containerd[2475]: time="2025-06-21T05:02:12.634025805Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jun 21 05:02:12.634466 containerd[2475]: time="2025-06-21T05:02:12.634426421Z" level=info msg="connecting to shim d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456" address="unix:///run/containerd/s/d22e4ce5509f3ab2e8883740477f23a24dcb44702d496bdc14b3d109a6c8a38a" namespace=moby protocol=ttrpc version=3 Jun 21 05:02:12.642773 containerd[2475]: time="2025-06-21T05:02:12.642743448Z" level=info msg="cleaning leaked shim process" id=d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456 namespace=moby Jun 21 05:02:12.652634 containerd[2475]: time="2025-06-21T05:02:12.652572567Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jun 21 05:02:12.652955 containerd[2475]: time="2025-06-21T05:02:12.652928619Z" level=info msg="shim disconnected" id=d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456 namespace=moby Jun 21 05:02:12.652955 containerd[2475]: time="2025-06-21T05:02:12.652965569Z" level=warning msg="cleaning up after shim disconnected" id=d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456 namespace=moby Jun 21 05:02:12.653058 containerd[2475]: time="2025-06-21T05:02:12.652975557Z" level=info msg="cleaning up dead shim" namespace=moby Jun 21 05:02:12.665114 containerd[2475]: time="2025-06-21T05:02:12.665050353Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jun 21 05:02:12.665203 containerd[2475]: time="2025-06-21T05:02:12.665171842Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jun 21 05:02:12.665203 containerd[2475]: time="2025-06-21T05:02:12.665195387Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jun 21 05:02:12.665275 containerd[2475]: time="2025-06-21T05:02:12.665216547Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jun 21 05:02:12.665275 containerd[2475]: time="2025-06-21T05:02:12.665227698Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jun 21 05:02:12.665275 containerd[2475]: time="2025-06-21T05:02:12.665239430Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jun 21 05:02:12.665275 containerd[2475]: time="2025-06-21T05:02:12.665271530Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665282461Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665292540Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665303540Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665313209Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665323930Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665381167Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jun 21 05:02:12.665393 containerd[2475]: time="2025-06-21T05:02:12.665392919Z" level=info msg="Start snapshots syncer" Jun 21 05:02:12.665584 containerd[2475]: time="2025-06-21T05:02:12.665425371Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jun 21 05:02:12.665666 containerd[2475]: time="2025-06-21T05:02:12.665622332Z" 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\"}" Jun 21 05:02:12.665762 containerd[2475]: time="2025-06-21T05:02:12.665674110Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jun 21 05:02:12.665762 containerd[2475]: time="2025-06-21T05:02:12.665743100Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jun 21 05:02:12.665824 containerd[2475]: time="2025-06-21T05:02:12.665778947Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jun 21 05:02:12.665824 containerd[2475]: time="2025-06-21T05:02:12.665804415Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jun 21 05:02:12.665824 containerd[2475]: time="2025-06-21T05:02:12.665814425Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jun 21 05:02:12.665824 containerd[2475]: time="2025-06-21T05:02:12.665822981Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jun 21 05:02:12.665928 containerd[2475]: time="2025-06-21T05:02:12.665834843Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jun 21 05:02:12.665928 containerd[2475]: time="2025-06-21T05:02:12.665845904Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jun 21 05:02:12.665928 containerd[2475]: time="2025-06-21T05:02:12.665855502Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jun 21 05:02:12.665928 containerd[2475]: time="2025-06-21T05:02:12.665882272Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jun 21 05:02:12.665928 containerd[2475]: time="2025-06-21T05:02:12.665892381Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jun 21 05:02:12.665928 containerd[2475]: time="2025-06-21T05:02:12.665901959Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665932828Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665946664Z" 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 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665955460Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665971721Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665979616Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665988823Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.665999072Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.666020864Z" level=info msg="runtime interface created" Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.666026344Z" level=info msg="created NRI interface" Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.666045130Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.666054988Z" level=info msg="Connect containerd service" Jun 21 05:02:12.666101 containerd[2475]: time="2025-06-21T05:02:12.666081598Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 21 05:02:12.666560 containerd[2475]: time="2025-06-21T05:02:12.666523833Z" 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" Jun 21 05:02:12.678045 containerd[2475]: time="2025-06-21T05:02:12.677995059Z" level=info msg="Start subscribing containerd event" Jun 21 05:02:12.678157 containerd[2475]: time="2025-06-21T05:02:12.678060854Z" level=info msg="Start recovering state" Jun 21 05:02:12.678204 containerd[2475]: time="2025-06-21T05:02:12.678151054Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 21 05:02:12.678240 containerd[2475]: time="2025-06-21T05:02:12.678214824Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 21 05:02:12.678240 containerd[2475]: time="2025-06-21T05:02:12.678155412Z" level=info msg="Start event monitor" Jun 21 05:02:12.678321 containerd[2475]: time="2025-06-21T05:02:12.678239550Z" level=info msg="Start cni network conf syncer for default" Jun 21 05:02:12.678321 containerd[2475]: time="2025-06-21T05:02:12.678266091Z" level=info msg="Start streaming server" Jun 21 05:02:12.678321 containerd[2475]: time="2025-06-21T05:02:12.678276420Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jun 21 05:02:12.678321 containerd[2475]: time="2025-06-21T05:02:12.678284676Z" level=info msg="runtime interface starting up..." Jun 21 05:02:12.678321 containerd[2475]: time="2025-06-21T05:02:12.678291438Z" level=info msg="starting plugins..." Jun 21 05:02:12.678321 containerd[2475]: time="2025-06-21T05:02:12.678302920Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jun 21 05:02:12.678475 containerd[2475]: time="2025-06-21T05:02:12.678432334Z" level=info msg="containerd successfully booted in 0.055310s" Jun 21 05:02:12.678547 systemd[1]: Started containerd.service - containerd container runtime. Jun 21 05:02:12.681106 systemd[1]: Starting docker.service - Docker Application Container Engine... Jun 21 05:02:12.704547 (dockerd)[2524]: 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 Jun 21 05:02:12.736276 dockerd[2524]: time="2025-06-21T05:02:12.736175489Z" level=info msg="Starting up" Jun 21 05:02:12.736860 dockerd[2524]: time="2025-06-21T05:02:12.736816548Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jun 21 05:02:12.769268 dockerd[2524]: time="2025-06-21T05:02:12.769171405Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jun 21 05:02:12.792340 dockerd[2524]: time="2025-06-21T05:02:12.792285953Z" level=info msg="Loading containers: start." Jun 21 05:02:12.806909 systemd[1]: var-lib-docker-overlay2-4bf76ce47ee3e5abf3334babbbdc2b5b8d52ecb6fb3c142ae1945f93abc76909-merged.mount: Deactivated successfully. Jun 21 05:02:13.181728 systemd-networkd[1413]: veth1f9154c: Link DOWN Jun 21 05:02:13.181738 systemd-networkd[1413]: veth1f9154c: Lost carrier Jun 21 05:02:13.183306 kernel: docker0: port 1(veth1f9154c) entered disabled state Jun 21 05:02:13.183390 kernel: veth1f9154c (unregistering): left allmulticast mode Jun 21 05:02:13.184892 kernel: veth1f9154c (unregistering): left promiscuous mode Jun 21 05:02:13.184959 kernel: docker0: port 1(veth1f9154c) entered disabled state Jun 21 05:02:13.185642 systemd-networkd[1413]: docker0: Lost carrier Jun 21 05:02:13.186925 dockerd[2524]: time="2025-06-21T05:02:13.186880906Z" level=info msg="Removing stale sandbox 730998b548a3111a2f30c693b8ea2211e02163ff713f02f1efe2f6d53495a66a (d5eca1cd229e8f4fa366180d589a875944eb55054ad1abe4b2dc7e7ee8b54456)" Jun 21 05:02:13.192457 dockerd[2524]: time="2025-06-21T05:02:13.192429338Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jun 21 05:02:13.192506 dockerd[2524]: time="2025-06-21T05:02:13.192467560Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 7b0c1a329589beaffde5dcb25953635184c1ba5c52515a1c07b14fbe51224421 85b31b109c64ad45bda9541f9dcb4194e17a98551871c00bee6fbb0ac79837ff], retrying...." Jun 21 05:02:13.417440 dockerd[2524]: time="2025-06-21T05:02:13.417379645Z" level=warning msg="error locating sandbox id 8d46bc085d8a67b6c3da2489024e7297b4867511d7b33c2892db86587e002b0d: sandbox 8d46bc085d8a67b6c3da2489024e7297b4867511d7b33c2892db86587e002b0d not found" Jun 21 05:02:13.417440 dockerd[2524]: time="2025-06-21T05:02:13.417426463Z" level=warning msg="error locating sandbox id 730998b548a3111a2f30c693b8ea2211e02163ff713f02f1efe2f6d53495a66a: sandbox 730998b548a3111a2f30c693b8ea2211e02163ff713f02f1efe2f6d53495a66a not found" Jun 21 05:02:13.417611 dockerd[2524]: time="2025-06-21T05:02:13.417559053Z" level=info msg="Loading containers: done." Jun 21 05:02:13.432328 dockerd[2524]: time="2025-06-21T05:02:13.432178979Z" 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 Jun 21 05:02:13.432328 dockerd[2524]: time="2025-06-21T05:02:13.432307482Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jun 21 05:02:13.432546 dockerd[2524]: time="2025-06-21T05:02:13.432362586Z" level=info msg="Initializing buildkit" Jun 21 05:02:13.451003 dockerd[2524]: time="2025-06-21T05:02:13.450951066Z" level=info msg="Completed buildkit initialization" Jun 21 05:02:13.455899 dockerd[2524]: time="2025-06-21T05:02:13.455867205Z" level=info msg="Daemon has completed initialization" Jun 21 05:02:13.456045 dockerd[2524]: time="2025-06-21T05:02:13.455968025Z" level=info msg="API listen on /run/docker.sock" Jun 21 05:02:13.456091 systemd[1]: Started docker.service - Docker Application Container Engine. Jun 21 05:02:13.757801 systemd[1]: run-docker-netns-730998b548a3.mount: Deactivated successfully. Jun 21 05:02:17.102585 systemd[1]: Started sshd@24-10.0.0.41:22-10.0.0.1:41654.service - OpenSSH per-connection server daemon (10.0.0.1:41654). Jun 21 05:02:17.161222 sshd[2745]: Accepted publickey for core from 10.0.0.1 port 41654 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:02:17.163180 sshd-session[2745]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:02:17.168257 systemd-logind[1457]: New session 25 of user core. Jun 21 05:02:17.184522 systemd[1]: Started session-25.scope - Session 25 of User core. Jun 21 05:02:17.241388 sshd[2747]: Connection closed by 10.0.0.1 port 41654 Jun 21 05:02:17.241682 sshd-session[2745]: pam_unix(sshd:session): session closed for user core Jun 21 05:02:17.260663 systemd[1]: sshd@24-10.0.0.41:22-10.0.0.1:41654.service: Deactivated successfully. Jun 21 05:02:17.262883 systemd[1]: session-25.scope: Deactivated successfully. Jun 21 05:02:17.263807 systemd-logind[1457]: Session 25 logged out. Waiting for processes to exit. Jun 21 05:02:17.266926 systemd[1]: Started sshd@25-10.0.0.41:22-10.0.0.1:41658.service - OpenSSH per-connection server daemon (10.0.0.1:41658). Jun 21 05:02:17.267650 systemd-logind[1457]: Removed session 25. Jun 21 05:02:17.321452 sshd[2753]: Accepted publickey for core from 10.0.0.1 port 41658 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:02:17.322925 sshd-session[2753]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:02:17.327962 systemd-logind[1457]: New session 26 of user core. Jun 21 05:02:17.337491 systemd[1]: Started session-26.scope - Session 26 of User core. Jun 21 05:02:17.396915 sshd[2755]: Connection closed by 10.0.0.1 port 41658 Jun 21 05:02:17.397125 sshd-session[2753]: pam_unix(sshd:session): session closed for user core Jun 21 05:02:17.409018 systemd[1]: sshd@25-10.0.0.41:22-10.0.0.1:41658.service: Deactivated successfully. Jun 21 05:02:17.411427 systemd[1]: session-26.scope: Deactivated successfully. Jun 21 05:02:17.412303 systemd-logind[1457]: Session 26 logged out. Waiting for processes to exit. Jun 21 05:02:17.416090 systemd[1]: Started sshd@26-10.0.0.41:22-10.0.0.1:41660.service - OpenSSH per-connection server daemon (10.0.0.1:41660). Jun 21 05:02:17.416876 systemd-logind[1457]: Removed session 26. Jun 21 05:02:17.466872 sshd[2761]: Accepted publickey for core from 10.0.0.1 port 41660 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:02:17.468700 sshd-session[2761]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:02:17.474614 systemd-logind[1457]: New session 27 of user core. Jun 21 05:02:17.485485 systemd[1]: Started session-27.scope - Session 27 of User core. Jun 21 05:02:17.551090 sshd[2763]: Connection closed by 10.0.0.1 port 41660 Jun 21 05:02:17.551601 sshd-session[2761]: pam_unix(sshd:session): session closed for user core Jun 21 05:02:17.562557 systemd[1]: sshd@26-10.0.0.41:22-10.0.0.1:41660.service: Deactivated successfully. Jun 21 05:02:17.564644 systemd[1]: session-27.scope: Deactivated successfully. Jun 21 05:02:17.565522 systemd-logind[1457]: Session 27 logged out. Waiting for processes to exit. Jun 21 05:02:17.569026 systemd[1]: Started sshd@27-10.0.0.41:22-10.0.0.1:41672.service - OpenSSH per-connection server daemon (10.0.0.1:41672). Jun 21 05:02:17.569810 systemd-logind[1457]: Removed session 27. Jun 21 05:02:17.621928 sshd[2776]: Accepted publickey for core from 10.0.0.1 port 41672 ssh2: RSA SHA256:UcUMoAuz6+rdewXVNINfGwLYEuDJpooqWrO3V6JQU60 Jun 21 05:02:17.623624 sshd-session[2776]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 05:02:17.630495 systemd-logind[1457]: New session 28 of user core. Jun 21 05:02:17.644398 systemd[1]: Started session-28.scope - Session 28 of User core. Jun 21 05:02:17.720069 systemd[1]: var-lib-docker-overlay2-8503009f3c1b8aab22f6668fa6ac8b3757fb616611270f4880e1308024550bb1\x2dinit-merged.mount: Deactivated successfully. Jun 21 05:02:17.760455 containerd[2475]: time="2025-06-21T05:02:17.760402576Z" level=info msg="connecting to shim 7c6838aff4f61ef84057533193cb646041cba3d3cb4a6a6b7f4ce1d9ff42209c" address="unix:///run/containerd/s/4a4db12572e6d9203aad57a71acbe836a2d1db22ab8c87f6cb2a0e496697fbec" namespace=moby protocol=ttrpc version=3 Jun 21 05:02:17.793395 systemd[1]: Started docker-7c6838aff4f61ef84057533193cb646041cba3d3cb4a6a6b7f4ce1d9ff42209c.scope - libcontainer container 7c6838aff4f61ef84057533193cb646041cba3d3cb4a6a6b7f4ce1d9ff42209c. Jun 21 05:02:17.808949 systemd-resolved[1348]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 05:02:17.838840 kernel: docker0: port 1(vethbd261a4) entered blocking state Jun 21 05:02:17.838989 kernel: docker0: port 1(vethbd261a4) entered disabled state Jun 21 05:02:17.839011 kernel: vethbd261a4: entered allmulticast mode Jun 21 05:02:17.839031 kernel: vethbd261a4: entered promiscuous mode Jun 21 05:02:17.839753 systemd-networkd[1413]: vethbd261a4: Link UP Jun 21 05:02:17.849277 kernel: eth0: renamed from veth4847e52 Jun 21 05:02:17.853100 kernel: docker0: port 1(vethbd261a4) entered blocking state Jun 21 05:02:17.853207 kernel: docker0: port 1(vethbd261a4) entered forwarding state Jun 21 05:02:17.853141 systemd-networkd[1413]: vethbd261a4: Gained carrier Jun 21 05:02:17.853953 systemd-networkd[1413]: docker0: Gained carrier Jun 21 05:02:17.884736 sshd[2778]: Connection closed by 10.0.0.1 port 41672 Jun 21 05:02:17.885084 sshd-session[2776]: pam_unix(sshd:session): session closed for user core Jun 21 05:02:17.889911 systemd[1]: sshd@27-10.0.0.41:22-10.0.0.1:41672.service: Deactivated successfully. Jun 21 05:02:17.892267 systemd[1]: session-28.scope: Deactivated successfully. Jun 21 05:02:17.894022 systemd-logind[1457]: Session 28 logged out. Waiting for processes to exit. Jun 21 05:02:17.895821 systemd-logind[1457]: Removed session 28.