Sep 16 04:49:15.862427 kernel: Linux version 6.12.47-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Tue Sep 16 03:05:42 -00 2025 Sep 16 04:49:15.862466 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=0b876f86a632750e9937176808a48c2452d5168964273bcfc3c72f2a26140c06 Sep 16 04:49:15.862478 kernel: BIOS-provided physical RAM map: Sep 16 04:49:15.862487 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Sep 16 04:49:15.862495 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Sep 16 04:49:15.862504 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Sep 16 04:49:15.862514 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Sep 16 04:49:15.862523 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Sep 16 04:49:15.862538 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Sep 16 04:49:15.862546 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Sep 16 04:49:15.862555 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 16 04:49:15.862564 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Sep 16 04:49:15.862573 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Sep 16 04:49:15.862581 kernel: NX (Execute Disable) protection: active Sep 16 04:49:15.862595 kernel: APIC: Static calls initialized Sep 16 04:49:15.862605 kernel: SMBIOS 2.8 present. Sep 16 04:49:15.862618 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Sep 16 04:49:15.862627 kernel: DMI: Memory slots populated: 1/1 Sep 16 04:49:15.862636 kernel: Hypervisor detected: KVM Sep 16 04:49:15.862646 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 16 04:49:15.862655 kernel: kvm-clock: using sched offset of 5780244408 cycles Sep 16 04:49:15.862665 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 16 04:49:15.862675 kernel: tsc: Detected 2794.750 MHz processor Sep 16 04:49:15.862688 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 16 04:49:15.862699 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 16 04:49:15.862708 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Sep 16 04:49:15.862718 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Sep 16 04:49:15.862728 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 16 04:49:15.862737 kernel: Using GB pages for direct mapping Sep 16 04:49:15.862747 kernel: ACPI: Early table checksum verification disabled Sep 16 04:49:15.862756 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Sep 16 04:49:15.862766 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862779 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862789 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862799 kernel: ACPI: FACS 0x000000009CFE0000 000040 Sep 16 04:49:15.862809 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862819 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862829 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862839 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 16 04:49:15.862848 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Sep 16 04:49:15.862865 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Sep 16 04:49:15.862875 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Sep 16 04:49:15.862885 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Sep 16 04:49:15.862895 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Sep 16 04:49:15.862905 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Sep 16 04:49:15.862915 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Sep 16 04:49:15.862928 kernel: No NUMA configuration found Sep 16 04:49:15.862938 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Sep 16 04:49:15.862948 kernel: NODE_DATA(0) allocated [mem 0x9cfd4dc0-0x9cfdbfff] Sep 16 04:49:15.862958 kernel: Zone ranges: Sep 16 04:49:15.862968 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 16 04:49:15.862978 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Sep 16 04:49:15.862988 kernel: Normal empty Sep 16 04:49:15.862997 kernel: Device empty Sep 16 04:49:15.863007 kernel: Movable zone start for each node Sep 16 04:49:15.863017 kernel: Early memory node ranges Sep 16 04:49:15.863029 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Sep 16 04:49:15.863039 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Sep 16 04:49:15.863049 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Sep 16 04:49:15.863059 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 16 04:49:15.863069 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Sep 16 04:49:15.863079 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Sep 16 04:49:15.863089 kernel: ACPI: PM-Timer IO Port: 0x608 Sep 16 04:49:15.863104 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 16 04:49:15.863114 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 16 04:49:15.863127 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 16 04:49:15.863137 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 16 04:49:15.863150 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 16 04:49:15.863160 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 16 04:49:15.863211 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 16 04:49:15.863219 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 16 04:49:15.863226 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 16 04:49:15.863234 kernel: TSC deadline timer available Sep 16 04:49:15.863241 kernel: CPU topo: Max. logical packages: 1 Sep 16 04:49:15.863252 kernel: CPU topo: Max. logical dies: 1 Sep 16 04:49:15.863259 kernel: CPU topo: Max. dies per package: 1 Sep 16 04:49:15.863267 kernel: CPU topo: Max. threads per core: 1 Sep 16 04:49:15.863274 kernel: CPU topo: Num. cores per package: 4 Sep 16 04:49:15.863282 kernel: CPU topo: Num. threads per package: 4 Sep 16 04:49:15.863289 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Sep 16 04:49:15.863296 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Sep 16 04:49:15.863304 kernel: kvm-guest: KVM setup pv remote TLB flush Sep 16 04:49:15.863311 kernel: kvm-guest: setup PV sched yield Sep 16 04:49:15.863319 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Sep 16 04:49:15.863328 kernel: Booting paravirtualized kernel on KVM Sep 16 04:49:15.863336 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 16 04:49:15.863344 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Sep 16 04:49:15.863351 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Sep 16 04:49:15.863359 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Sep 16 04:49:15.863366 kernel: pcpu-alloc: [0] 0 1 2 3 Sep 16 04:49:15.863373 kernel: kvm-guest: PV spinlocks enabled Sep 16 04:49:15.863381 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 16 04:49:15.863401 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=0b876f86a632750e9937176808a48c2452d5168964273bcfc3c72f2a26140c06 Sep 16 04:49:15.863413 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 16 04:49:15.863437 kernel: random: crng init done Sep 16 04:49:15.863447 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 16 04:49:15.863455 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 16 04:49:15.863462 kernel: Fallback order for Node 0: 0 Sep 16 04:49:15.863470 kernel: Built 1 zonelists, mobility grouping on. Total pages: 642938 Sep 16 04:49:15.863477 kernel: Policy zone: DMA32 Sep 16 04:49:15.863485 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 16 04:49:15.863495 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 16 04:49:15.863503 kernel: ftrace: allocating 40125 entries in 157 pages Sep 16 04:49:15.863510 kernel: ftrace: allocated 157 pages with 5 groups Sep 16 04:49:15.863518 kernel: Dynamic Preempt: voluntary Sep 16 04:49:15.863531 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 16 04:49:15.863539 kernel: rcu: RCU event tracing is enabled. Sep 16 04:49:15.863547 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 16 04:49:15.863554 kernel: Trampoline variant of Tasks RCU enabled. Sep 16 04:49:15.863565 kernel: Rude variant of Tasks RCU enabled. Sep 16 04:49:15.863575 kernel: Tracing variant of Tasks RCU enabled. Sep 16 04:49:15.863583 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 16 04:49:15.863591 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 16 04:49:15.863598 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 16 04:49:15.863606 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 16 04:49:15.863614 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 16 04:49:15.863621 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Sep 16 04:49:15.863629 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 16 04:49:15.863645 kernel: Console: colour VGA+ 80x25 Sep 16 04:49:15.863653 kernel: printk: legacy console [ttyS0] enabled Sep 16 04:49:15.863660 kernel: ACPI: Core revision 20240827 Sep 16 04:49:15.863668 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 16 04:49:15.863678 kernel: APIC: Switch to symmetric I/O mode setup Sep 16 04:49:15.863686 kernel: x2apic enabled Sep 16 04:49:15.863694 kernel: APIC: Switched APIC routing to: physical x2apic Sep 16 04:49:15.863704 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Sep 16 04:49:15.863712 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Sep 16 04:49:15.863722 kernel: kvm-guest: setup PV IPIs Sep 16 04:49:15.863730 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 16 04:49:15.863738 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Sep 16 04:49:15.863746 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Sep 16 04:49:15.863754 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 16 04:49:15.863761 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Sep 16 04:49:15.863769 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Sep 16 04:49:15.863777 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 16 04:49:15.863787 kernel: Spectre V2 : Mitigation: Retpolines Sep 16 04:49:15.863794 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 16 04:49:15.863802 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Sep 16 04:49:15.863810 kernel: active return thunk: retbleed_return_thunk Sep 16 04:49:15.863817 kernel: RETBleed: Mitigation: untrained return thunk Sep 16 04:49:15.863825 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Sep 16 04:49:15.863833 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Sep 16 04:49:15.863841 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Sep 16 04:49:15.863850 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Sep 16 04:49:15.863860 kernel: active return thunk: srso_return_thunk Sep 16 04:49:15.863868 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Sep 16 04:49:15.863879 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 16 04:49:15.863889 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 16 04:49:15.863900 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 16 04:49:15.863910 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 16 04:49:15.863920 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Sep 16 04:49:15.863931 kernel: Freeing SMP alternatives memory: 32K Sep 16 04:49:15.863976 kernel: pid_max: default: 32768 minimum: 301 Sep 16 04:49:15.863990 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 16 04:49:15.864000 kernel: landlock: Up and running. Sep 16 04:49:15.864010 kernel: SELinux: Initializing. Sep 16 04:49:15.864024 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 16 04:49:15.864034 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 16 04:49:15.864044 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Sep 16 04:49:15.864054 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Sep 16 04:49:15.864064 kernel: ... version: 0 Sep 16 04:49:15.864074 kernel: ... bit width: 48 Sep 16 04:49:15.864087 kernel: ... generic registers: 6 Sep 16 04:49:15.864097 kernel: ... value mask: 0000ffffffffffff Sep 16 04:49:15.864107 kernel: ... max period: 00007fffffffffff Sep 16 04:49:15.864117 kernel: ... fixed-purpose events: 0 Sep 16 04:49:15.864127 kernel: ... event mask: 000000000000003f Sep 16 04:49:15.864137 kernel: signal: max sigframe size: 1776 Sep 16 04:49:15.864147 kernel: rcu: Hierarchical SRCU implementation. Sep 16 04:49:15.864157 kernel: rcu: Max phase no-delay instances is 400. Sep 16 04:49:15.864195 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 16 04:49:15.864209 kernel: smp: Bringing up secondary CPUs ... Sep 16 04:49:15.864219 kernel: smpboot: x86: Booting SMP configuration: Sep 16 04:49:15.864229 kernel: .... node #0, CPUs: #1 #2 #3 Sep 16 04:49:15.864239 kernel: smp: Brought up 1 node, 4 CPUs Sep 16 04:49:15.864249 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Sep 16 04:49:15.864259 kernel: Memory: 2428916K/2571752K available (14336K kernel code, 2432K rwdata, 9992K rodata, 54096K init, 2868K bss, 136904K reserved, 0K cma-reserved) Sep 16 04:49:15.864269 kernel: devtmpfs: initialized Sep 16 04:49:15.864280 kernel: x86/mm: Memory block size: 128MB Sep 16 04:49:15.864290 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 16 04:49:15.864304 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 16 04:49:15.864314 kernel: pinctrl core: initialized pinctrl subsystem Sep 16 04:49:15.864324 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 16 04:49:15.864335 kernel: audit: initializing netlink subsys (disabled) Sep 16 04:49:15.864345 kernel: audit: type=2000 audit(1757998152.480:1): state=initialized audit_enabled=0 res=1 Sep 16 04:49:15.864355 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 16 04:49:15.864364 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 16 04:49:15.864374 kernel: cpuidle: using governor menu Sep 16 04:49:15.864384 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 16 04:49:15.864397 kernel: dca service started, version 1.12.1 Sep 16 04:49:15.864429 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Sep 16 04:49:15.864450 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Sep 16 04:49:15.864460 kernel: PCI: Using configuration type 1 for base access Sep 16 04:49:15.864469 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 16 04:49:15.864480 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 16 04:49:15.864489 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 16 04:49:15.864504 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 16 04:49:15.864515 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 16 04:49:15.864528 kernel: ACPI: Added _OSI(Module Device) Sep 16 04:49:15.864538 kernel: ACPI: Added _OSI(Processor Device) Sep 16 04:49:15.864548 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 16 04:49:15.864557 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 16 04:49:15.864567 kernel: ACPI: Interpreter enabled Sep 16 04:49:15.864576 kernel: ACPI: PM: (supports S0 S3 S5) Sep 16 04:49:15.864586 kernel: ACPI: Using IOAPIC for interrupt routing Sep 16 04:49:15.864596 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 16 04:49:15.864606 kernel: PCI: Using E820 reservations for host bridge windows Sep 16 04:49:15.864619 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Sep 16 04:49:15.864629 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 16 04:49:15.864877 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 16 04:49:15.865029 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Sep 16 04:49:15.865153 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Sep 16 04:49:15.865180 kernel: PCI host bridge to bus 0000:00 Sep 16 04:49:15.865331 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 16 04:49:15.865450 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 16 04:49:15.865560 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 16 04:49:15.865669 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Sep 16 04:49:15.865778 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Sep 16 04:49:15.865894 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Sep 16 04:49:15.866014 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 16 04:49:15.866200 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Sep 16 04:49:15.866350 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Sep 16 04:49:15.866473 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Sep 16 04:49:15.866608 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Sep 16 04:49:15.866728 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Sep 16 04:49:15.866848 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 16 04:49:15.867012 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 16 04:49:15.867146 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Sep 16 04:49:15.867302 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Sep 16 04:49:15.867434 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Sep 16 04:49:15.867612 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Sep 16 04:49:15.867767 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Sep 16 04:49:15.867938 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Sep 16 04:49:15.868098 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Sep 16 04:49:15.868296 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Sep 16 04:49:15.868423 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Sep 16 04:49:15.868543 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Sep 16 04:49:15.868663 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Sep 16 04:49:15.868783 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Sep 16 04:49:15.868931 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Sep 16 04:49:15.869062 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Sep 16 04:49:15.869244 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Sep 16 04:49:15.869374 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Sep 16 04:49:15.869494 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Sep 16 04:49:15.869631 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Sep 16 04:49:15.869757 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Sep 16 04:49:15.869771 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Sep 16 04:49:15.869786 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 16 04:49:15.869794 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 16 04:49:15.869802 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Sep 16 04:49:15.869811 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Sep 16 04:49:15.869819 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Sep 16 04:49:15.869827 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Sep 16 04:49:15.869835 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Sep 16 04:49:15.869843 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Sep 16 04:49:15.869851 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Sep 16 04:49:15.869861 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Sep 16 04:49:15.869870 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Sep 16 04:49:15.869880 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Sep 16 04:49:15.869891 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Sep 16 04:49:15.869902 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Sep 16 04:49:15.869913 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Sep 16 04:49:15.869924 kernel: iommu: Default domain type: Translated Sep 16 04:49:15.869935 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 16 04:49:15.869946 kernel: PCI: Using ACPI for IRQ routing Sep 16 04:49:15.869961 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 16 04:49:15.869971 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Sep 16 04:49:15.869979 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Sep 16 04:49:15.870132 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Sep 16 04:49:15.870296 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Sep 16 04:49:15.870418 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 16 04:49:15.870429 kernel: vgaarb: loaded Sep 16 04:49:15.870437 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 16 04:49:15.870450 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 16 04:49:15.870458 kernel: clocksource: Switched to clocksource kvm-clock Sep 16 04:49:15.870466 kernel: VFS: Disk quotas dquot_6.6.0 Sep 16 04:49:15.870474 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 16 04:49:15.870482 kernel: pnp: PnP ACPI init Sep 16 04:49:15.870629 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Sep 16 04:49:15.870641 kernel: pnp: PnP ACPI: found 6 devices Sep 16 04:49:15.870650 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 16 04:49:15.870661 kernel: NET: Registered PF_INET protocol family Sep 16 04:49:15.870669 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 16 04:49:15.870677 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 16 04:49:15.870685 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 16 04:49:15.870694 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 16 04:49:15.870702 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 16 04:49:15.870710 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 16 04:49:15.870718 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 16 04:49:15.870726 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 16 04:49:15.870736 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 16 04:49:15.870744 kernel: NET: Registered PF_XDP protocol family Sep 16 04:49:15.870866 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 16 04:49:15.870984 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 16 04:49:15.871096 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 16 04:49:15.871241 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Sep 16 04:49:15.871355 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Sep 16 04:49:15.871466 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Sep 16 04:49:15.871476 kernel: PCI: CLS 0 bytes, default 64 Sep 16 04:49:15.871489 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Sep 16 04:49:15.871497 kernel: Initialise system trusted keyrings Sep 16 04:49:15.871505 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 16 04:49:15.871513 kernel: Key type asymmetric registered Sep 16 04:49:15.871521 kernel: Asymmetric key parser 'x509' registered Sep 16 04:49:15.871529 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 16 04:49:15.871537 kernel: io scheduler mq-deadline registered Sep 16 04:49:15.871545 kernel: io scheduler kyber registered Sep 16 04:49:15.871553 kernel: io scheduler bfq registered Sep 16 04:49:15.871563 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 16 04:49:15.871572 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Sep 16 04:49:15.871580 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Sep 16 04:49:15.871588 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Sep 16 04:49:15.871596 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 16 04:49:15.871604 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 16 04:49:15.871612 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 16 04:49:15.871620 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 16 04:49:15.871628 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 16 04:49:15.871769 kernel: rtc_cmos 00:04: RTC can wake from S4 Sep 16 04:49:15.871781 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Sep 16 04:49:15.871904 kernel: rtc_cmos 00:04: registered as rtc0 Sep 16 04:49:15.872022 kernel: rtc_cmos 00:04: setting system clock to 2025-09-16T04:49:15 UTC (1757998155) Sep 16 04:49:15.872162 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Sep 16 04:49:15.872205 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Sep 16 04:49:15.872214 kernel: NET: Registered PF_INET6 protocol family Sep 16 04:49:15.872226 kernel: Segment Routing with IPv6 Sep 16 04:49:15.872235 kernel: In-situ OAM (IOAM) with IPv6 Sep 16 04:49:15.872243 kernel: NET: Registered PF_PACKET protocol family Sep 16 04:49:15.872252 kernel: Key type dns_resolver registered Sep 16 04:49:15.872260 kernel: IPI shorthand broadcast: enabled Sep 16 04:49:15.872268 kernel: sched_clock: Marking stable (3265004132, 111904391)->(3445106103, -68197580) Sep 16 04:49:15.872276 kernel: registered taskstats version 1 Sep 16 04:49:15.872285 kernel: Loading compiled-in X.509 certificates Sep 16 04:49:15.872294 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.47-flatcar: d1d5b0d56b9b23dabf19e645632ff93bf659b3bf' Sep 16 04:49:15.872302 kernel: Demotion targets for Node 0: null Sep 16 04:49:15.872312 kernel: Key type .fscrypt registered Sep 16 04:49:15.872321 kernel: Key type fscrypt-provisioning registered Sep 16 04:49:15.872329 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 16 04:49:15.872337 kernel: ima: Allocated hash algorithm: sha1 Sep 16 04:49:15.872346 kernel: ima: No architecture policies found Sep 16 04:49:15.872354 kernel: clk: Disabling unused clocks Sep 16 04:49:15.872362 kernel: Warning: unable to open an initial console. Sep 16 04:49:15.872371 kernel: Freeing unused kernel image (initmem) memory: 54096K Sep 16 04:49:15.872382 kernel: Write protecting the kernel read-only data: 24576k Sep 16 04:49:15.872390 kernel: Freeing unused kernel image (rodata/data gap) memory: 248K Sep 16 04:49:15.872398 kernel: Run /init as init process Sep 16 04:49:15.872407 kernel: with arguments: Sep 16 04:49:15.872415 kernel: /init Sep 16 04:49:15.872423 kernel: with environment: Sep 16 04:49:15.872431 kernel: HOME=/ Sep 16 04:49:15.872439 kernel: TERM=linux Sep 16 04:49:15.872447 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 16 04:49:15.872463 systemd[1]: Successfully made /usr/ read-only. Sep 16 04:49:15.872486 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 16 04:49:15.872498 systemd[1]: Detected virtualization kvm. Sep 16 04:49:15.872506 systemd[1]: Detected architecture x86-64. Sep 16 04:49:15.872515 systemd[1]: Running in initrd. Sep 16 04:49:15.872525 systemd[1]: No hostname configured, using default hostname. Sep 16 04:49:15.872534 systemd[1]: Hostname set to . Sep 16 04:49:15.872543 systemd[1]: Initializing machine ID from VM UUID. Sep 16 04:49:15.872552 systemd[1]: Queued start job for default target initrd.target. Sep 16 04:49:15.872560 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 16 04:49:15.872569 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 16 04:49:15.872579 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 16 04:49:15.872588 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 16 04:49:15.872599 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 16 04:49:15.872608 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 16 04:49:15.872618 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 16 04:49:15.872627 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 16 04:49:15.872637 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 16 04:49:15.872645 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 16 04:49:15.872654 systemd[1]: Reached target paths.target - Path Units. Sep 16 04:49:15.872665 systemd[1]: Reached target slices.target - Slice Units. Sep 16 04:49:15.872674 systemd[1]: Reached target swap.target - Swaps. Sep 16 04:49:15.872683 systemd[1]: Reached target timers.target - Timer Units. Sep 16 04:49:15.872692 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 16 04:49:15.872700 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 16 04:49:15.872709 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 16 04:49:15.872718 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 16 04:49:15.872727 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 16 04:49:15.872735 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 16 04:49:15.872748 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 16 04:49:15.872757 systemd[1]: Reached target sockets.target - Socket Units. Sep 16 04:49:15.872765 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 16 04:49:15.872774 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 16 04:49:15.872785 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 16 04:49:15.872796 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 16 04:49:15.872805 systemd[1]: Starting systemd-fsck-usr.service... Sep 16 04:49:15.872814 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 16 04:49:15.872823 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 16 04:49:15.872832 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 16 04:49:15.872841 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 16 04:49:15.872852 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 16 04:49:15.872861 systemd[1]: Finished systemd-fsck-usr.service. Sep 16 04:49:15.872870 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 16 04:49:15.872911 systemd-journald[220]: Collecting audit messages is disabled. Sep 16 04:49:15.872936 systemd-journald[220]: Journal started Sep 16 04:49:15.872958 systemd-journald[220]: Runtime Journal (/run/log/journal/0e553bbbca394e8db1f09822aa7009db) is 6M, max 48.6M, 42.5M free. Sep 16 04:49:15.874204 systemd[1]: Started systemd-journald.service - Journal Service. Sep 16 04:49:15.862244 systemd-modules-load[222]: Inserted module 'overlay' Sep 16 04:49:15.875944 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 16 04:49:15.879365 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 16 04:49:15.882296 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 16 04:49:15.906214 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 16 04:49:15.908280 systemd-modules-load[222]: Inserted module 'br_netfilter' Sep 16 04:49:15.939161 kernel: Bridge firewalling registered Sep 16 04:49:15.910976 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 16 04:49:15.916879 systemd-tmpfiles[239]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 16 04:49:15.943695 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 16 04:49:15.946142 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 16 04:49:15.948878 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 16 04:49:15.953998 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 16 04:49:15.956136 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 16 04:49:15.976374 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 16 04:49:15.979716 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 16 04:49:16.000391 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 16 04:49:16.002069 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 16 04:49:16.023135 dracut-cmdline[264]: 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=0b876f86a632750e9937176808a48c2452d5168964273bcfc3c72f2a26140c06 Sep 16 04:49:16.049808 systemd-resolved[255]: Positive Trust Anchors: Sep 16 04:49:16.049843 systemd-resolved[255]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 16 04:49:16.049890 systemd-resolved[255]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 16 04:49:16.053722 systemd-resolved[255]: Defaulting to hostname 'linux'. Sep 16 04:49:16.055394 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 16 04:49:16.059589 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 16 04:49:16.150224 kernel: SCSI subsystem initialized Sep 16 04:49:16.162240 kernel: Loading iSCSI transport class v2.0-870. Sep 16 04:49:16.177237 kernel: iscsi: registered transport (tcp) Sep 16 04:49:16.206668 kernel: iscsi: registered transport (qla4xxx) Sep 16 04:49:16.206753 kernel: QLogic iSCSI HBA Driver Sep 16 04:49:16.235938 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 16 04:49:16.262054 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 16 04:49:16.267125 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 16 04:49:16.341929 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 16 04:49:16.344049 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 16 04:49:16.408241 kernel: raid6: avx2x4 gen() 26714 MB/s Sep 16 04:49:16.425229 kernel: raid6: avx2x2 gen() 25142 MB/s Sep 16 04:49:16.442286 kernel: raid6: avx2x1 gen() 23484 MB/s Sep 16 04:49:16.442367 kernel: raid6: using algorithm avx2x4 gen() 26714 MB/s Sep 16 04:49:16.460271 kernel: raid6: .... xor() 7640 MB/s, rmw enabled Sep 16 04:49:16.460330 kernel: raid6: using avx2x2 recovery algorithm Sep 16 04:49:16.483220 kernel: xor: automatically using best checksumming function avx Sep 16 04:49:16.688248 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 16 04:49:16.699291 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 16 04:49:16.702330 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 16 04:49:16.736278 systemd-udevd[473]: Using default interface naming scheme 'v255'. Sep 16 04:49:16.743286 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 16 04:49:16.744680 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 16 04:49:16.772904 dracut-pre-trigger[477]: rd.md=0: removing MD RAID activation Sep 16 04:49:16.812692 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 16 04:49:16.817552 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 16 04:49:16.902504 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 16 04:49:16.905971 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 16 04:49:16.956307 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Sep 16 04:49:16.964271 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Sep 16 04:49:16.982026 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 16 04:49:16.982340 kernel: cryptd: max_cpu_qlen set to 1000 Sep 16 04:49:16.983194 kernel: libata version 3.00 loaded. Sep 16 04:49:16.991193 kernel: ahci 0000:00:1f.2: version 3.0 Sep 16 04:49:16.991418 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Sep 16 04:49:16.994673 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Sep 16 04:49:16.994877 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Sep 16 04:49:16.995024 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Sep 16 04:49:16.997754 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 16 04:49:16.999479 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 16 04:49:17.001490 kernel: scsi host0: ahci Sep 16 04:49:17.001747 kernel: scsi host1: ahci Sep 16 04:49:17.001960 kernel: AES CTR mode by8 optimization enabled Sep 16 04:49:17.006119 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 16 04:49:17.006150 kernel: scsi host2: ahci Sep 16 04:49:17.008200 kernel: scsi host3: ahci Sep 16 04:49:17.006658 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 16 04:49:17.013859 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 16 04:49:17.018201 kernel: scsi host4: ahci Sep 16 04:49:17.019534 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 16 04:49:17.022756 kernel: scsi host5: ahci Sep 16 04:49:17.022935 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 lpm-pol 1 Sep 16 04:49:17.022948 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 lpm-pol 1 Sep 16 04:49:17.025081 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 lpm-pol 1 Sep 16 04:49:17.025109 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 lpm-pol 1 Sep 16 04:49:17.026703 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 lpm-pol 1 Sep 16 04:49:17.029067 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 lpm-pol 1 Sep 16 04:49:17.066401 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 16 04:49:17.106542 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 16 04:49:17.110202 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 16 04:49:17.123210 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 16 04:49:17.145099 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 16 04:49:17.159987 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 16 04:49:17.165597 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 16 04:49:17.204261 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 16 04:49:17.212196 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 16 04:49:17.339227 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 16 04:49:17.339322 kernel: ata2: SATA link down (SStatus 0 SControl 300) Sep 16 04:49:17.340207 kernel: ata3.00: LPM support broken, forcing max_power Sep 16 04:49:17.341337 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 16 04:49:17.341364 kernel: ata3.00: applying bridge limits Sep 16 04:49:17.342687 kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 16 04:49:17.343573 kernel: ata1: SATA link down (SStatus 0 SControl 300) Sep 16 04:49:17.344443 kernel: ata6: SATA link down (SStatus 0 SControl 300) Sep 16 04:49:17.344469 kernel: ata3.00: LPM support broken, forcing max_power Sep 16 04:49:17.345219 kernel: ata3.00: configured for UDMA/100 Sep 16 04:49:17.346204 kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 16 04:49:17.347226 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 16 04:49:17.403294 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 16 04:49:17.403672 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 16 04:49:17.424224 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Sep 16 04:49:17.749615 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 16 04:49:17.751737 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 16 04:49:17.753250 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 16 04:49:17.755726 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 16 04:49:17.759330 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 16 04:49:17.801454 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 16 04:49:18.217205 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 16 04:49:18.218839 disk-uuid[634]: The operation has completed successfully. Sep 16 04:49:18.257406 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 16 04:49:18.257565 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 16 04:49:18.302853 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 16 04:49:18.334249 sh[663]: Success Sep 16 04:49:18.353240 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 16 04:49:18.353298 kernel: device-mapper: uevent: version 1.0.3 Sep 16 04:49:18.354441 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 16 04:49:18.364193 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 16 04:49:18.394374 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 16 04:49:18.397832 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 16 04:49:18.412541 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 16 04:49:18.420199 kernel: BTRFS: device fsid f1b91845-3914-4d21-a370-6d760ee45b2e devid 1 transid 36 /dev/mapper/usr (253:0) scanned by mount (676) Sep 16 04:49:18.422194 kernel: BTRFS info (device dm-0): first mount of filesystem f1b91845-3914-4d21-a370-6d760ee45b2e Sep 16 04:49:18.422210 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 16 04:49:18.427212 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 16 04:49:18.427246 kernel: BTRFS info (device dm-0): enabling free space tree Sep 16 04:49:18.428517 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 16 04:49:18.429534 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 16 04:49:18.430754 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 16 04:49:18.431734 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 16 04:49:18.433597 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 16 04:49:18.463310 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (708) Sep 16 04:49:18.465494 kernel: BTRFS info (device vda6): first mount of filesystem 8b047ef5-4757-404a-b211-2a505a425364 Sep 16 04:49:18.465520 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 16 04:49:18.469243 kernel: BTRFS info (device vda6): turning on async discard Sep 16 04:49:18.469335 kernel: BTRFS info (device vda6): enabling free space tree Sep 16 04:49:18.475197 kernel: BTRFS info (device vda6): last unmount of filesystem 8b047ef5-4757-404a-b211-2a505a425364 Sep 16 04:49:18.476774 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 16 04:49:18.478608 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 16 04:49:18.599421 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 16 04:49:18.604289 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 16 04:49:18.625379 ignition[751]: Ignition 2.22.0 Sep 16 04:49:18.625387 ignition[751]: Stage: fetch-offline Sep 16 04:49:18.625431 ignition[751]: no configs at "/usr/lib/ignition/base.d" Sep 16 04:49:18.625440 ignition[751]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 16 04:49:18.625550 ignition[751]: parsed url from cmdline: "" Sep 16 04:49:18.625554 ignition[751]: no config URL provided Sep 16 04:49:18.625559 ignition[751]: reading system config file "/usr/lib/ignition/user.ign" Sep 16 04:49:18.625568 ignition[751]: no config at "/usr/lib/ignition/user.ign" Sep 16 04:49:18.625593 ignition[751]: op(1): [started] loading QEMU firmware config module Sep 16 04:49:18.625598 ignition[751]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 16 04:49:18.747461 ignition[751]: op(1): [finished] loading QEMU firmware config module Sep 16 04:49:18.748930 ignition[751]: parsing config with SHA512: 98e19a7501f06258b2bbb0d31beea5518cca4bc690ad538a1c4277c2432421a28cdee29fa1c4a427161cac2ccb4ce6724a5b46a963fb8bc13e6c3be05a2a1e8f Sep 16 04:49:18.760271 unknown[751]: fetched base config from "system" Sep 16 04:49:18.760289 unknown[751]: fetched user config from "qemu" Sep 16 04:49:18.760569 ignition[751]: fetch-offline: fetch-offline passed Sep 16 04:49:18.760749 ignition[751]: Ignition finished successfully Sep 16 04:49:18.764257 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 16 04:49:18.782131 systemd-networkd[850]: lo: Link UP Sep 16 04:49:18.782145 systemd-networkd[850]: lo: Gained carrier Sep 16 04:49:18.785489 systemd-networkd[850]: Enumeration completed Sep 16 04:49:18.785760 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 16 04:49:18.786918 systemd[1]: Reached target network.target - Network. Sep 16 04:49:18.787218 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 16 04:49:18.788725 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 16 04:49:18.795319 systemd-networkd[850]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 16 04:49:18.795331 systemd-networkd[850]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 16 04:49:18.800603 systemd-networkd[850]: eth0: Link UP Sep 16 04:49:18.801667 systemd-networkd[850]: eth0: Gained carrier Sep 16 04:49:18.801687 systemd-networkd[850]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 16 04:49:18.827370 systemd-networkd[850]: eth0: DHCPv4 address 10.0.0.45/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 16 04:49:18.847883 ignition[859]: Ignition 2.22.0 Sep 16 04:49:18.847899 ignition[859]: Stage: kargs Sep 16 04:49:18.848050 ignition[859]: no configs at "/usr/lib/ignition/base.d" Sep 16 04:49:18.848061 ignition[859]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 16 04:49:18.848727 ignition[859]: kargs: kargs passed Sep 16 04:49:18.848777 ignition[859]: Ignition finished successfully Sep 16 04:49:18.853803 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 16 04:49:18.855845 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 16 04:49:18.899830 ignition[868]: Ignition 2.22.0 Sep 16 04:49:18.899846 ignition[868]: Stage: disks Sep 16 04:49:18.900042 ignition[868]: no configs at "/usr/lib/ignition/base.d" Sep 16 04:49:18.900055 ignition[868]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 16 04:49:18.900863 ignition[868]: disks: disks passed Sep 16 04:49:18.900912 ignition[868]: Ignition finished successfully Sep 16 04:49:18.908573 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 16 04:49:18.910945 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 16 04:49:18.911445 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 16 04:49:18.911797 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 16 04:49:18.912151 systemd[1]: Reached target sysinit.target - System Initialization. Sep 16 04:49:18.912750 systemd[1]: Reached target basic.target - Basic System. Sep 16 04:49:18.914462 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 16 04:49:18.945944 systemd-fsck[878]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 16 04:49:18.954479 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 16 04:49:18.956036 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 16 04:49:18.990550 systemd-resolved[255]: Detected conflict on linux IN A 10.0.0.45 Sep 16 04:49:18.990571 systemd-resolved[255]: Hostname conflict, changing published hostname from 'linux' to 'linux10'. Sep 16 04:49:19.077239 kernel: EXT4-fs (vda9): mounted filesystem fb1cb44f-955b-4cd0-8849-33ce3640d547 r/w with ordered data mode. Quota mode: none. Sep 16 04:49:19.078459 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 16 04:49:19.080119 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 16 04:49:19.082778 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 16 04:49:19.084446 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 16 04:49:19.085578 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 16 04:49:19.085618 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 16 04:49:19.085641 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 16 04:49:19.097468 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 16 04:49:19.100443 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 16 04:49:19.105442 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (886) Sep 16 04:49:19.107881 kernel: BTRFS info (device vda6): first mount of filesystem 8b047ef5-4757-404a-b211-2a505a425364 Sep 16 04:49:19.107911 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 16 04:49:19.111714 kernel: BTRFS info (device vda6): turning on async discard Sep 16 04:49:19.111785 kernel: BTRFS info (device vda6): enabling free space tree Sep 16 04:49:19.114350 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 16 04:49:19.151926 initrd-setup-root[910]: cut: /sysroot/etc/passwd: No such file or directory Sep 16 04:49:19.157696 initrd-setup-root[917]: cut: /sysroot/etc/group: No such file or directory Sep 16 04:49:19.163051 initrd-setup-root[924]: cut: /sysroot/etc/shadow: No such file or directory Sep 16 04:49:19.167573 initrd-setup-root[931]: cut: /sysroot/etc/gshadow: No such file or directory Sep 16 04:49:19.278843 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 16 04:49:19.294912 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 16 04:49:19.297322 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 16 04:49:19.321223 kernel: BTRFS info (device vda6): last unmount of filesystem 8b047ef5-4757-404a-b211-2a505a425364 Sep 16 04:49:19.347407 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 16 04:49:19.376329 ignition[1000]: INFO : Ignition 2.22.0 Sep 16 04:49:19.376329 ignition[1000]: INFO : Stage: mount Sep 16 04:49:19.378935 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 16 04:49:19.378935 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 16 04:49:19.378935 ignition[1000]: INFO : mount: mount passed Sep 16 04:49:19.378935 ignition[1000]: INFO : Ignition finished successfully Sep 16 04:49:19.385565 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 16 04:49:19.392138 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 16 04:49:19.533572 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 16 04:49:19.545639 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 16 04:49:19.570601 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1012) Sep 16 04:49:19.573217 kernel: BTRFS info (device vda6): first mount of filesystem 8b047ef5-4757-404a-b211-2a505a425364 Sep 16 04:49:19.573262 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 16 04:49:19.577250 kernel: BTRFS info (device vda6): turning on async discard Sep 16 04:49:19.577352 kernel: BTRFS info (device vda6): enabling free space tree Sep 16 04:49:19.579659 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 16 04:49:19.628713 ignition[1029]: INFO : Ignition 2.22.0 Sep 16 04:49:19.628713 ignition[1029]: INFO : Stage: files Sep 16 04:49:19.630725 ignition[1029]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 16 04:49:19.630725 ignition[1029]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 16 04:49:19.633008 ignition[1029]: DEBUG : files: compiled without relabeling support, skipping Sep 16 04:49:19.635145 ignition[1029]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 16 04:49:19.635145 ignition[1029]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 16 04:49:19.640472 ignition[1029]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 16 04:49:19.642280 ignition[1029]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 16 04:49:19.643878 ignition[1029]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 16 04:49:19.643254 unknown[1029]: wrote ssh authorized keys file for user: core Sep 16 04:49:19.648773 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 16 04:49:19.650875 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 16 04:49:19.650875 ignition[1029]: INFO : files: op(4): [started] processing unit "docker.service" Sep 16 04:49:19.650875 ignition[1029]: INFO : files: op(4): [finished] processing unit "docker.service" Sep 16 04:49:19.650875 ignition[1029]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Sep 16 04:49:19.650875 ignition[1029]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 16 04:49:19.660061 ignition[1029]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 16 04:49:19.660061 ignition[1029]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Sep 16 04:49:19.660061 ignition[1029]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 16 04:49:19.679616 ignition[1029]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 16 04:49:19.686488 ignition[1029]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 16 04:49:19.688520 ignition[1029]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 16 04:49:19.688520 ignition[1029]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 16 04:49:19.688520 ignition[1029]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 16 04:49:19.688520 ignition[1029]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 16 04:49:19.688520 ignition[1029]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 16 04:49:19.688520 ignition[1029]: INFO : files: files passed Sep 16 04:49:19.688520 ignition[1029]: INFO : Ignition finished successfully Sep 16 04:49:19.696995 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 16 04:49:19.699993 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 16 04:49:19.702881 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 16 04:49:19.719959 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 16 04:49:19.720151 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 16 04:49:19.725360 initrd-setup-root-after-ignition[1059]: grep: /sysroot/oem/oem-release: No such file or directory Sep 16 04:49:19.730284 initrd-setup-root-after-ignition[1061]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 16 04:49:19.730284 initrd-setup-root-after-ignition[1061]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 16 04:49:19.734244 initrd-setup-root-after-ignition[1065]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 16 04:49:19.738819 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 16 04:49:19.739329 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 16 04:49:19.740809 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 16 04:49:19.820825 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 16 04:49:19.820990 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 16 04:49:19.821998 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 16 04:49:19.825507 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 16 04:49:19.826766 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 16 04:49:19.830010 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 16 04:49:19.876733 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 16 04:49:19.880234 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 16 04:49:19.929752 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 16 04:49:19.930813 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 16 04:49:19.931681 systemd[1]: Stopped target timers.target - Timer Units. Sep 16 04:49:19.935715 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 16 04:49:19.935972 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 16 04:49:19.939668 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 16 04:49:19.940503 systemd[1]: Stopped target basic.target - Basic System. Sep 16 04:49:19.940894 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 16 04:49:19.941587 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 16 04:49:19.942214 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 16 04:49:19.943423 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 16 04:49:19.950896 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 16 04:49:19.952994 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 16 04:49:19.953705 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 16 04:49:19.957634 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 16 04:49:19.959631 systemd[1]: Stopped target swap.target - Swaps. Sep 16 04:49:19.959910 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 16 04:49:19.960122 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 16 04:49:19.964413 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 16 04:49:19.965152 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 16 04:49:19.965642 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 16 04:49:19.969508 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 16 04:49:19.970473 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 16 04:49:19.970679 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 16 04:49:19.976155 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 16 04:49:19.976379 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 16 04:49:19.976971 systemd[1]: Stopped target paths.target - Path Units. Sep 16 04:49:19.981519 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 16 04:49:19.982687 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 16 04:49:19.985646 systemd[1]: Stopped target slices.target - Slice Units. Sep 16 04:49:19.986258 systemd[1]: Stopped target sockets.target - Socket Units. Sep 16 04:49:19.986816 systemd[1]: iscsid.socket: Deactivated successfully. Sep 16 04:49:19.986948 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 16 04:49:19.989976 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 16 04:49:19.990069 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 16 04:49:19.991860 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 16 04:49:19.992037 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 16 04:49:19.994001 systemd[1]: ignition-files.service: Deactivated successfully. Sep 16 04:49:19.994201 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 16 04:49:20.000593 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 16 04:49:20.001776 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 16 04:49:20.004676 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 16 04:49:20.004857 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 16 04:49:20.008777 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 16 04:49:20.008990 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 16 04:49:20.018269 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 16 04:49:20.020458 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 16 04:49:20.050995 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 16 04:49:20.059436 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 16 04:49:20.059675 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 16 04:49:20.068345 ignition[1085]: INFO : Ignition 2.22.0 Sep 16 04:49:20.068345 ignition[1085]: INFO : Stage: umount Sep 16 04:49:20.070975 ignition[1085]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 16 04:49:20.070975 ignition[1085]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 16 04:49:20.070975 ignition[1085]: INFO : umount: umount passed Sep 16 04:49:20.070975 ignition[1085]: INFO : Ignition finished successfully Sep 16 04:49:20.076611 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 16 04:49:20.076819 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 16 04:49:20.078128 systemd[1]: Stopped target network.target - Network. Sep 16 04:49:20.080861 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 16 04:49:20.080952 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 16 04:49:20.081675 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 16 04:49:20.081832 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 16 04:49:20.085549 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 16 04:49:20.085613 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 16 04:49:20.085939 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 16 04:49:20.085981 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 16 04:49:20.086572 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 16 04:49:20.086639 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 16 04:49:20.087195 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 16 04:49:20.093656 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 16 04:49:20.103661 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 16 04:49:20.103829 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 16 04:49:20.107943 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 16 04:49:20.108335 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 16 04:49:20.108432 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 16 04:49:20.113600 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 16 04:49:20.113927 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 16 04:49:20.114077 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 16 04:49:20.119139 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 16 04:49:20.121366 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 16 04:49:20.121441 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 16 04:49:20.124650 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 16 04:49:20.125119 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 16 04:49:20.125254 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 16 04:49:20.125689 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 16 04:49:20.125737 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 16 04:49:20.130767 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 16 04:49:20.130816 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 16 04:49:20.131200 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 16 04:49:20.150496 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 16 04:49:20.156515 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 16 04:49:20.160068 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 16 04:49:20.160226 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 16 04:49:20.161391 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 16 04:49:20.161476 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 16 04:49:20.163613 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 16 04:49:20.163655 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 16 04:49:20.165944 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 16 04:49:20.166018 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 16 04:49:20.168975 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 16 04:49:20.169029 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 16 04:49:20.173602 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 16 04:49:20.173672 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 16 04:49:20.180956 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 16 04:49:20.183654 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 16 04:49:20.183728 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 16 04:49:20.187909 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 16 04:49:20.187982 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 16 04:49:20.191986 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 16 04:49:20.192051 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 16 04:49:20.196422 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 16 04:49:20.196486 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 16 04:49:20.197129 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 16 04:49:20.197201 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 16 04:49:20.209467 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 16 04:49:20.209628 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 16 04:49:20.210312 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 16 04:49:20.216611 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 16 04:49:20.241286 systemd[1]: Switching root. Sep 16 04:49:20.278579 systemd-journald[220]: Journal stopped Sep 16 04:49:21.321160 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Sep 16 04:49:21.321256 kernel: SELinux: policy capability network_peer_controls=1 Sep 16 04:49:21.321271 kernel: SELinux: policy capability open_perms=1 Sep 16 04:49:21.321283 kernel: SELinux: policy capability extended_socket_class=1 Sep 16 04:49:21.321298 kernel: SELinux: policy capability always_check_network=0 Sep 16 04:49:21.321310 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 16 04:49:21.321322 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 16 04:49:21.321333 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 16 04:49:21.321345 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 16 04:49:21.321357 kernel: SELinux: policy capability userspace_initial_context=0 Sep 16 04:49:21.321369 kernel: audit: type=1403 audit(1757998160.396:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 16 04:49:21.321386 systemd[1]: Successfully loaded SELinux policy in 65.888ms. Sep 16 04:49:21.321410 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 8.830ms. Sep 16 04:49:21.321440 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 16 04:49:21.321454 systemd[1]: Detected virtualization kvm. Sep 16 04:49:21.321471 systemd[1]: Detected architecture x86-64. Sep 16 04:49:21.321495 systemd[1]: Detected first boot. Sep 16 04:49:21.321516 systemd[1]: Initializing machine ID from VM UUID. Sep 16 04:49:21.321535 zram_generator::config[1130]: No configuration found. Sep 16 04:49:21.321550 kernel: Guest personality initialized and is inactive Sep 16 04:49:21.321562 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Sep 16 04:49:21.321574 kernel: Initialized host personality Sep 16 04:49:21.321585 kernel: NET: Registered PF_VSOCK protocol family Sep 16 04:49:21.321597 systemd[1]: Populated /etc with preset unit settings. Sep 16 04:49:21.321611 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 16 04:49:21.321628 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 16 04:49:21.321640 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 16 04:49:21.321655 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 16 04:49:21.321668 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 16 04:49:21.321681 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 16 04:49:21.321693 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 16 04:49:21.321705 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 16 04:49:21.321717 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 16 04:49:21.321730 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 16 04:49:21.321742 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 16 04:49:21.321757 systemd[1]: Created slice user.slice - User and Session Slice. Sep 16 04:49:21.321769 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 16 04:49:21.321786 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 16 04:49:21.321799 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 16 04:49:21.321811 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 16 04:49:21.321824 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 16 04:49:21.321837 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 16 04:49:21.321849 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 16 04:49:21.321864 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 16 04:49:21.321876 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 16 04:49:21.321888 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 16 04:49:21.321900 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 16 04:49:21.321913 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 16 04:49:21.321925 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 16 04:49:21.321939 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 16 04:49:21.321951 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 16 04:49:21.321964 systemd[1]: Reached target slices.target - Slice Units. Sep 16 04:49:21.321979 systemd[1]: Reached target swap.target - Swaps. Sep 16 04:49:21.321991 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 16 04:49:21.322004 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 16 04:49:21.322016 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 16 04:49:21.322029 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 16 04:49:21.322041 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 16 04:49:21.322068 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 16 04:49:21.322080 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 16 04:49:21.322092 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 16 04:49:21.322108 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 16 04:49:21.322120 systemd[1]: Mounting media.mount - External Media Directory... Sep 16 04:49:21.322132 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:21.322145 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 16 04:49:21.322157 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 16 04:49:21.322186 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 16 04:49:21.322199 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 16 04:49:21.322211 systemd[1]: Reached target machines.target - Containers. Sep 16 04:49:21.322224 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 16 04:49:21.322239 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 16 04:49:21.322252 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 16 04:49:21.322264 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 16 04:49:21.322276 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 16 04:49:21.322289 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 16 04:49:21.322301 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 16 04:49:21.322314 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 16 04:49:21.322326 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 16 04:49:21.322341 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 16 04:49:21.322358 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 16 04:49:21.322370 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 16 04:49:21.322383 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 16 04:49:21.322395 systemd[1]: Stopped systemd-fsck-usr.service. Sep 16 04:49:21.322408 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 16 04:49:21.322421 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 16 04:49:21.322433 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 16 04:49:21.322445 kernel: loop: module loaded Sep 16 04:49:21.322460 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 16 04:49:21.322472 kernel: fuse: init (API version 7.41) Sep 16 04:49:21.322484 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 16 04:49:21.322497 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 16 04:49:21.322533 systemd-journald[1194]: Collecting audit messages is disabled. Sep 16 04:49:21.322557 systemd-journald[1194]: Journal started Sep 16 04:49:21.322582 systemd-journald[1194]: Runtime Journal (/run/log/journal/0e553bbbca394e8db1f09822aa7009db) is 6M, max 48.6M, 42.5M free. Sep 16 04:49:21.058251 systemd[1]: Queued start job for default target multi-user.target. Sep 16 04:49:21.071652 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 16 04:49:21.072227 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 16 04:49:21.333045 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 16 04:49:21.335401 systemd[1]: verity-setup.service: Deactivated successfully. Sep 16 04:49:21.338875 systemd[1]: Stopped verity-setup.service. Sep 16 04:49:21.338924 kernel: ACPI: bus type drm_connector registered Sep 16 04:49:21.344308 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:21.351228 systemd[1]: Started systemd-journald.service - Journal Service. Sep 16 04:49:21.353459 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 16 04:49:21.354751 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 16 04:49:21.356339 systemd[1]: Mounted media.mount - External Media Directory. Sep 16 04:49:21.357607 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 16 04:49:21.358882 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 16 04:49:21.360276 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 16 04:49:21.361761 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 16 04:49:21.364452 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 16 04:49:21.364787 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 16 04:49:21.366489 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 16 04:49:21.366791 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 16 04:49:21.368618 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 16 04:49:21.368931 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 16 04:49:21.370687 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 16 04:49:21.370997 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 16 04:49:21.372736 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 16 04:49:21.373034 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 16 04:49:21.374622 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 16 04:49:21.374915 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 16 04:49:21.376568 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 16 04:49:21.378245 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 16 04:49:21.379997 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 16 04:49:21.382080 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 16 04:49:21.400111 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 16 04:49:21.404288 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 16 04:49:21.409312 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 16 04:49:21.410687 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 16 04:49:21.410733 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 16 04:49:21.413582 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 16 04:49:21.420378 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 16 04:49:21.421909 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 16 04:49:21.424637 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 16 04:49:21.428309 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 16 04:49:21.429821 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 16 04:49:21.431150 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 16 04:49:21.434224 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 16 04:49:21.443303 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 16 04:49:21.454427 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 16 04:49:21.459761 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 16 04:49:21.463552 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 16 04:49:21.465541 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 16 04:49:21.471629 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 16 04:49:21.471941 systemd-journald[1194]: Time spent on flushing to /var/log/journal/0e553bbbca394e8db1f09822aa7009db is 13.538ms for 955 entries. Sep 16 04:49:21.471941 systemd-journald[1194]: System Journal (/var/log/journal/0e553bbbca394e8db1f09822aa7009db) is 8M, max 195.6M, 187.6M free. Sep 16 04:49:21.712974 systemd-journald[1194]: Received client request to flush runtime journal. Sep 16 04:49:21.482923 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 16 04:49:21.484640 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 16 04:49:21.487621 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 16 04:49:21.508544 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 16 04:49:21.512141 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 16 04:49:21.528670 systemd-tmpfiles[1250]: ACLs are not supported, ignoring. Sep 16 04:49:21.528690 systemd-tmpfiles[1250]: ACLs are not supported, ignoring. Sep 16 04:49:21.535434 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 16 04:49:21.544732 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 16 04:49:21.714634 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 16 04:49:21.743249 kernel: loop0: detected capacity change from 0 to 110984 Sep 16 04:49:21.764557 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 16 04:49:21.774925 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 16 04:49:21.779481 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 16 04:49:21.788446 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 16 04:49:21.857825 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. Sep 16 04:49:21.858388 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. Sep 16 04:49:21.860196 kernel: loop1: detected capacity change from 0 to 128016 Sep 16 04:49:21.863869 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 16 04:49:21.956230 kernel: loop2: detected capacity change from 0 to 110984 Sep 16 04:49:21.973223 kernel: loop3: detected capacity change from 0 to 128016 Sep 16 04:49:21.985971 (sd-merge)[1273]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 16 04:49:21.986595 (sd-merge)[1273]: Merged extensions into '/usr'. Sep 16 04:49:21.990764 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 16 04:49:21.995803 systemd[1]: Starting ensure-sysext.service... Sep 16 04:49:22.000319 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 16 04:49:22.071122 systemd[1]: Reload requested from client PID 1275 ('systemctl') (unit ensure-sysext.service)... Sep 16 04:49:22.071161 systemd[1]: Reloading... Sep 16 04:49:22.082331 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 16 04:49:22.082760 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 16 04:49:22.083128 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 16 04:49:22.083508 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 16 04:49:22.088812 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 16 04:49:22.089196 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. Sep 16 04:49:22.089295 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. Sep 16 04:49:22.101276 systemd-tmpfiles[1276]: Detected autofs mount point /boot during canonicalization of boot. Sep 16 04:49:22.101296 systemd-tmpfiles[1276]: Skipping /boot Sep 16 04:49:22.130652 systemd-tmpfiles[1276]: Detected autofs mount point /boot during canonicalization of boot. Sep 16 04:49:22.130860 systemd-tmpfiles[1276]: Skipping /boot Sep 16 04:49:22.367226 zram_generator::config[1307]: No configuration found. Sep 16 04:49:22.456822 ldconfig[1236]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 16 04:49:22.618542 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 16 04:49:22.618659 systemd[1]: Reloading finished in 547 ms. Sep 16 04:49:22.771081 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 16 04:49:22.792396 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 16 04:49:22.804969 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 16 04:49:22.808743 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 16 04:49:22.813407 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 16 04:49:22.821273 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 16 04:49:22.826604 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 16 04:49:22.831304 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:22.831495 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 16 04:49:22.836321 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 16 04:49:22.842793 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 16 04:49:22.850582 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 16 04:49:22.852122 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 16 04:49:22.852387 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 16 04:49:22.852531 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:22.866544 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 16 04:49:22.871840 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 16 04:49:22.874511 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 16 04:49:22.895741 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 16 04:49:22.898732 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 16 04:49:22.901152 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 16 04:49:22.901673 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 16 04:49:22.903849 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 16 04:49:22.904351 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 16 04:49:22.912616 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:22.913197 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 16 04:49:22.913575 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 16 04:49:22.913710 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 16 04:49:22.913852 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 16 04:49:22.914021 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 16 04:49:22.914142 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:22.918522 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:22.918841 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 16 04:49:22.921107 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 16 04:49:22.931606 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 16 04:49:22.940649 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 16 04:49:22.951867 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 16 04:49:22.953455 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 16 04:49:22.953735 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 16 04:49:22.953956 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 16 04:49:22.955348 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 16 04:49:22.959723 augenrules[1380]: No rules Sep 16 04:49:22.960285 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 16 04:49:22.960570 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 16 04:49:22.962683 systemd[1]: audit-rules.service: Deactivated successfully. Sep 16 04:49:22.962985 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 16 04:49:22.964617 systemd[1]: Finished ensure-sysext.service. Sep 16 04:49:22.966111 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 16 04:49:22.966455 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 16 04:49:22.968070 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 16 04:49:22.968350 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 16 04:49:22.970101 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 16 04:49:22.972076 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 16 04:49:22.972406 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 16 04:49:22.984521 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 16 04:49:22.984579 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 16 04:49:22.987383 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 16 04:49:22.988874 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 16 04:49:23.046756 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 16 04:49:23.053951 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 16 04:49:23.058106 systemd-resolved[1346]: Positive Trust Anchors: Sep 16 04:49:23.058358 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 16 04:49:23.058517 systemd-resolved[1346]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 16 04:49:23.058612 systemd-resolved[1346]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 16 04:49:23.063377 systemd-resolved[1346]: Defaulting to hostname 'linux'. Sep 16 04:49:23.065723 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 16 04:49:23.069458 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 16 04:49:23.088396 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 16 04:49:23.090928 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 16 04:49:23.092691 systemd[1]: Reached target time-set.target - System Time Set. Sep 16 04:49:23.112310 systemd-udevd[1399]: Using default interface naming scheme 'v255'. Sep 16 04:49:23.139485 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 16 04:49:23.142663 systemd[1]: Reached target sysinit.target - System Initialization. Sep 16 04:49:23.144215 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 16 04:49:23.145791 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 16 04:49:23.148185 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 16 04:49:23.150071 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 16 04:49:23.152403 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 16 04:49:23.154252 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 16 04:49:23.156445 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 16 04:49:23.157042 systemd[1]: Reached target paths.target - Path Units. Sep 16 04:49:23.159045 systemd[1]: Reached target timers.target - Timer Units. Sep 16 04:49:23.162079 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 16 04:49:23.166105 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 16 04:49:23.175472 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 16 04:49:23.185919 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 16 04:49:23.187737 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 16 04:49:23.200583 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 16 04:49:23.202811 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 16 04:49:23.211412 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 16 04:49:23.213565 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 16 04:49:23.225245 systemd[1]: Reached target sockets.target - Socket Units. Sep 16 04:49:23.242132 systemd[1]: Reached target basic.target - Basic System. Sep 16 04:49:23.243493 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 16 04:49:23.243541 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 16 04:49:23.248365 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 16 04:49:23.251831 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 16 04:49:23.255915 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 16 04:49:23.261601 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 16 04:49:23.263036 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 16 04:49:23.266800 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 16 04:49:23.271943 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 16 04:49:23.275386 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 16 04:49:23.276116 jq[1435]: false Sep 16 04:49:23.291689 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 16 04:49:23.295864 extend-filesystems[1436]: Found /dev/vda6 Sep 16 04:49:23.297915 google_oslogin_nss_cache[1437]: oslogin_cache_refresh[1437]: Refreshing passwd entry cache Sep 16 04:49:23.297940 oslogin_cache_refresh[1437]: Refreshing passwd entry cache Sep 16 04:49:23.298012 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 16 04:49:23.300604 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 16 04:49:23.300641 oslogin_cache_refresh[1437]: Failure getting users, quitting Sep 16 04:49:23.300768 google_oslogin_nss_cache[1437]: oslogin_cache_refresh[1437]: Failure getting users, quitting Sep 16 04:49:23.300768 google_oslogin_nss_cache[1437]: oslogin_cache_refresh[1437]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 16 04:49:23.300768 google_oslogin_nss_cache[1437]: oslogin_cache_refresh[1437]: Refreshing group entry cache Sep 16 04:49:23.300656 oslogin_cache_refresh[1437]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 16 04:49:23.300700 oslogin_cache_refresh[1437]: Refreshing group entry cache Sep 16 04:49:23.301158 google_oslogin_nss_cache[1437]: oslogin_cache_refresh[1437]: Failure getting groups, quitting Sep 16 04:49:23.301158 google_oslogin_nss_cache[1437]: oslogin_cache_refresh[1437]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 16 04:49:23.301151 oslogin_cache_refresh[1437]: Failure getting groups, quitting Sep 16 04:49:23.301161 oslogin_cache_refresh[1437]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 16 04:49:23.307787 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 16 04:49:23.309648 systemd[1]: Starting update-engine.service - Update Engine... Sep 16 04:49:23.312930 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 16 04:49:23.316057 extend-filesystems[1436]: Found /dev/vda9 Sep 16 04:49:23.317244 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 16 04:49:23.319338 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 16 04:49:23.319867 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 16 04:49:23.320587 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 16 04:49:23.323316 extend-filesystems[1436]: Checking size of /dev/vda9 Sep 16 04:49:23.325994 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 16 04:49:23.329540 jq[1448]: true Sep 16 04:49:23.360178 systemd[1]: motdgen.service: Deactivated successfully. Sep 16 04:49:23.361718 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 16 04:49:23.363635 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 16 04:49:23.364445 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 16 04:49:23.373334 extend-filesystems[1436]: Old size kept for /dev/vda9 Sep 16 04:49:23.376944 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 16 04:49:23.378022 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 16 04:49:23.379492 update_engine[1447]: I20250916 04:49:23.379402 1447 main.cc:92] Flatcar Update Engine starting Sep 16 04:49:23.403824 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 16 04:49:23.409034 jq[1467]: true Sep 16 04:49:23.509425 systemd-logind[1446]: New seat seat0. Sep 16 04:49:23.510848 systemd[1]: Started systemd-logind.service - User Login Management. Sep 16 04:49:23.513203 kernel: mousedev: PS/2 mouse device common for all mice Sep 16 04:49:23.522355 dbus-daemon[1433]: [system] SELinux support is enabled Sep 16 04:49:23.522858 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 16 04:49:23.523208 systemd-networkd[1432]: lo: Link UP Sep 16 04:49:23.523217 systemd-networkd[1432]: lo: Gained carrier Sep 16 04:49:23.529294 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 16 04:49:23.529328 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 16 04:49:23.532326 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 16 04:49:23.532341 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 16 04:49:23.536116 systemd-networkd[1432]: Enumeration completed Sep 16 04:49:23.536213 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 16 04:49:23.553261 systemd-networkd[1432]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 16 04:49:23.553269 systemd-networkd[1432]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 16 04:49:23.553901 systemd-networkd[1432]: eth0: Link UP Sep 16 04:49:23.554153 systemd-networkd[1432]: eth0: Gained carrier Sep 16 04:49:23.555128 systemd-networkd[1432]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 16 04:49:23.561925 systemd[1]: Reached target network.target - Network. Sep 16 04:49:23.564218 dbus-daemon[1433]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 16 04:49:23.565317 systemd[1]: Starting containerd.service - containerd container runtime... Sep 16 04:49:23.568145 update_engine[1447]: I20250916 04:49:23.568068 1447 update_check_scheduler.cc:74] Next update check in 10m43s Sep 16 04:49:23.570515 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 16 04:49:23.576406 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 16 04:49:23.577250 systemd-networkd[1432]: eth0: DHCPv4 address 10.0.0.45/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 16 04:49:23.582109 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Sep 16 04:49:23.582525 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Sep 16 04:49:23.582884 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Sep 16 04:49:23.583989 systemd-timesyncd[1397]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 16 04:49:23.584070 systemd-timesyncd[1397]: Initial clock synchronization to Tue 2025-09-16 04:49:23.886374 UTC. Sep 16 04:49:23.622212 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Sep 16 04:49:23.591839 systemd[1]: Started update-engine.service - Update Engine. Sep 16 04:49:23.632576 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 16 04:49:23.661377 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 16 04:49:23.701671 (ntainerd)[1517]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 16 04:49:23.712306 bash[1493]: Updated "/home/core/.ssh/authorized_keys" Sep 16 04:49:23.716239 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 16 04:49:23.720898 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 16 04:49:23.736207 kernel: ACPI: button: Power Button [PWRF] Sep 16 04:49:23.785149 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 16 04:49:23.811019 systemd-logind[1446]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 16 04:49:23.848622 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 16 04:49:23.852353 systemd-logind[1446]: Watching system buttons on /dev/input/event2 (Power Button) Sep 16 04:49:23.859459 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 16 04:49:23.888997 kernel: kvm_amd: TSC scaling supported Sep 16 04:49:23.889110 kernel: kvm_amd: Nested Virtualization enabled Sep 16 04:49:23.889158 kernel: kvm_amd: Nested Paging enabled Sep 16 04:49:23.889215 kernel: kvm_amd: LBR virtualization supported Sep 16 04:49:23.893213 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Sep 16 04:49:23.893292 kernel: kvm_amd: Virtual GIF supported Sep 16 04:49:23.894096 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 16 04:49:23.911493 locksmithd[1514]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 16 04:49:23.951574 kernel: EDAC MC: Ver: 3.0.0 Sep 16 04:49:23.958002 sshd_keygen[1464]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 16 04:49:23.989334 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 16 04:49:24.023557 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 16 04:49:24.102175 systemd[1]: issuegen.service: Deactivated successfully. Sep 16 04:49:24.102602 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 16 04:49:24.115135 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 16 04:49:24.133473 containerd[1517]: time="2025-09-16T04:49:24Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 16 04:49:24.135660 containerd[1517]: time="2025-09-16T04:49:24.135595181Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 16 04:49:24.137515 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 16 04:49:24.173069 containerd[1517]: time="2025-09-16T04:49:24.172997851Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="14.962µs" Sep 16 04:49:24.173069 containerd[1517]: time="2025-09-16T04:49:24.173054134Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 16 04:49:24.173262 containerd[1517]: time="2025-09-16T04:49:24.173080305Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 16 04:49:24.173456 containerd[1517]: time="2025-09-16T04:49:24.173424156Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 16 04:49:24.173488 containerd[1517]: time="2025-09-16T04:49:24.173454413Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 16 04:49:24.173509 containerd[1517]: time="2025-09-16T04:49:24.173492312Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 16 04:49:24.173647 containerd[1517]: time="2025-09-16T04:49:24.173605440Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 16 04:49:24.173713 containerd[1517]: time="2025-09-16T04:49:24.173648870Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 16 04:49:24.174309 containerd[1517]: time="2025-09-16T04:49:24.174272596Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 16 04:49:24.174309 containerd[1517]: time="2025-09-16T04:49:24.174300660Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 16 04:49:24.174386 containerd[1517]: time="2025-09-16T04:49:24.174316204Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 16 04:49:24.174386 containerd[1517]: time="2025-09-16T04:49:24.174339412Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 16 04:49:24.174517 containerd[1517]: time="2025-09-16T04:49:24.174491093Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 16 04:49:24.174712 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 16 04:49:24.176049 containerd[1517]: time="2025-09-16T04:49:24.174894148Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 16 04:49:24.176049 containerd[1517]: time="2025-09-16T04:49:24.174935459Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 16 04:49:24.176049 containerd[1517]: time="2025-09-16T04:49:24.174948455Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 16 04:49:24.176049 containerd[1517]: time="2025-09-16T04:49:24.175226479Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 16 04:49:24.176049 containerd[1517]: time="2025-09-16T04:49:24.175780353Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 16 04:49:24.176049 containerd[1517]: time="2025-09-16T04:49:24.175896651Z" level=info msg="metadata content store policy set" policy=shared Sep 16 04:49:24.178577 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 16 04:49:24.181240 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 16 04:49:24.182660 systemd[1]: Reached target getty.target - Login Prompts. Sep 16 04:49:24.184743 containerd[1517]: time="2025-09-16T04:49:24.184663817Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 16 04:49:24.184822 containerd[1517]: time="2025-09-16T04:49:24.184796896Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 16 04:49:24.184883 containerd[1517]: time="2025-09-16T04:49:24.184858367Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 16 04:49:24.184910 containerd[1517]: time="2025-09-16T04:49:24.184887502Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 16 04:49:24.184910 containerd[1517]: time="2025-09-16T04:49:24.184903452Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 16 04:49:24.184966 containerd[1517]: time="2025-09-16T04:49:24.184918694Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 16 04:49:24.184966 containerd[1517]: time="2025-09-16T04:49:24.184936412Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 16 04:49:24.184966 containerd[1517]: time="2025-09-16T04:49:24.184951936Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 16 04:49:24.184966 containerd[1517]: time="2025-09-16T04:49:24.184965276Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 16 04:49:24.185039 containerd[1517]: time="2025-09-16T04:49:24.184977265Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 16 04:49:24.185039 containerd[1517]: time="2025-09-16T04:49:24.184994348Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 16 04:49:24.185039 containerd[1517]: time="2025-09-16T04:49:24.185010162Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 16 04:49:24.185278 containerd[1517]: time="2025-09-16T04:49:24.185255600Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 16 04:49:24.185311 containerd[1517]: time="2025-09-16T04:49:24.185293074Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 16 04:49:24.186755 containerd[1517]: time="2025-09-16T04:49:24.186702344Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 16 04:49:24.186988 containerd[1517]: time="2025-09-16T04:49:24.186933348Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 16 04:49:24.187200 containerd[1517]: time="2025-09-16T04:49:24.187171018Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 16 04:49:24.187245 containerd[1517]: time="2025-09-16T04:49:24.187233769Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 16 04:49:24.187279 containerd[1517]: time="2025-09-16T04:49:24.187252464Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 16 04:49:24.187279 containerd[1517]: time="2025-09-16T04:49:24.187269006Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 16 04:49:24.187335 containerd[1517]: time="2025-09-16T04:49:24.187287098Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 16 04:49:24.187335 containerd[1517]: time="2025-09-16T04:49:24.187299222Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 16 04:49:24.187335 containerd[1517]: time="2025-09-16T04:49:24.187315183Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 16 04:49:24.187441 containerd[1517]: time="2025-09-16T04:49:24.187424078Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 16 04:49:24.187470 containerd[1517]: time="2025-09-16T04:49:24.187442367Z" level=info msg="Start snapshots syncer" Sep 16 04:49:24.187516 containerd[1517]: time="2025-09-16T04:49:24.187480038Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 16 04:49:24.187800 containerd[1517]: time="2025-09-16T04:49:24.187759340Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 16 04:49:24.187947 containerd[1517]: time="2025-09-16T04:49:24.187832810Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 16 04:49:24.187947 containerd[1517]: time="2025-09-16T04:49:24.187923540Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 16 04:49:24.188098 containerd[1517]: time="2025-09-16T04:49:24.188080867Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 16 04:49:24.188122 containerd[1517]: time="2025-09-16T04:49:24.188105260Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 16 04:49:24.188122 containerd[1517]: time="2025-09-16T04:49:24.188117603Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 16 04:49:24.188160 containerd[1517]: time="2025-09-16T04:49:24.188128333Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 16 04:49:24.188160 containerd[1517]: time="2025-09-16T04:49:24.188144418Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 16 04:49:24.188213 containerd[1517]: time="2025-09-16T04:49:24.188163196Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 16 04:49:24.188234 containerd[1517]: time="2025-09-16T04:49:24.188196344Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 16 04:49:24.188268 containerd[1517]: time="2025-09-16T04:49:24.188251805Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 16 04:49:24.188268 containerd[1517]: time="2025-09-16T04:49:24.188264366Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 16 04:49:24.188307 containerd[1517]: time="2025-09-16T04:49:24.188280378Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 16 04:49:24.188341 containerd[1517]: time="2025-09-16T04:49:24.188325172Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 16 04:49:24.188362 containerd[1517]: time="2025-09-16T04:49:24.188342691Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 16 04:49:24.188362 containerd[1517]: time="2025-09-16T04:49:24.188351956Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 16 04:49:24.188409 containerd[1517]: time="2025-09-16T04:49:24.188361699Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 16 04:49:24.188409 containerd[1517]: time="2025-09-16T04:49:24.188369912Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 16 04:49:24.188409 containerd[1517]: time="2025-09-16T04:49:24.188378876Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 16 04:49:24.188409 containerd[1517]: time="2025-09-16T04:49:24.188391508Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 16 04:49:24.188482 containerd[1517]: time="2025-09-16T04:49:24.188421121Z" level=info msg="runtime interface created" Sep 16 04:49:24.188482 containerd[1517]: time="2025-09-16T04:49:24.188427017Z" level=info msg="created NRI interface" Sep 16 04:49:24.188482 containerd[1517]: time="2025-09-16T04:49:24.188435273Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 16 04:49:24.188482 containerd[1517]: time="2025-09-16T04:49:24.188446741Z" level=info msg="Connect containerd service" Sep 16 04:49:24.188482 containerd[1517]: time="2025-09-16T04:49:24.188470312Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 16 04:49:24.189419 containerd[1517]: time="2025-09-16T04:49:24.189396100Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 16 04:49:24.522571 containerd[1517]: time="2025-09-16T04:49:24.522405671Z" level=info msg="Start subscribing containerd event" Sep 16 04:49:24.522717 containerd[1517]: time="2025-09-16T04:49:24.522544938Z" level=info msg="Start recovering state" Sep 16 04:49:24.522794 containerd[1517]: time="2025-09-16T04:49:24.522773438Z" level=info msg="Start event monitor" Sep 16 04:49:24.522842 containerd[1517]: time="2025-09-16T04:49:24.522826392Z" level=info msg="Start cni network conf syncer for default" Sep 16 04:49:24.522876 containerd[1517]: time="2025-09-16T04:49:24.522845711Z" level=info msg="Start streaming server" Sep 16 04:49:24.522876 containerd[1517]: time="2025-09-16T04:49:24.522871467Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 16 04:49:24.523067 containerd[1517]: time="2025-09-16T04:49:24.522888405Z" level=info msg="runtime interface starting up..." Sep 16 04:49:24.523067 containerd[1517]: time="2025-09-16T04:49:24.522900134Z" level=info msg="starting plugins..." Sep 16 04:49:24.523067 containerd[1517]: time="2025-09-16T04:49:24.522903347Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 16 04:49:24.523067 containerd[1517]: time="2025-09-16T04:49:24.522936130Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 16 04:49:24.523067 containerd[1517]: time="2025-09-16T04:49:24.522985581Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 16 04:49:24.523220 containerd[1517]: time="2025-09-16T04:49:24.523178905Z" level=info msg="containerd successfully booted in 0.390553s" Sep 16 04:49:24.523411 systemd[1]: Started containerd.service - containerd container runtime. Sep 16 04:49:24.853807 systemd-networkd[1432]: eth0: Gained IPv6LL Sep 16 04:49:24.858308 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 16 04:49:24.860744 systemd[1]: Reached target network-online.target - Network is Online. Sep 16 04:49:24.864534 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 16 04:49:24.867587 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 16 04:49:24.927507 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 16 04:49:24.963792 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 16 04:49:24.964112 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 16 04:49:24.966185 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 16 04:49:24.966368 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 16 04:49:24.967896 systemd[1]: Startup finished in 3.329s (kernel) + 4.754s (initrd) + 4.636s (userspace) = 12.720s. Sep 16 04:49:29.726250 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 16 04:49:29.728011 systemd[1]: Started sshd@0-10.0.0.45:22-10.0.0.1:47008.service - OpenSSH per-connection server daemon (10.0.0.1:47008). Sep 16 04:49:29.810929 sshd[1594]: Accepted publickey for core from 10.0.0.1 port 47008 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:29.813149 sshd-session[1594]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:29.821748 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 16 04:49:29.823054 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 16 04:49:29.830688 systemd-logind[1446]: New session 1 of user core. Sep 16 04:49:29.851495 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 16 04:49:29.855499 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 16 04:49:29.875041 (systemd)[1599]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 16 04:49:29.877754 systemd-logind[1446]: New session c1 of user core. Sep 16 04:49:30.035832 systemd[1599]: Queued start job for default target default.target. Sep 16 04:49:30.054795 systemd[1599]: Created slice app.slice - User Application Slice. Sep 16 04:49:30.054828 systemd[1599]: Reached target paths.target - Paths. Sep 16 04:49:30.054884 systemd[1599]: Reached target timers.target - Timers. Sep 16 04:49:30.056888 systemd[1599]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 16 04:49:30.072278 systemd[1599]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 16 04:49:30.072456 systemd[1599]: Reached target sockets.target - Sockets. Sep 16 04:49:30.072515 systemd[1599]: Reached target basic.target - Basic System. Sep 16 04:49:30.072557 systemd[1599]: Reached target default.target - Main User Target. Sep 16 04:49:30.072594 systemd[1599]: Startup finished in 186ms. Sep 16 04:49:30.072970 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 16 04:49:30.081342 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 16 04:49:30.147177 systemd[1]: Started sshd@1-10.0.0.45:22-10.0.0.1:59842.service - OpenSSH per-connection server daemon (10.0.0.1:59842). Sep 16 04:49:30.213277 sshd[1610]: Accepted publickey for core from 10.0.0.1 port 59842 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:30.214839 sshd-session[1610]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:30.220026 systemd-logind[1446]: New session 2 of user core. Sep 16 04:49:30.235486 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 16 04:49:30.291843 sshd[1613]: Connection closed by 10.0.0.1 port 59842 Sep 16 04:49:30.292192 sshd-session[1610]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:30.306588 systemd[1]: sshd@1-10.0.0.45:22-10.0.0.1:59842.service: Deactivated successfully. Sep 16 04:49:30.308661 systemd[1]: session-2.scope: Deactivated successfully. Sep 16 04:49:30.309462 systemd-logind[1446]: Session 2 logged out. Waiting for processes to exit. Sep 16 04:49:30.312506 systemd[1]: Started sshd@2-10.0.0.45:22-10.0.0.1:59848.service - OpenSSH per-connection server daemon (10.0.0.1:59848). Sep 16 04:49:30.313125 systemd-logind[1446]: Removed session 2. Sep 16 04:49:30.381750 sshd[1619]: Accepted publickey for core from 10.0.0.1 port 59848 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:30.383808 sshd-session[1619]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:30.389332 systemd-logind[1446]: New session 3 of user core. Sep 16 04:49:30.399383 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 16 04:49:30.452509 sshd[1622]: Connection closed by 10.0.0.1 port 59848 Sep 16 04:49:30.453062 sshd-session[1619]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:30.473701 systemd[1]: sshd@2-10.0.0.45:22-10.0.0.1:59848.service: Deactivated successfully. Sep 16 04:49:30.476420 systemd[1]: session-3.scope: Deactivated successfully. Sep 16 04:49:30.477463 systemd-logind[1446]: Session 3 logged out. Waiting for processes to exit. Sep 16 04:49:30.481628 systemd[1]: Started sshd@3-10.0.0.45:22-10.0.0.1:59862.service - OpenSSH per-connection server daemon (10.0.0.1:59862). Sep 16 04:49:30.482591 systemd-logind[1446]: Removed session 3. Sep 16 04:49:30.539912 sshd[1628]: Accepted publickey for core from 10.0.0.1 port 59862 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:30.541835 sshd-session[1628]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:30.547640 systemd-logind[1446]: New session 4 of user core. Sep 16 04:49:30.563492 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 16 04:49:30.620082 sshd[1631]: Connection closed by 10.0.0.1 port 59862 Sep 16 04:49:30.620572 sshd-session[1628]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:30.638365 systemd[1]: sshd@3-10.0.0.45:22-10.0.0.1:59862.service: Deactivated successfully. Sep 16 04:49:30.640489 systemd[1]: session-4.scope: Deactivated successfully. Sep 16 04:49:30.641294 systemd-logind[1446]: Session 4 logged out. Waiting for processes to exit. Sep 16 04:49:30.644084 systemd[1]: Started sshd@4-10.0.0.45:22-10.0.0.1:59876.service - OpenSSH per-connection server daemon (10.0.0.1:59876). Sep 16 04:49:30.644919 systemd-logind[1446]: Removed session 4. Sep 16 04:49:30.704516 sshd[1637]: Accepted publickey for core from 10.0.0.1 port 59876 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:30.706120 sshd-session[1637]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:30.710868 systemd-logind[1446]: New session 5 of user core. Sep 16 04:49:30.727459 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 16 04:49:30.789849 sudo[1641]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 16 04:49:30.790328 sudo[1641]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 16 04:49:30.808071 sudo[1641]: pam_unix(sudo:session): session closed for user root Sep 16 04:49:30.809947 sshd[1640]: Connection closed by 10.0.0.1 port 59876 Sep 16 04:49:30.810367 sshd-session[1637]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:30.831107 systemd[1]: sshd@4-10.0.0.45:22-10.0.0.1:59876.service: Deactivated successfully. Sep 16 04:49:30.832861 systemd[1]: session-5.scope: Deactivated successfully. Sep 16 04:49:30.833708 systemd-logind[1446]: Session 5 logged out. Waiting for processes to exit. Sep 16 04:49:30.836870 systemd[1]: Started sshd@5-10.0.0.45:22-10.0.0.1:59886.service - OpenSSH per-connection server daemon (10.0.0.1:59886). Sep 16 04:49:30.837682 systemd-logind[1446]: Removed session 5. Sep 16 04:49:30.895945 sshd[1647]: Accepted publickey for core from 10.0.0.1 port 59886 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:30.897540 sshd-session[1647]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:30.902649 systemd-logind[1446]: New session 6 of user core. Sep 16 04:49:30.912387 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 16 04:49:30.967015 sudo[1652]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 16 04:49:30.967368 sudo[1652]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 16 04:49:31.018714 sudo[1652]: pam_unix(sudo:session): session closed for user root Sep 16 04:49:31.025758 sudo[1651]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 16 04:49:31.026092 sudo[1651]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 16 04:49:31.037154 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 16 04:49:31.094712 augenrules[1674]: No rules Sep 16 04:49:31.096884 systemd[1]: audit-rules.service: Deactivated successfully. Sep 16 04:49:31.097316 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 16 04:49:31.098801 sudo[1651]: pam_unix(sudo:session): session closed for user root Sep 16 04:49:31.100788 sshd[1650]: Connection closed by 10.0.0.1 port 59886 Sep 16 04:49:31.101225 sshd-session[1647]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:31.111293 systemd[1]: sshd@5-10.0.0.45:22-10.0.0.1:59886.service: Deactivated successfully. Sep 16 04:49:31.113815 systemd[1]: session-6.scope: Deactivated successfully. Sep 16 04:49:31.114914 systemd-logind[1446]: Session 6 logged out. Waiting for processes to exit. Sep 16 04:49:31.118807 systemd[1]: Started sshd@6-10.0.0.45:22-10.0.0.1:59890.service - OpenSSH per-connection server daemon (10.0.0.1:59890). Sep 16 04:49:31.119704 systemd-logind[1446]: Removed session 6. Sep 16 04:49:31.185775 sshd[1683]: Accepted publickey for core from 10.0.0.1 port 59890 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:31.187399 sshd-session[1683]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:31.192651 systemd-logind[1446]: New session 7 of user core. Sep 16 04:49:31.206411 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 16 04:49:31.266447 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 16 04:49:31.282603 (dockerd)[1688]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 16 04:49:31.802426 dockerd[1688]: time="2025-09-16T04:49:31.802309783Z" level=info msg="Starting up" Sep 16 04:49:31.803872 dockerd[1688]: time="2025-09-16T04:49:31.803842800Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 16 04:49:31.829860 dockerd[1688]: time="2025-09-16T04:49:31.829800333Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 16 04:49:31.924298 dockerd[1688]: time="2025-09-16T04:49:31.924197884Z" level=info msg="Loading containers: start." Sep 16 04:49:31.939381 kernel: Initializing XFRM netlink socket Sep 16 04:49:32.336735 systemd-networkd[1432]: docker0: Link UP Sep 16 04:49:32.343842 dockerd[1688]: time="2025-09-16T04:49:32.343743179Z" level=info msg="Loading containers: done." Sep 16 04:49:32.363261 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1852605961-merged.mount: Deactivated successfully. Sep 16 04:49:32.363984 dockerd[1688]: time="2025-09-16T04:49:32.363918978Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 16 04:49:32.364072 dockerd[1688]: time="2025-09-16T04:49:32.364052539Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 16 04:49:32.364230 dockerd[1688]: time="2025-09-16T04:49:32.364207899Z" level=info msg="Initializing buildkit" Sep 16 04:49:32.398466 dockerd[1688]: time="2025-09-16T04:49:32.398392908Z" level=info msg="Completed buildkit initialization" Sep 16 04:49:32.406497 dockerd[1688]: time="2025-09-16T04:49:32.406413917Z" level=info msg="Daemon has completed initialization" Sep 16 04:49:32.406682 dockerd[1688]: time="2025-09-16T04:49:32.406526104Z" level=info msg="API listen on /run/docker.sock" Sep 16 04:49:32.406857 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 16 04:49:32.422811 sshd[1686]: Connection closed by 10.0.0.1 port 59890 Sep 16 04:49:32.423389 sshd-session[1683]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:32.443212 systemd[1]: sshd@6-10.0.0.45:22-10.0.0.1:59890.service: Deactivated successfully. Sep 16 04:49:32.445499 systemd[1]: session-7.scope: Deactivated successfully. Sep 16 04:49:32.446329 systemd-logind[1446]: Session 7 logged out. Waiting for processes to exit. Sep 16 04:49:32.449101 systemd[1]: Started sshd@7-10.0.0.45:22-10.0.0.1:59902.service - OpenSSH per-connection server daemon (10.0.0.1:59902). Sep 16 04:49:32.449970 systemd-logind[1446]: Removed session 7. Sep 16 04:49:32.506522 sshd[1900]: Accepted publickey for core from 10.0.0.1 port 59902 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:32.508063 sshd-session[1900]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:32.512498 systemd-logind[1446]: New session 8 of user core. Sep 16 04:49:32.522316 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 16 04:49:34.499798 systemd[1]: var-lib-docker-overlay2-3bbaa1a3c53ff229541de5ea025d740b77801db1425526dfdf85c62f55d811c4\x2dinit-merged.mount: Deactivated successfully. Sep 16 04:49:34.594856 containerd[1517]: time="2025-09-16T04:49:34.594774850Z" level=info msg="connecting to shim 6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb" address="unix:///run/containerd/s/7f7b14cd3b1844221fa263ba8db2db978e3ceccceb7773134baaee4e93ca65d3" namespace=moby protocol=ttrpc version=3 Sep 16 04:49:34.628406 systemd[1]: Started docker-6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb.scope - libcontainer container 6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb. Sep 16 04:49:34.802862 systemd-resolved[1346]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 16 04:49:34.837638 kernel: docker0: port 1(veth27c9ede) entered blocking state Sep 16 04:49:34.837748 kernel: docker0: port 1(veth27c9ede) entered disabled state Sep 16 04:49:34.837768 kernel: veth27c9ede: entered allmulticast mode Sep 16 04:49:34.839236 kernel: veth27c9ede: entered promiscuous mode Sep 16 04:49:34.839371 systemd-networkd[1432]: veth27c9ede: Link UP Sep 16 04:49:34.851204 kernel: eth0: renamed from veth1c4ef43 Sep 16 04:49:34.853848 kernel: docker0: port 1(veth27c9ede) entered blocking state Sep 16 04:49:34.853909 kernel: docker0: port 1(veth27c9ede) entered forwarding state Sep 16 04:49:34.853931 systemd-networkd[1432]: veth27c9ede: Gained carrier Sep 16 04:49:34.854721 systemd-networkd[1432]: docker0: Gained carrier Sep 16 04:49:34.905558 sshd[1903]: Connection closed by 10.0.0.1 port 59902 Sep 16 04:49:34.906004 sshd-session[1900]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:34.924976 systemd[1]: sshd@7-10.0.0.45:22-10.0.0.1:59902.service: Deactivated successfully. Sep 16 04:49:34.927308 systemd[1]: session-8.scope: Deactivated successfully. Sep 16 04:49:34.928219 systemd-logind[1446]: Session 8 logged out. Waiting for processes to exit. Sep 16 04:49:34.931216 systemd[1]: Started sshd@8-10.0.0.45:22-10.0.0.1:59906.service - OpenSSH per-connection server daemon (10.0.0.1:59906). Sep 16 04:49:34.932193 systemd-logind[1446]: Removed session 8. Sep 16 04:49:34.996689 sshd[1978]: Accepted publickey for core from 10.0.0.1 port 59906 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:34.998483 sshd-session[1978]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:35.004225 systemd-logind[1446]: New session 9 of user core. Sep 16 04:49:35.019475 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 16 04:49:35.085142 sshd[1982]: Connection closed by 10.0.0.1 port 59906 Sep 16 04:49:35.085690 sshd-session[1978]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:35.099378 systemd[1]: sshd@8-10.0.0.45:22-10.0.0.1:59906.service: Deactivated successfully. Sep 16 04:49:35.102124 systemd[1]: session-9.scope: Deactivated successfully. Sep 16 04:49:35.103265 systemd-logind[1446]: Session 9 logged out. Waiting for processes to exit. Sep 16 04:49:35.107207 systemd[1]: Started sshd@9-10.0.0.45:22-10.0.0.1:59910.service - OpenSSH per-connection server daemon (10.0.0.1:59910). Sep 16 04:49:35.107982 systemd-logind[1446]: Removed session 9. Sep 16 04:49:35.168139 sshd[1988]: Accepted publickey for core from 10.0.0.1 port 59910 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:35.169880 sshd-session[1988]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:35.175667 systemd-logind[1446]: New session 10 of user core. Sep 16 04:49:35.194511 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 16 04:49:35.254843 sudo[1992]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1517 Sep 16 04:49:35.255323 sudo[1992]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 16 04:49:35.262496 sudo[1992]: pam_unix(sudo:session): session closed for user root Sep 16 04:49:35.262705 containerd[1517]: time="2025-09-16T04:49:35.262636721Z" level=info msg="Stop CRI service" Sep 16 04:49:35.263802 dockerd[1688]: time="2025-09-16T04:49:35.263473356Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 16 04:49:35.263802 dockerd[1688]: time="2025-09-16T04:49:35.263541228Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 16 04:49:35.264587 dockerd[1688]: time="2025-09-16T04:49:35.264079301Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 16 04:49:35.264587 dockerd[1688]: time="2025-09-16T04:49:35.264104314Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 16 04:49:35.265394 sshd[1991]: Connection closed by 10.0.0.1 port 59910 Sep 16 04:49:35.265867 sshd-session[1988]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:35.278871 systemd[1]: containerd.service: Deactivated successfully. Sep 16 04:49:35.279037 systemd[1]: containerd.service: Unit process 1927 (containerd-shim) remains running after unit stopped. Sep 16 04:49:35.279420 systemd[1]: containerd.service: Consumed 698ms CPU time, 122.4M memory peak. Sep 16 04:49:35.279991 systemd[1]: sshd@9-10.0.0.45:22-10.0.0.1:59910.service: Deactivated successfully. Sep 16 04:49:35.282646 systemd[1]: session-10.scope: Deactivated successfully. Sep 16 04:49:35.284698 systemd-logind[1446]: Session 10 logged out. Waiting for processes to exit. Sep 16 04:49:35.288275 systemd[1]: Started sshd@10-10.0.0.45:22-10.0.0.1:59926.service - OpenSSH per-connection server daemon (10.0.0.1:59926). Sep 16 04:49:35.288952 systemd-logind[1446]: Removed session 10. Sep 16 04:49:35.349121 sshd[1999]: Accepted publickey for core from 10.0.0.1 port 59926 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:35.350604 sshd-session[1999]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:35.355152 systemd-logind[1446]: New session 11 of user core. Sep 16 04:49:35.366499 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 16 04:49:35.425994 sshd[2002]: Connection closed by 10.0.0.1 port 59926 Sep 16 04:49:35.426412 sshd-session[1999]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:35.430724 systemd[1]: sshd@10-10.0.0.45:22-10.0.0.1:59926.service: Deactivated successfully. Sep 16 04:49:35.432658 systemd[1]: session-11.scope: Deactivated successfully. Sep 16 04:49:35.433551 systemd-logind[1446]: Session 11 logged out. Waiting for processes to exit. Sep 16 04:49:35.434845 systemd-logind[1446]: Removed session 11. Sep 16 04:49:36.179402 systemd-networkd[1432]: docker0: Gained IPv6LL Sep 16 04:49:36.691396 systemd-networkd[1432]: veth27c9ede: Gained IPv6LL Sep 16 04:49:40.529844 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 16 04:49:40.530339 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 16 04:49:40.530664 dockerd[1688]: time="2025-09-16T04:49:40.530470673Z" level=info msg="Processing signal 'terminated'" Sep 16 04:49:41.482325 systemd[1]: Started sshd@11-10.0.0.45:22-10.0.0.1:49836.service - OpenSSH per-connection server daemon (10.0.0.1:49836). Sep 16 04:49:41.527006 sshd[2008]: Accepted publickey for core from 10.0.0.1 port 49836 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:41.529226 sshd-session[2008]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:41.534946 systemd-logind[1446]: New session 12 of user core. Sep 16 04:49:41.547456 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 16 04:49:41.606185 sshd[2011]: Connection closed by 10.0.0.1 port 49836 Sep 16 04:49:41.606681 sshd-session[2008]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:41.611592 systemd[1]: sshd@11-10.0.0.45:22-10.0.0.1:49836.service: Deactivated successfully. Sep 16 04:49:41.613913 systemd[1]: session-12.scope: Deactivated successfully. Sep 16 04:49:41.614888 systemd-logind[1446]: Session 12 logged out. Waiting for processes to exit. Sep 16 04:49:41.616330 systemd-logind[1446]: Removed session 12. Sep 16 04:49:47.646137 systemd[1]: Started sshd@12-10.0.0.45:22-10.0.0.1:49864.service - OpenSSH per-connection server daemon (10.0.0.1:49864). Sep 16 04:49:47.713198 sshd[2017]: Accepted publickey for core from 10.0.0.1 port 49864 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:47.715245 sshd-session[2017]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:47.720115 systemd-logind[1446]: New session 13 of user core. Sep 16 04:49:47.730340 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 16 04:49:47.788881 sshd[2020]: Connection closed by 10.0.0.1 port 49864 Sep 16 04:49:47.789203 sshd-session[2017]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:47.793591 systemd[1]: sshd@12-10.0.0.45:22-10.0.0.1:49864.service: Deactivated successfully. Sep 16 04:49:47.795610 systemd[1]: session-13.scope: Deactivated successfully. Sep 16 04:49:47.796523 systemd-logind[1446]: Session 13 logged out. Waiting for processes to exit. Sep 16 04:49:47.797818 systemd-logind[1446]: Removed session 13. Sep 16 04:49:53.819322 systemd[1]: Started sshd@13-10.0.0.45:22-10.0.0.1:39148.service - OpenSSH per-connection server daemon (10.0.0.1:39148). Sep 16 04:49:53.886705 sshd[2026]: Accepted publickey for core from 10.0.0.1 port 39148 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:49:53.888343 sshd-session[2026]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:49:53.893439 systemd-logind[1446]: New session 14 of user core. Sep 16 04:49:53.903686 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 16 04:49:53.962297 sshd[2029]: Connection closed by 10.0.0.1 port 39148 Sep 16 04:49:53.962693 sshd-session[2026]: pam_unix(sshd:session): session closed for user core Sep 16 04:49:53.968007 systemd[1]: sshd@13-10.0.0.45:22-10.0.0.1:39148.service: Deactivated successfully. Sep 16 04:49:53.970048 systemd[1]: session-14.scope: Deactivated successfully. Sep 16 04:49:53.970835 systemd-logind[1446]: Session 14 logged out. Waiting for processes to exit. Sep 16 04:49:53.972303 systemd-logind[1446]: Removed session 14. Sep 16 04:49:55.531631 dockerd[1688]: time="2025-09-16T04:49:55.531517945Z" level=error msg="Force shutdown daemon" Sep 16 04:49:55.532110 dockerd[1688]: time="2025-09-16T04:49:55.531776636Z" level=info msg="Daemon shutdown complete" Sep 16 04:49:55.532110 dockerd[1688]: time="2025-09-16T04:49:55.532041832Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: received context error while waiting for new LB policy update: context canceled" Sep 16 04:49:55.532110 dockerd[1688]: time="2025-09-16T04:49:55.532071014Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Sep 16 04:49:55.532276 dockerd[1688]: time="2025-09-16T04:49:55.532107865Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: received context error while waiting for new LB policy update: context canceled" Sep 16 04:49:55.537522 systemd[1]: docker.service: Deactivated successfully. Sep 16 04:49:55.537967 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 16 04:49:55.538055 systemd[1]: docker.service: Consumed 2.226s CPU time, 128M memory peak. Sep 16 04:49:55.538626 systemd[1]: docker.socket: Deactivated successfully. Sep 16 04:49:55.539026 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 16 04:49:55.539072 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 16 04:49:55.541408 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 16 04:49:55.541784 systemd[1]: containerd.service: Found left-over process 1927 (containerd-shim) in control group while starting unit. Ignoring. Sep 16 04:49:55.541795 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 16 04:49:55.548919 systemd[1]: Starting containerd.service - containerd container runtime... Sep 16 04:49:55.549587 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 16 04:49:55.566563 systemd[1]: containerd.service: Found left-over process 1927 (containerd-shim) in control group while starting unit. Ignoring. Sep 16 04:49:55.566579 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 16 04:49:55.572033 (ntainerd)[2040]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 16 04:49:55.592692 containerd[2040]: time="2025-09-16T04:49:55Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 16 04:49:55.593386 containerd[2040]: time="2025-09-16T04:49:55.593326243Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 16 04:49:55.602625 containerd[2040]: time="2025-09-16T04:49:55.602552136Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="15.599µs" Sep 16 04:49:55.602625 containerd[2040]: time="2025-09-16T04:49:55.602604435Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 16 04:49:55.602729 containerd[2040]: time="2025-09-16T04:49:55.602632424Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 16 04:49:55.602729 containerd[2040]: time="2025-09-16T04:49:55.602678058Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 16 04:49:55.602729 containerd[2040]: time="2025-09-16T04:49:55.602702949Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 16 04:49:55.602994 containerd[2040]: time="2025-09-16T04:49:55.602959584Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 16 04:49:55.602994 containerd[2040]: time="2025-09-16T04:49:55.602991493Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603058 containerd[2040]: time="2025-09-16T04:49:55.603002631Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603445 containerd[2040]: time="2025-09-16T04:49:55.603400095Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603445 containerd[2040]: time="2025-09-16T04:49:55.603425228Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603445 containerd[2040]: time="2025-09-16T04:49:55.603438159Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603445 containerd[2040]: time="2025-09-16T04:49:55.603448786Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603559 containerd[2040]: time="2025-09-16T04:49:55.603477587Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603621 containerd[2040]: time="2025-09-16T04:49:55.603591940Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603657 containerd[2040]: time="2025-09-16T04:49:55.603626225Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 16 04:49:55.603657 containerd[2040]: time="2025-09-16T04:49:55.603636260Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 16 04:49:55.603724 containerd[2040]: time="2025-09-16T04:49:55.603668339Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 16 04:49:55.604421 containerd[2040]: time="2025-09-16T04:49:55.604379961Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 16 04:49:55.604742 containerd[2040]: time="2025-09-16T04:49:55.604599976Z" level=info msg="metadata content store policy set" policy=shared Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.604981912Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605025780Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605039213Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605051234Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605063434Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605073398Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605084927Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605100385Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605110890Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605120825Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605131011Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 16 04:49:55.605193 containerd[2040]: time="2025-09-16T04:49:55.605143582Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 16 04:49:55.605516 containerd[2040]: time="2025-09-16T04:49:55.605415094Z" level=info msg="connecting to shim 6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb" address="unix:///run/containerd/s/7f7b14cd3b1844221fa263ba8db2db978e3ceccceb7773134baaee4e93ca65d3" namespace=moby protocol=ttrpc version=3 Sep 16 04:49:55.615967 containerd[2040]: time="2025-09-16T04:49:55.615900075Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 16 04:49:55.615967 containerd[2040]: time="2025-09-16T04:49:55.615977788Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616011140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616028824Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616047961Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616063269Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616084081Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616100050Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 16 04:49:55.616124 containerd[2040]: time="2025-09-16T04:49:55.616115789Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 16 04:49:55.616331 containerd[2040]: time="2025-09-16T04:49:55.616129533Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 16 04:49:55.616331 containerd[2040]: time="2025-09-16T04:49:55.616142515Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 16 04:49:55.616331 containerd[2040]: time="2025-09-16T04:49:55.616250242Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 16 04:49:55.616331 containerd[2040]: time="2025-09-16T04:49:55.616271605Z" level=info msg="Start snapshots syncer" Sep 16 04:49:55.616331 containerd[2040]: time="2025-09-16T04:49:55.616317890Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 16 04:49:55.616669 containerd[2040]: time="2025-09-16T04:49:55.616614684Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 16 04:49:55.616780 containerd[2040]: time="2025-09-16T04:49:55.616701961Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 16 04:49:55.616845 containerd[2040]: time="2025-09-16T04:49:55.616823582Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 16 04:49:55.616943 containerd[2040]: time="2025-09-16T04:49:55.616918587Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 16 04:49:55.617008 containerd[2040]: time="2025-09-16T04:49:55.616946776Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 16 04:49:55.617008 containerd[2040]: time="2025-09-16T04:49:55.616962947Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 16 04:49:55.617008 containerd[2040]: time="2025-09-16T04:49:55.616975347Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 16 04:49:55.617008 containerd[2040]: time="2025-09-16T04:49:55.616993492Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 16 04:49:55.617008 containerd[2040]: time="2025-09-16T04:49:55.617007798Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617023677Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617052799Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617065351Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617077921Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617117038Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617133379Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 16 04:49:55.617143 containerd[2040]: time="2025-09-16T04:49:55.617144085Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617157578Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617186901Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617201126Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617214579Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617242438Z" level=info msg="runtime interface created" Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617249205Z" level=info msg="created NRI interface" Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617265816Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617278408Z" level=info msg="Connect containerd service" Sep 16 04:49:55.617312 containerd[2040]: time="2025-09-16T04:49:55.617306578Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 16 04:49:55.618030 containerd[2040]: time="2025-09-16T04:49:55.617988485Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 16 04:49:55.630093 containerd[2040]: time="2025-09-16T04:49:55.629918013Z" level=info msg="Start subscribing containerd event" Sep 16 04:49:55.630093 containerd[2040]: time="2025-09-16T04:49:55.630000758Z" level=info msg="Start recovering state" Sep 16 04:49:55.630093 containerd[2040]: time="2025-09-16T04:49:55.630119653Z" level=info msg="Start event monitor" Sep 16 04:49:55.630392 containerd[2040]: time="2025-09-16T04:49:55.630138228Z" level=info msg="Start cni network conf syncer for default" Sep 16 04:49:55.630392 containerd[2040]: time="2025-09-16T04:49:55.630151642Z" level=info msg="Start streaming server" Sep 16 04:49:55.630392 containerd[2040]: time="2025-09-16T04:49:55.630207991Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 16 04:49:55.630392 containerd[2040]: time="2025-09-16T04:49:55.630220402Z" level=info msg="runtime interface starting up..." Sep 16 04:49:55.630392 containerd[2040]: time="2025-09-16T04:49:55.630228552Z" level=info msg="starting plugins..." Sep 16 04:49:55.630392 containerd[2040]: time="2025-09-16T04:49:55.630243880Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 16 04:49:55.630654 containerd[2040]: time="2025-09-16T04:49:55.630612513Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 16 04:49:55.630696 containerd[2040]: time="2025-09-16T04:49:55.630683790Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 16 04:49:55.630955 systemd[1]: Started containerd.service - containerd container runtime. Sep 16 04:49:55.632316 containerd[2040]: time="2025-09-16T04:49:55.632264052Z" level=info msg="containerd successfully booted in 0.039784s" Sep 16 04:49:55.633766 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 16 04:49:55.652890 (dockerd)[2069]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 16 04:49:55.696951 dockerd[2069]: time="2025-09-16T04:49:55.696845014Z" level=info msg="Starting up" Sep 16 04:49:55.698371 dockerd[2069]: time="2025-09-16T04:49:55.698329911Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 16 04:49:55.714681 dockerd[2069]: time="2025-09-16T04:49:55.714576909Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 16 04:49:55.748533 dockerd[2069]: time="2025-09-16T04:49:55.748468344Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 16 04:49:55.773995 dockerd[2069]: time="2025-09-16T04:49:55.773923142Z" level=info msg="Loading containers: start." Sep 16 04:49:59.984744 systemd[1]: Started sshd@14-10.0.0.45:22-10.0.0.1:35696.service - OpenSSH per-connection server daemon (10.0.0.1:35696). Sep 16 04:50:00.047976 sshd[2100]: Accepted publickey for core from 10.0.0.1 port 35696 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:00.049859 sshd-session[2100]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:00.054883 systemd-logind[1446]: New session 15 of user core. Sep 16 04:50:00.070353 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 16 04:50:00.131965 sshd[2103]: Connection closed by 10.0.0.1 port 35696 Sep 16 04:50:00.132372 sshd-session[2100]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:00.142386 systemd[1]: sshd@14-10.0.0.45:22-10.0.0.1:35696.service: Deactivated successfully. Sep 16 04:50:00.145065 systemd[1]: session-15.scope: Deactivated successfully. Sep 16 04:50:00.146245 systemd-logind[1446]: Session 15 logged out. Waiting for processes to exit. Sep 16 04:50:00.149970 systemd[1]: Started sshd@15-10.0.0.45:22-10.0.0.1:35708.service - OpenSSH per-connection server daemon (10.0.0.1:35708). Sep 16 04:50:00.150604 systemd-logind[1446]: Removed session 15. Sep 16 04:50:00.210214 sshd[2109]: Accepted publickey for core from 10.0.0.1 port 35708 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:00.211583 sshd-session[2109]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:00.217266 systemd-logind[1446]: New session 16 of user core. Sep 16 04:50:00.235487 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 16 04:50:00.293140 sshd[2112]: Connection closed by 10.0.0.1 port 35708 Sep 16 04:50:00.293676 sshd-session[2109]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:00.313412 systemd[1]: sshd@15-10.0.0.45:22-10.0.0.1:35708.service: Deactivated successfully. Sep 16 04:50:00.315931 systemd[1]: session-16.scope: Deactivated successfully. Sep 16 04:50:00.316792 systemd-logind[1446]: Session 16 logged out. Waiting for processes to exit. Sep 16 04:50:00.320624 systemd[1]: Started sshd@16-10.0.0.45:22-10.0.0.1:35714.service - OpenSSH per-connection server daemon (10.0.0.1:35714). Sep 16 04:50:00.321478 systemd-logind[1446]: Removed session 16. Sep 16 04:50:00.379245 sshd[2118]: Accepted publickey for core from 10.0.0.1 port 35714 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:00.380531 sshd-session[2118]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:00.385534 systemd-logind[1446]: New session 17 of user core. Sep 16 04:50:00.395339 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 16 04:50:05.808939 dockerd[2069]: time="2025-09-16T04:50:05.808809393Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb Sep 16 04:50:05.822924 systemd[1]: docker-6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb.scope: Deactivated successfully. Sep 16 04:50:05.840452 containerd[2040]: time="2025-09-16T04:50:05.840152317Z" level=info msg="shim disconnected" id=6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb namespace=moby Sep 16 04:50:05.840452 containerd[2040]: time="2025-09-16T04:50:05.840212778Z" level=warning msg="cleaning up after shim disconnected" id=6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb namespace=moby Sep 16 04:50:05.840452 containerd[2040]: time="2025-09-16T04:50:05.840222531Z" level=info msg="cleaning up dead shim" namespace=moby Sep 16 04:50:05.840940 dockerd[2069]: time="2025-09-16T04:50:05.840393789Z" level=info msg="ignoring event" container=6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 16 04:50:05.861023 systemd[1]: var-lib-docker-overlay2-3bbaa1a3c53ff229541de5ea025d740b77801db1425526dfdf85c62f55d811c4-merged.mount: Deactivated successfully. Sep 16 04:50:06.384295 kernel: docker0: port 1(veth27c9ede) entered disabled state Sep 16 04:50:06.384449 kernel: veth27c9ede (unregistering): left allmulticast mode Sep 16 04:50:06.380861 systemd-networkd[1432]: veth27c9ede: Link DOWN Sep 16 04:50:06.380874 systemd-networkd[1432]: veth27c9ede: Lost carrier Sep 16 04:50:06.382631 systemd[1]: run-docker-netns-e9d5c03ea719.mount: Deactivated successfully. Sep 16 04:50:06.385833 kernel: veth27c9ede (unregistering): left promiscuous mode Sep 16 04:50:06.385879 kernel: docker0: port 1(veth27c9ede) entered disabled state Sep 16 04:50:06.387937 systemd-networkd[1432]: docker0: Lost carrier Sep 16 04:50:06.390711 dockerd[2069]: time="2025-09-16T04:50:06.390657921Z" level=info msg="Removing stale sandbox e9d5c03ea719c013df3f6b98d1b3dc59bc9ab564c0d24343cee0d4554541dc62 (6144d2ff91f5e3d967809a0976dc09d8767b144a08533c95563adb5223eadfbb)" Sep 16 04:50:06.521637 dockerd[2069]: time="2025-09-16T04:50:06.521385437Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 16 04:50:06.521637 dockerd[2069]: time="2025-09-16T04:50:06.521655459Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 06b8a067553cd5d0a34fcda9882206aa141ebea3a2eb96f289c6cb2dfd2fdd4a 20e4084e4c02a1ee977b00b6de1eb7b667312a44939e8ad8eaeb4ba29a4e4b8d], retrying...." Sep 16 04:50:06.584755 systemd[1]: run-docker-netns-e9d5c03ea719.mount: Deactivated successfully. Sep 16 04:50:06.831397 dockerd[2069]: time="2025-09-16T04:50:06.831316014Z" level=warning msg="error locating sandbox id e9d5c03ea719c013df3f6b98d1b3dc59bc9ab564c0d24343cee0d4554541dc62: sandbox e9d5c03ea719c013df3f6b98d1b3dc59bc9ab564c0d24343cee0d4554541dc62 not found" Sep 16 04:50:06.831944 dockerd[2069]: time="2025-09-16T04:50:06.831501351Z" level=info msg="Loading containers: done." Sep 16 04:50:06.849349 dockerd[2069]: time="2025-09-16T04:50:06.849277171Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 16 04:50:06.849607 dockerd[2069]: time="2025-09-16T04:50:06.849391876Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 16 04:50:06.849607 dockerd[2069]: time="2025-09-16T04:50:06.849439155Z" level=info msg="Initializing buildkit" Sep 16 04:50:06.861119 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2564642404-merged.mount: Deactivated successfully. Sep 16 04:50:06.870263 dockerd[2069]: time="2025-09-16T04:50:06.870190538Z" level=info msg="Completed buildkit initialization" Sep 16 04:50:06.875478 dockerd[2069]: time="2025-09-16T04:50:06.875396593Z" level=info msg="Daemon has completed initialization" Sep 16 04:50:06.875714 dockerd[2069]: time="2025-09-16T04:50:06.875505634Z" level=info msg="API listen on /run/docker.sock" Sep 16 04:50:06.875723 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 16 04:50:06.886618 sshd[2121]: Connection closed by 10.0.0.1 port 35714 Sep 16 04:50:06.887186 sshd-session[2118]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:06.899293 systemd[1]: sshd@16-10.0.0.45:22-10.0.0.1:35714.service: Deactivated successfully. Sep 16 04:50:06.902100 systemd[1]: session-17.scope: Deactivated successfully. Sep 16 04:50:06.903248 systemd-logind[1446]: Session 17 logged out. Waiting for processes to exit. Sep 16 04:50:06.907380 systemd[1]: Started sshd@17-10.0.0.45:22-10.0.0.1:35718.service - OpenSSH per-connection server daemon (10.0.0.1:35718). Sep 16 04:50:06.908790 systemd-logind[1446]: Removed session 17. Sep 16 04:50:06.964569 sshd[2371]: Accepted publickey for core from 10.0.0.1 port 35718 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:06.966505 sshd-session[2371]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:06.972713 systemd-logind[1446]: New session 18 of user core. Sep 16 04:50:06.990496 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 16 04:50:07.073114 systemd[1]: var-lib-docker-overlay2-e7019fbd714a2cde316d8a3137d7873b5ed40b7f2639b48779421a4898bf05a3\x2dinit-merged.mount: Deactivated successfully. Sep 16 04:50:07.117580 containerd[2040]: time="2025-09-16T04:50:07.117218556Z" level=info msg="connecting to shim 7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff" address="unix:///run/containerd/s/7423dbb915c6df83ea959732f74e5653b980be220a8b0da784182d08e5d37512" namespace=moby protocol=ttrpc version=3 Sep 16 04:50:07.156519 systemd[1]: Started docker-7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff.scope - libcontainer container 7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff. Sep 16 04:50:07.171542 systemd-resolved[1346]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 16 04:50:07.198233 kernel: docker0: port 1(vethd26eb00) entered blocking state Sep 16 04:50:07.198345 kernel: docker0: port 1(vethd26eb00) entered disabled state Sep 16 04:50:07.200795 kernel: vethd26eb00: entered allmulticast mode Sep 16 04:50:07.200859 kernel: vethd26eb00: entered promiscuous mode Sep 16 04:50:07.201161 systemd-networkd[1432]: vethd26eb00: Link UP Sep 16 04:50:07.213233 kernel: eth0: renamed from vetha868ef3 Sep 16 04:50:07.215211 kernel: docker0: port 1(vethd26eb00) entered blocking state Sep 16 04:50:07.215311 kernel: docker0: port 1(vethd26eb00) entered forwarding state Sep 16 04:50:07.216194 systemd-networkd[1432]: vethd26eb00: Gained carrier Sep 16 04:50:07.216556 systemd-networkd[1432]: docker0: Gained carrier Sep 16 04:50:07.253697 sshd[2374]: Connection closed by 10.0.0.1 port 35718 Sep 16 04:50:07.254397 sshd-session[2371]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:07.267694 systemd[1]: sshd@17-10.0.0.45:22-10.0.0.1:35718.service: Deactivated successfully. Sep 16 04:50:07.270344 systemd[1]: session-18.scope: Deactivated successfully. Sep 16 04:50:07.271466 systemd-logind[1446]: Session 18 logged out. Waiting for processes to exit. Sep 16 04:50:07.273888 systemd-logind[1446]: Removed session 18. Sep 16 04:50:07.275715 systemd[1]: Started sshd@18-10.0.0.45:22-10.0.0.1:35722.service - OpenSSH per-connection server daemon (10.0.0.1:35722). Sep 16 04:50:07.330192 sshd[2443]: Accepted publickey for core from 10.0.0.1 port 35722 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:07.332295 sshd-session[2443]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:07.337930 systemd-logind[1446]: New session 19 of user core. Sep 16 04:50:07.347415 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 16 04:50:07.408748 sshd[2446]: Connection closed by 10.0.0.1 port 35722 Sep 16 04:50:07.409257 sshd-session[2443]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:07.420997 systemd[1]: sshd@18-10.0.0.45:22-10.0.0.1:35722.service: Deactivated successfully. Sep 16 04:50:07.423356 systemd[1]: session-19.scope: Deactivated successfully. Sep 16 04:50:07.424322 systemd-logind[1446]: Session 19 logged out. Waiting for processes to exit. Sep 16 04:50:07.428468 systemd[1]: Started sshd@19-10.0.0.45:22-10.0.0.1:35728.service - OpenSSH per-connection server daemon (10.0.0.1:35728). Sep 16 04:50:07.429034 systemd-logind[1446]: Removed session 19. Sep 16 04:50:07.489476 sshd[2452]: Accepted publickey for core from 10.0.0.1 port 35728 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:07.491091 sshd-session[2452]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:07.497666 systemd-logind[1446]: New session 20 of user core. Sep 16 04:50:07.506551 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 16 04:50:07.564386 sudo[2456]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2040 Sep 16 04:50:07.564809 sudo[2456]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 16 04:50:07.569480 sudo[2456]: pam_unix(sudo:session): session closed for user root Sep 16 04:50:07.571383 sshd[2455]: Connection closed by 10.0.0.1 port 35728 Sep 16 04:50:07.572352 sshd-session[2452]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:07.574814 dockerd[2069]: time="2025-09-16T04:50:07.574742663Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 16 04:50:07.574814 dockerd[2069]: time="2025-09-16T04:50:07.574790743Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 16 04:50:07.575966 dockerd[2069]: time="2025-09-16T04:50:07.575906030Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 16 04:50:07.575966 dockerd[2069]: time="2025-09-16T04:50:07.575958651Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 16 04:50:07.586157 systemd[1]: containerd.service: Deactivated successfully. Sep 16 04:50:07.586365 systemd[1]: containerd.service: Unit process 2393 (containerd-shim) remains running after unit stopped. Sep 16 04:50:07.586750 systemd[1]: containerd.service: Consumed 262ms CPU time, 125.5M memory peak. Sep 16 04:50:07.587417 systemd[1]: sshd@19-10.0.0.45:22-10.0.0.1:35728.service: Deactivated successfully. Sep 16 04:50:07.589362 systemd[1]: session-20.scope: Deactivated successfully. Sep 16 04:50:07.590333 systemd-logind[1446]: Session 20 logged out. Waiting for processes to exit. Sep 16 04:50:07.594602 systemd[1]: Started sshd@20-10.0.0.45:22-10.0.0.1:35740.service - OpenSSH per-connection server daemon (10.0.0.1:35740). Sep 16 04:50:07.595481 systemd-logind[1446]: Removed session 20. Sep 16 04:50:07.651326 sshd[2463]: Accepted publickey for core from 10.0.0.1 port 35740 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:07.653429 sshd-session[2463]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:07.660576 systemd-logind[1446]: New session 21 of user core. Sep 16 04:50:07.674542 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 16 04:50:07.733555 sshd[2466]: Connection closed by 10.0.0.1 port 35740 Sep 16 04:50:07.733951 sshd-session[2463]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:07.739732 systemd[1]: sshd@20-10.0.0.45:22-10.0.0.1:35740.service: Deactivated successfully. Sep 16 04:50:07.742576 systemd[1]: session-21.scope: Deactivated successfully. Sep 16 04:50:07.743615 systemd-logind[1446]: Session 21 logged out. Waiting for processes to exit. Sep 16 04:50:07.745639 systemd-logind[1446]: Removed session 21. Sep 16 04:50:08.883861 systemd-networkd[1432]: vethd26eb00: Gained IPv6LL Sep 16 04:50:09.249099 update_engine[1447]: I20250916 04:50:09.248802 1447 update_attempter.cc:509] Updating boot flags... Sep 16 04:50:12.772725 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 16 04:50:12.773222 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 16 04:50:12.774198 dockerd[2069]: time="2025-09-16T04:50:12.774127268Z" level=info msg="Processing signal 'terminated'" Sep 16 04:50:13.753845 systemd[1]: Started sshd@21-10.0.0.45:22-10.0.0.1:41600.service - OpenSSH per-connection server daemon (10.0.0.1:41600). Sep 16 04:50:13.813196 sshd[2483]: Accepted publickey for core from 10.0.0.1 port 41600 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:13.815089 sshd-session[2483]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:13.820400 systemd-logind[1446]: New session 22 of user core. Sep 16 04:50:13.832557 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 16 04:50:13.892062 sshd[2486]: Connection closed by 10.0.0.1 port 41600 Sep 16 04:50:13.892431 sshd-session[2483]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:13.896779 systemd[1]: sshd@21-10.0.0.45:22-10.0.0.1:41600.service: Deactivated successfully. Sep 16 04:50:13.898906 systemd[1]: session-22.scope: Deactivated successfully. Sep 16 04:50:13.899834 systemd-logind[1446]: Session 22 logged out. Waiting for processes to exit. Sep 16 04:50:13.901154 systemd-logind[1446]: Removed session 22. Sep 16 04:50:14.775518 dockerd[2069]: time="2025-09-16T04:50:14.775343051Z" level=error msg="Error sending stop (signal 15) to container" container=7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff error="Cannot kill container 7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Sep 16 04:50:14.775518 dockerd[2069]: time="2025-09-16T04:50:14.775454673Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff Sep 16 04:50:19.913858 systemd[1]: Started sshd@22-10.0.0.45:22-10.0.0.1:37254.service - OpenSSH per-connection server daemon (10.0.0.1:37254). Sep 16 04:50:19.979017 sshd[2492]: Accepted publickey for core from 10.0.0.1 port 37254 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:19.980595 sshd-session[2492]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:19.986005 systemd-logind[1446]: New session 23 of user core. Sep 16 04:50:19.995362 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 16 04:50:20.052023 sshd[2495]: Connection closed by 10.0.0.1 port 37254 Sep 16 04:50:20.052377 sshd-session[2492]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:20.056257 systemd[1]: sshd@22-10.0.0.45:22-10.0.0.1:37254.service: Deactivated successfully. Sep 16 04:50:20.058188 systemd[1]: session-23.scope: Deactivated successfully. Sep 16 04:50:20.058916 systemd-logind[1446]: Session 23 logged out. Waiting for processes to exit. Sep 16 04:50:20.060126 systemd-logind[1446]: Removed session 23. Sep 16 04:50:24.776913 dockerd[2069]: time="2025-09-16T04:50:24.776763479Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff error="context deadline exceeded" Sep 16 04:50:24.778561 systemd[1]: docker-7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff.scope: Deactivated successfully. Sep 16 04:50:26.070634 systemd[1]: Started sshd@23-10.0.0.45:22-10.0.0.1:37266.service - OpenSSH per-connection server daemon (10.0.0.1:37266). Sep 16 04:50:26.125940 sshd[2501]: Accepted publickey for core from 10.0.0.1 port 37266 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:26.128084 sshd-session[2501]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:26.133675 systemd-logind[1446]: New session 24 of user core. Sep 16 04:50:26.143465 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 16 04:50:26.202768 sshd[2504]: Connection closed by 10.0.0.1 port 37266 Sep 16 04:50:26.203060 sshd-session[2501]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:26.209300 systemd[1]: sshd@23-10.0.0.45:22-10.0.0.1:37266.service: Deactivated successfully. Sep 16 04:50:26.211472 systemd[1]: session-24.scope: Deactivated successfully. Sep 16 04:50:26.212524 systemd-logind[1446]: Session 24 logged out. Waiting for processes to exit. Sep 16 04:50:26.213854 systemd-logind[1446]: Removed session 24. Sep 16 04:50:27.775509 dockerd[2069]: time="2025-09-16T04:50:27.775391039Z" level=error msg="Force shutdown daemon" Sep 16 04:50:27.776098 dockerd[2069]: time="2025-09-16T04:50:27.775673978Z" level=info msg="Daemon shutdown complete" Sep 16 04:50:27.785746 systemd[1]: docker.service: Deactivated successfully. Sep 16 04:50:27.786314 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 16 04:50:27.787033 systemd[1]: docker.socket: Deactivated successfully. Sep 16 04:50:27.787634 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 16 04:50:27.787702 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 16 04:50:27.790223 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 16 04:50:27.790537 systemd[1]: containerd.service: Found left-over process 2393 (containerd-shim) in control group while starting unit. Ignoring. Sep 16 04:50:27.790549 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 16 04:50:27.796762 systemd[1]: Starting containerd.service - containerd container runtime... Sep 16 04:50:27.797854 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 16 04:50:27.814553 systemd[1]: containerd.service: Found left-over process 2393 (containerd-shim) in control group while starting unit. Ignoring. Sep 16 04:50:27.814568 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 16 04:50:27.829681 (ntainerd)[2515]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 16 04:50:27.855805 containerd[2515]: time="2025-09-16T04:50:27Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 16 04:50:27.856545 containerd[2515]: time="2025-09-16T04:50:27.856503395Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 16 04:50:27.868404 containerd[2515]: time="2025-09-16T04:50:27.868306235Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="20.632µs" Sep 16 04:50:27.868404 containerd[2515]: time="2025-09-16T04:50:27.868369545Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 16 04:50:27.868404 containerd[2515]: time="2025-09-16T04:50:27.868396038Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 16 04:50:27.868681 containerd[2515]: time="2025-09-16T04:50:27.868461984Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 16 04:50:27.868681 containerd[2515]: time="2025-09-16T04:50:27.868480301Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 16 04:50:27.868868 containerd[2515]: time="2025-09-16T04:50:27.868827071Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 16 04:50:27.868921 containerd[2515]: time="2025-09-16T04:50:27.868876814Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 16 04:50:27.868921 containerd[2515]: time="2025-09-16T04:50:27.868894690Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869440 containerd[2515]: time="2025-09-16T04:50:27.869398982Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869440 containerd[2515]: time="2025-09-16T04:50:27.869426850Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869523 containerd[2515]: time="2025-09-16T04:50:27.869442071Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869523 containerd[2515]: time="2025-09-16T04:50:27.869455759Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869584 containerd[2515]: time="2025-09-16T04:50:27.869519940Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869707 containerd[2515]: time="2025-09-16T04:50:27.869679137Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869756 containerd[2515]: time="2025-09-16T04:50:27.869730862Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 16 04:50:27.869756 containerd[2515]: time="2025-09-16T04:50:27.869752777Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 16 04:50:27.869842 containerd[2515]: time="2025-09-16T04:50:27.869815105Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 16 04:50:27.870294 containerd[2515]: time="2025-09-16T04:50:27.870207919Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 16 04:50:27.870341 containerd[2515]: time="2025-09-16T04:50:27.870311010Z" level=info msg="metadata content store policy set" policy=shared Sep 16 04:50:27.870606 containerd[2515]: time="2025-09-16T04:50:27.870574771Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 16 04:50:27.870660 containerd[2515]: time="2025-09-16T04:50:27.870629122Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 16 04:50:27.870660 containerd[2515]: time="2025-09-16T04:50:27.870644022Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 16 04:50:27.870660 containerd[2515]: time="2025-09-16T04:50:27.870656618Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870673312Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870685627Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870699826Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870715939Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870727533Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870738616Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870749358Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 16 04:50:27.870764 containerd[2515]: time="2025-09-16T04:50:27.870767024Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 16 04:50:27.871240 containerd[2515]: time="2025-09-16T04:50:27.871195060Z" level=info msg="connecting to shim 7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff" address="unix:///run/containerd/s/7423dbb915c6df83ea959732f74e5653b980be220a8b0da784182d08e5d37512" namespace=moby protocol=ttrpc version=3 Sep 16 04:50:27.884927 containerd[2515]: time="2025-09-16T04:50:27.884861446Z" level=info msg="cleaning leaked shim process" id=7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff namespace=moby Sep 16 04:50:27.900485 containerd[2515]: time="2025-09-16T04:50:27.900389052Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 16 04:50:27.900982 containerd[2515]: time="2025-09-16T04:50:27.900851569Z" level=info msg="shim disconnected" id=7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff namespace=moby Sep 16 04:50:27.900982 containerd[2515]: time="2025-09-16T04:50:27.900975253Z" level=warning msg="cleaning up after shim disconnected" id=7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff namespace=moby Sep 16 04:50:27.900982 containerd[2515]: time="2025-09-16T04:50:27.900989592Z" level=info msg="cleaning up dead shim" namespace=moby Sep 16 04:50:27.918067 containerd[2515]: time="2025-09-16T04:50:27.918007550Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 16 04:50:27.918067 containerd[2515]: time="2025-09-16T04:50:27.918068645Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 16 04:50:27.918067 containerd[2515]: time="2025-09-16T04:50:27.918099057Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918114008Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918127105Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918139039Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918151214Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918162096Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918197068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918208552Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918219284Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 16 04:50:27.918325 containerd[2515]: time="2025-09-16T04:50:27.918325391Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 16 04:50:27.918541 containerd[2515]: time="2025-09-16T04:50:27.918341243Z" level=info msg="Start snapshots syncer" Sep 16 04:50:27.918541 containerd[2515]: time="2025-09-16T04:50:27.918381305Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 16 04:50:27.918669 containerd[2515]: time="2025-09-16T04:50:27.918632249Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 16 04:50:27.918783 containerd[2515]: time="2025-09-16T04:50:27.918688484Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 16 04:50:27.918783 containerd[2515]: time="2025-09-16T04:50:27.918773439Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 16 04:50:27.918846 containerd[2515]: time="2025-09-16T04:50:27.918817730Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 16 04:50:27.918872 containerd[2515]: time="2025-09-16T04:50:27.918854585Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 16 04:50:27.918905 containerd[2515]: time="2025-09-16T04:50:27.918879165Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 16 04:50:27.918905 containerd[2515]: time="2025-09-16T04:50:27.918890328Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 16 04:50:27.918905 containerd[2515]: time="2025-09-16T04:50:27.918905549Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 16 04:50:27.918987 containerd[2515]: time="2025-09-16T04:50:27.918918435Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 16 04:50:27.918987 containerd[2515]: time="2025-09-16T04:50:27.918930229Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 16 04:50:27.918987 containerd[2515]: time="2025-09-16T04:50:27.918963768Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 16 04:50:27.918987 containerd[2515]: time="2025-09-16T04:50:27.918974480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 16 04:50:27.918987 containerd[2515]: time="2025-09-16T04:50:27.918985092Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919033772Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919049815Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919058582Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919068653Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919077050Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919095799Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 16 04:50:27.919113 containerd[2515]: time="2025-09-16T04:50:27.919108154Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 16 04:50:27.919295 containerd[2515]: time="2025-09-16T04:50:27.919139337Z" level=info msg="runtime interface created" Sep 16 04:50:27.919295 containerd[2515]: time="2025-09-16T04:50:27.919145350Z" level=info msg="created NRI interface" Sep 16 04:50:27.919295 containerd[2515]: time="2025-09-16T04:50:27.919198528Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 16 04:50:27.919295 containerd[2515]: time="2025-09-16T04:50:27.919213570Z" level=info msg="Connect containerd service" Sep 16 04:50:27.919295 containerd[2515]: time="2025-09-16T04:50:27.919236917Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 16 04:50:27.919881 containerd[2515]: time="2025-09-16T04:50:27.919842057Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 16 04:50:27.933375 containerd[2515]: time="2025-09-16T04:50:27.933280946Z" level=info msg="Start subscribing containerd event" Sep 16 04:50:27.933375 containerd[2515]: time="2025-09-16T04:50:27.933364327Z" level=info msg="Start recovering state" Sep 16 04:50:27.933623 containerd[2515]: time="2025-09-16T04:50:27.933556089Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 16 04:50:27.933770 containerd[2515]: time="2025-09-16T04:50:27.933560829Z" level=info msg="Start event monitor" Sep 16 04:50:27.933770 containerd[2515]: time="2025-09-16T04:50:27.933694503Z" level=info msg="Start cni network conf syncer for default" Sep 16 04:50:27.933770 containerd[2515]: time="2025-09-16T04:50:27.933723302Z" level=info msg="Start streaming server" Sep 16 04:50:27.933770 containerd[2515]: time="2025-09-16T04:50:27.933661645Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 16 04:50:27.933770 containerd[2515]: time="2025-09-16T04:50:27.933768284Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 16 04:50:27.933963 containerd[2515]: time="2025-09-16T04:50:27.933781491Z" level=info msg="runtime interface starting up..." Sep 16 04:50:27.933963 containerd[2515]: time="2025-09-16T04:50:27.933795500Z" level=info msg="starting plugins..." Sep 16 04:50:27.933963 containerd[2515]: time="2025-09-16T04:50:27.933834730Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 16 04:50:27.934196 containerd[2515]: time="2025-09-16T04:50:27.934141027Z" level=info msg="containerd successfully booted in 0.078643s" Sep 16 04:50:27.934321 systemd[1]: Started containerd.service - containerd container runtime. Sep 16 04:50:27.937277 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 16 04:50:27.960668 (dockerd)[2565]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 16 04:50:27.996551 dockerd[2565]: time="2025-09-16T04:50:27.996466353Z" level=info msg="Starting up" Sep 16 04:50:27.997368 dockerd[2565]: time="2025-09-16T04:50:27.997345373Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 16 04:50:28.010352 dockerd[2565]: time="2025-09-16T04:50:28.010302063Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 16 04:50:28.026361 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport1608886237-merged.mount: Deactivated successfully. Sep 16 04:50:28.039877 dockerd[2565]: time="2025-09-16T04:50:28.039813466Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 16 04:50:28.064944 dockerd[2565]: time="2025-09-16T04:50:28.064867949Z" level=info msg="Loading containers: start." Sep 16 04:50:28.085759 systemd[1]: var-lib-docker-overlay2-e7019fbd714a2cde316d8a3137d7873b5ed40b7f2639b48779421a4898bf05a3-merged.mount: Deactivated successfully. Sep 16 04:50:28.568683 systemd-networkd[1432]: vethd26eb00: Link DOWN Sep 16 04:50:28.568692 systemd-networkd[1432]: vethd26eb00: Lost carrier Sep 16 04:50:28.569853 kernel: docker0: port 1(vethd26eb00) entered disabled state Sep 16 04:50:28.569915 kernel: vethd26eb00 (unregistering): left allmulticast mode Sep 16 04:50:28.569935 kernel: vethd26eb00 (unregistering): left promiscuous mode Sep 16 04:50:28.571576 kernel: docker0: port 1(vethd26eb00) entered disabled state Sep 16 04:50:28.572374 systemd-networkd[1432]: docker0: Lost carrier Sep 16 04:50:28.574230 dockerd[2565]: time="2025-09-16T04:50:28.574155843Z" level=info msg="Removing stale sandbox 86031c3a733e44bc601bbd8f0fcaa71d9fa3cf8333ab6d1bf229fd4d9846e604 (7373c4f3ff4daaf0812a4b5f16e8ee18c32f64b0f979f7ea698d3f255a064dff)" Sep 16 04:50:28.580561 dockerd[2565]: time="2025-09-16T04:50:28.580512084Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 16 04:50:28.580638 dockerd[2565]: time="2025-09-16T04:50:28.580558999Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint ad739f35022707868fb7a0c8ef70bdb271c18fbce4eff1b3b51adc336f47073b 28e36e7a2590fe2a9e8c91a484b64c921d3f7ad2b2ce1beb3d443750537f2fdc], retrying...." Sep 16 04:50:28.787658 dockerd[2565]: time="2025-09-16T04:50:28.787564762Z" level=warning msg="error locating sandbox id 86031c3a733e44bc601bbd8f0fcaa71d9fa3cf8333ab6d1bf229fd4d9846e604: sandbox 86031c3a733e44bc601bbd8f0fcaa71d9fa3cf8333ab6d1bf229fd4d9846e604 not found" Sep 16 04:50:28.787658 dockerd[2565]: time="2025-09-16T04:50:28.787628944Z" level=warning msg="error locating sandbox id e9d5c03ea719c013df3f6b98d1b3dc59bc9ab564c0d24343cee0d4554541dc62: sandbox e9d5c03ea719c013df3f6b98d1b3dc59bc9ab564c0d24343cee0d4554541dc62 not found" Sep 16 04:50:28.787902 dockerd[2565]: time="2025-09-16T04:50:28.787872682Z" level=info msg="Loading containers: done." Sep 16 04:50:28.805605 dockerd[2565]: time="2025-09-16T04:50:28.805538998Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 16 04:50:28.805817 dockerd[2565]: time="2025-09-16T04:50:28.805656327Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 16 04:50:28.805817 dockerd[2565]: time="2025-09-16T04:50:28.805702312Z" level=info msg="Initializing buildkit" Sep 16 04:50:28.825234 dockerd[2565]: time="2025-09-16T04:50:28.825056015Z" level=info msg="Completed buildkit initialization" Sep 16 04:50:28.829399 dockerd[2565]: time="2025-09-16T04:50:28.829354303Z" level=info msg="Daemon has completed initialization" Sep 16 04:50:28.829502 dockerd[2565]: time="2025-09-16T04:50:28.829454206Z" level=info msg="API listen on /run/docker.sock" Sep 16 04:50:28.829669 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 16 04:50:29.020439 systemd[1]: run-docker-netns-86031c3a733e.mount: Deactivated successfully. Sep 16 04:50:32.221349 systemd[1]: Started sshd@24-10.0.0.45:22-10.0.0.1:55032.service - OpenSSH per-connection server daemon (10.0.0.1:55032). Sep 16 04:50:32.292826 sshd[2800]: Accepted publickey for core from 10.0.0.1 port 55032 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:32.294804 sshd-session[2800]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:32.301014 systemd-logind[1446]: New session 25 of user core. Sep 16 04:50:32.313526 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 16 04:50:32.373938 sshd[2803]: Connection closed by 10.0.0.1 port 55032 Sep 16 04:50:32.374616 sshd-session[2800]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:32.393980 systemd[1]: sshd@24-10.0.0.45:22-10.0.0.1:55032.service: Deactivated successfully. Sep 16 04:50:32.396620 systemd[1]: session-25.scope: Deactivated successfully. Sep 16 04:50:32.397647 systemd-logind[1446]: Session 25 logged out. Waiting for processes to exit. Sep 16 04:50:32.401399 systemd[1]: Started sshd@25-10.0.0.45:22-10.0.0.1:55048.service - OpenSSH per-connection server daemon (10.0.0.1:55048). Sep 16 04:50:32.402262 systemd-logind[1446]: Removed session 25. Sep 16 04:50:32.466616 sshd[2809]: Accepted publickey for core from 10.0.0.1 port 55048 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:32.468461 sshd-session[2809]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:32.474232 systemd-logind[1446]: New session 26 of user core. Sep 16 04:50:32.488479 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 16 04:50:32.546423 sshd[2812]: Connection closed by 10.0.0.1 port 55048 Sep 16 04:50:32.546880 sshd-session[2809]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:32.560384 systemd[1]: sshd@25-10.0.0.45:22-10.0.0.1:55048.service: Deactivated successfully. Sep 16 04:50:32.562426 systemd[1]: session-26.scope: Deactivated successfully. Sep 16 04:50:32.563224 systemd-logind[1446]: Session 26 logged out. Waiting for processes to exit. Sep 16 04:50:32.566547 systemd[1]: Started sshd@26-10.0.0.45:22-10.0.0.1:55060.service - OpenSSH per-connection server daemon (10.0.0.1:55060). Sep 16 04:50:32.567360 systemd-logind[1446]: Removed session 26. Sep 16 04:50:32.632535 sshd[2818]: Accepted publickey for core from 10.0.0.1 port 55060 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:32.634084 sshd-session[2818]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:32.642627 systemd-logind[1446]: New session 27 of user core. Sep 16 04:50:32.657523 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 16 04:50:32.722218 sshd[2821]: Connection closed by 10.0.0.1 port 55060 Sep 16 04:50:32.722696 sshd-session[2818]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:32.735935 systemd[1]: sshd@26-10.0.0.45:22-10.0.0.1:55060.service: Deactivated successfully. Sep 16 04:50:32.738289 systemd[1]: session-27.scope: Deactivated successfully. Sep 16 04:50:32.739190 systemd-logind[1446]: Session 27 logged out. Waiting for processes to exit. Sep 16 04:50:32.742881 systemd[1]: Started sshd@27-10.0.0.45:22-10.0.0.1:55064.service - OpenSSH per-connection server daemon (10.0.0.1:55064). Sep 16 04:50:32.743506 systemd-logind[1446]: Removed session 27. Sep 16 04:50:32.805719 sshd[2834]: Accepted publickey for core from 10.0.0.1 port 55064 ssh2: RSA SHA256:aEZDbvRSzBiXYZsKx2DfzqvT2f8l39YfiPij+CF9oIs Sep 16 04:50:32.807134 sshd-session[2834]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 16 04:50:32.812356 systemd-logind[1446]: New session 28 of user core. Sep 16 04:50:32.820319 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 16 04:50:33.055178 systemd[1]: var-lib-docker-overlay2-b6b4d1df46fef55c64183ef9d6e52aa4a1c2820148737b74d02155e6e2d84c58\x2dinit-merged.mount: Deactivated successfully. Sep 16 04:50:33.181092 containerd[2515]: time="2025-09-16T04:50:33.181023493Z" level=info msg="connecting to shim 02048494f9da3ef2c0d257bc73382aa5db9c48301f06cac087b4cf7ba1948caf" address="unix:///run/containerd/s/d50c45e3217a9d79cf3dec69a502cbefe517a8153e1937a67b3b33010b6b1e8b" namespace=moby protocol=ttrpc version=3 Sep 16 04:50:33.218347 systemd[1]: Started docker-02048494f9da3ef2c0d257bc73382aa5db9c48301f06cac087b4cf7ba1948caf.scope - libcontainer container 02048494f9da3ef2c0d257bc73382aa5db9c48301f06cac087b4cf7ba1948caf. Sep 16 04:50:33.233474 systemd-resolved[1346]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 16 04:50:33.257699 kernel: docker0: port 1(veth86cb7fe) entered blocking state Sep 16 04:50:33.257859 kernel: docker0: port 1(veth86cb7fe) entered disabled state Sep 16 04:50:33.257882 kernel: veth86cb7fe: entered allmulticast mode Sep 16 04:50:33.257900 kernel: veth86cb7fe: entered promiscuous mode Sep 16 04:50:33.258512 systemd-networkd[1432]: veth86cb7fe: Link UP Sep 16 04:50:33.280227 kernel: eth0: renamed from veth0ec40d3 Sep 16 04:50:33.282445 kernel: docker0: port 1(veth86cb7fe) entered blocking state Sep 16 04:50:33.282531 kernel: docker0: port 1(veth86cb7fe) entered forwarding state Sep 16 04:50:33.282538 systemd-networkd[1432]: veth86cb7fe: Gained carrier Sep 16 04:50:33.282888 systemd-networkd[1432]: docker0: Gained carrier Sep 16 04:50:33.321663 sshd[2837]: Connection closed by 10.0.0.1 port 55064 Sep 16 04:50:33.322025 sshd-session[2834]: pam_unix(sshd:session): session closed for user core Sep 16 04:50:33.327376 systemd[1]: sshd@27-10.0.0.45:22-10.0.0.1:55064.service: Deactivated successfully. Sep 16 04:50:33.329503 systemd[1]: session-28.scope: Deactivated successfully. Sep 16 04:50:33.330527 systemd-logind[1446]: Session 28 logged out. Waiting for processes to exit. Sep 16 04:50:33.332150 systemd-logind[1446]: Removed session 28.