Jul 15 23:44:39.871811 kernel: Linux version 6.12.36-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Tue Jul 15 22:01:05 -00 2025 Jul 15 23:44:39.871840 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=e99cfd77676fb46bb6e7e7d8fcebb095dd84f43a354bdf152777c6b07182cd66 Jul 15 23:44:39.871852 kernel: BIOS-provided physical RAM map: Jul 15 23:44:39.871861 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jul 15 23:44:39.871870 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jul 15 23:44:39.871878 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jul 15 23:44:39.871889 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Jul 15 23:44:39.871901 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Jul 15 23:44:39.871914 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jul 15 23:44:39.871923 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Jul 15 23:44:39.871932 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jul 15 23:44:39.871941 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jul 15 23:44:39.871950 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jul 15 23:44:39.871959 kernel: NX (Execute Disable) protection: active Jul 15 23:44:39.871974 kernel: APIC: Static calls initialized Jul 15 23:44:39.871984 kernel: SMBIOS 2.8 present. Jul 15 23:44:39.871998 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Jul 15 23:44:39.872007 kernel: DMI: Memory slots populated: 1/1 Jul 15 23:44:39.872016 kernel: Hypervisor detected: KVM Jul 15 23:44:39.872025 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jul 15 23:44:39.872034 kernel: kvm-clock: using sched offset of 5032910334 cycles Jul 15 23:44:39.872044 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jul 15 23:44:39.872054 kernel: tsc: Detected 2794.750 MHz processor Jul 15 23:44:39.872064 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 15 23:44:39.872078 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 15 23:44:39.872088 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Jul 15 23:44:39.872099 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Jul 15 23:44:39.872109 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 15 23:44:39.872119 kernel: Using GB pages for direct mapping Jul 15 23:44:39.872129 kernel: ACPI: Early table checksum verification disabled Jul 15 23:44:39.872139 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Jul 15 23:44:39.872149 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872164 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872174 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872184 kernel: ACPI: FACS 0x000000009CFE0000 000040 Jul 15 23:44:39.872795 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872809 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872819 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872829 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 15 23:44:39.872839 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Jul 15 23:44:39.872857 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Jul 15 23:44:39.872867 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Jul 15 23:44:39.872877 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Jul 15 23:44:39.872887 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Jul 15 23:44:39.872897 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Jul 15 23:44:39.872907 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Jul 15 23:44:39.872918 kernel: No NUMA configuration found Jul 15 23:44:39.872927 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Jul 15 23:44:39.872937 kernel: NODE_DATA(0) allocated [mem 0x9cfd4dc0-0x9cfdbfff] Jul 15 23:44:39.872947 kernel: Zone ranges: Jul 15 23:44:39.872957 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 15 23:44:39.872966 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Jul 15 23:44:39.872975 kernel: Normal empty Jul 15 23:44:39.872985 kernel: Device empty Jul 15 23:44:39.872994 kernel: Movable zone start for each node Jul 15 23:44:39.873004 kernel: Early memory node ranges Jul 15 23:44:39.873018 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jul 15 23:44:39.873028 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Jul 15 23:44:39.873038 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Jul 15 23:44:39.873048 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 15 23:44:39.873058 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jul 15 23:44:39.873068 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Jul 15 23:44:39.873077 kernel: ACPI: PM-Timer IO Port: 0x608 Jul 15 23:44:39.873091 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jul 15 23:44:39.873101 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 15 23:44:39.873114 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jul 15 23:44:39.873123 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jul 15 23:44:39.873148 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 15 23:44:39.873158 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jul 15 23:44:39.873169 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jul 15 23:44:39.873178 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 15 23:44:39.873189 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jul 15 23:44:39.873224 kernel: TSC deadline timer available Jul 15 23:44:39.873234 kernel: CPU topo: Max. logical packages: 1 Jul 15 23:44:39.873245 kernel: CPU topo: Max. logical dies: 1 Jul 15 23:44:39.873259 kernel: CPU topo: Max. dies per package: 1 Jul 15 23:44:39.873269 kernel: CPU topo: Max. threads per core: 1 Jul 15 23:44:39.873279 kernel: CPU topo: Num. cores per package: 4 Jul 15 23:44:39.873290 kernel: CPU topo: Num. threads per package: 4 Jul 15 23:44:39.873300 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Jul 15 23:44:39.873310 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jul 15 23:44:39.873321 kernel: kvm-guest: KVM setup pv remote TLB flush Jul 15 23:44:39.873331 kernel: kvm-guest: setup PV sched yield Jul 15 23:44:39.873341 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Jul 15 23:44:39.873354 kernel: Booting paravirtualized kernel on KVM Jul 15 23:44:39.873365 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 15 23:44:39.873375 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jul 15 23:44:39.873386 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Jul 15 23:44:39.873396 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Jul 15 23:44:39.873406 kernel: pcpu-alloc: [0] 0 1 2 3 Jul 15 23:44:39.873416 kernel: kvm-guest: PV spinlocks enabled Jul 15 23:44:39.873427 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 15 23:44:39.873438 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=e99cfd77676fb46bb6e7e7d8fcebb095dd84f43a354bdf152777c6b07182cd66 Jul 15 23:44:39.873453 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 15 23:44:39.873463 kernel: random: crng init done Jul 15 23:44:39.873473 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 15 23:44:39.873484 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 15 23:44:39.873494 kernel: Fallback order for Node 0: 0 Jul 15 23:44:39.873504 kernel: Built 1 zonelists, mobility grouping on. Total pages: 642938 Jul 15 23:44:39.873514 kernel: Policy zone: DMA32 Jul 15 23:44:39.873524 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 15 23:44:39.873539 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 15 23:44:39.873549 kernel: ftrace: allocating 40095 entries in 157 pages Jul 15 23:44:39.873559 kernel: ftrace: allocated 157 pages with 5 groups Jul 15 23:44:39.873571 kernel: Dynamic Preempt: voluntary Jul 15 23:44:39.873583 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 15 23:44:39.873596 kernel: rcu: RCU event tracing is enabled. Jul 15 23:44:39.873607 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 15 23:44:39.873617 kernel: Trampoline variant of Tasks RCU enabled. Jul 15 23:44:39.873632 kernel: Rude variant of Tasks RCU enabled. Jul 15 23:44:39.873642 kernel: Tracing variant of Tasks RCU enabled. Jul 15 23:44:39.873656 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 15 23:44:39.873666 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 15 23:44:39.873676 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 15 23:44:39.873686 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 15 23:44:39.873696 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 15 23:44:39.873706 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jul 15 23:44:39.873716 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 15 23:44:39.873738 kernel: Console: colour VGA+ 80x25 Jul 15 23:44:39.873748 kernel: printk: legacy console [ttyS0] enabled Jul 15 23:44:39.873759 kernel: ACPI: Core revision 20240827 Jul 15 23:44:39.873771 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jul 15 23:44:39.873785 kernel: APIC: Switch to symmetric I/O mode setup Jul 15 23:44:39.873796 kernel: x2apic enabled Jul 15 23:44:39.873811 kernel: APIC: Switched APIC routing to: physical x2apic Jul 15 23:44:39.873821 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jul 15 23:44:39.873832 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jul 15 23:44:39.873845 kernel: kvm-guest: setup PV IPIs Jul 15 23:44:39.873855 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jul 15 23:44:39.873866 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Jul 15 23:44:39.873876 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Jul 15 23:44:39.873886 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jul 15 23:44:39.873897 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jul 15 23:44:39.873908 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jul 15 23:44:39.873920 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 15 23:44:39.873931 kernel: Spectre V2 : Mitigation: Retpolines Jul 15 23:44:39.873944 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 15 23:44:39.873955 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Jul 15 23:44:39.873966 kernel: RETBleed: Mitigation: untrained return thunk Jul 15 23:44:39.873976 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jul 15 23:44:39.873987 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jul 15 23:44:39.873997 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Jul 15 23:44:39.874009 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Jul 15 23:44:39.874018 kernel: x86/bugs: return thunk changed Jul 15 23:44:39.874031 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Jul 15 23:44:39.874041 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 15 23:44:39.874051 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 15 23:44:39.874061 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 15 23:44:39.874071 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 15 23:44:39.874080 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jul 15 23:44:39.874090 kernel: Freeing SMP alternatives memory: 32K Jul 15 23:44:39.874100 kernel: pid_max: default: 32768 minimum: 301 Jul 15 23:44:39.874110 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 15 23:44:39.874123 kernel: landlock: Up and running. Jul 15 23:44:39.874132 kernel: SELinux: Initializing. Jul 15 23:44:39.874142 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 15 23:44:39.874157 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 15 23:44:39.874168 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Jul 15 23:44:39.874179 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Jul 15 23:44:39.874225 kernel: ... version: 0 Jul 15 23:44:39.874238 kernel: ... bit width: 48 Jul 15 23:44:39.874248 kernel: ... generic registers: 6 Jul 15 23:44:39.874263 kernel: ... value mask: 0000ffffffffffff Jul 15 23:44:39.874274 kernel: ... max period: 00007fffffffffff Jul 15 23:44:39.874285 kernel: ... fixed-purpose events: 0 Jul 15 23:44:39.874295 kernel: ... event mask: 000000000000003f Jul 15 23:44:39.874306 kernel: signal: max sigframe size: 1776 Jul 15 23:44:39.874317 kernel: rcu: Hierarchical SRCU implementation. Jul 15 23:44:39.874328 kernel: rcu: Max phase no-delay instances is 400. Jul 15 23:44:39.874338 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 15 23:44:39.874349 kernel: smp: Bringing up secondary CPUs ... Jul 15 23:44:39.874363 kernel: smpboot: x86: Booting SMP configuration: Jul 15 23:44:39.874374 kernel: .... node #0, CPUs: #1 #2 #3 Jul 15 23:44:39.874384 kernel: smp: Brought up 1 node, 4 CPUs Jul 15 23:44:39.874395 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Jul 15 23:44:39.874406 kernel: Memory: 2428908K/2571752K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54424K init, 2544K bss, 136904K reserved, 0K cma-reserved) Jul 15 23:44:39.874417 kernel: devtmpfs: initialized Jul 15 23:44:39.874427 kernel: x86/mm: Memory block size: 128MB Jul 15 23:44:39.874438 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 15 23:44:39.874449 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 15 23:44:39.874463 kernel: pinctrl core: initialized pinctrl subsystem Jul 15 23:44:39.874474 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 15 23:44:39.874484 kernel: audit: initializing netlink subsys (disabled) Jul 15 23:44:39.874496 kernel: audit: type=2000 audit(1752623076.316:1): state=initialized audit_enabled=0 res=1 Jul 15 23:44:39.874506 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 15 23:44:39.874517 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 15 23:44:39.874528 kernel: cpuidle: using governor menu Jul 15 23:44:39.874538 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 15 23:44:39.874549 kernel: dca service started, version 1.12.1 Jul 15 23:44:39.874563 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Jul 15 23:44:39.874573 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Jul 15 23:44:39.874584 kernel: PCI: Using configuration type 1 for base access Jul 15 23:44:39.874595 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 15 23:44:39.874605 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 15 23:44:39.874616 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 15 23:44:39.874627 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 15 23:44:39.874637 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 15 23:44:39.874646 kernel: ACPI: Added _OSI(Module Device) Jul 15 23:44:39.874660 kernel: ACPI: Added _OSI(Processor Device) Jul 15 23:44:39.874670 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 15 23:44:39.874681 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 15 23:44:39.874692 kernel: ACPI: Interpreter enabled Jul 15 23:44:39.874703 kernel: ACPI: PM: (supports S0 S3 S5) Jul 15 23:44:39.874714 kernel: ACPI: Using IOAPIC for interrupt routing Jul 15 23:44:39.874725 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 15 23:44:39.874737 kernel: PCI: Using E820 reservations for host bridge windows Jul 15 23:44:39.874748 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jul 15 23:44:39.874763 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 15 23:44:39.875052 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 15 23:44:39.875255 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jul 15 23:44:39.875425 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jul 15 23:44:39.875442 kernel: PCI host bridge to bus 0000:00 Jul 15 23:44:39.875628 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jul 15 23:44:39.875782 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jul 15 23:44:39.875948 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jul 15 23:44:39.876100 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jul 15 23:44:39.876289 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jul 15 23:44:39.876444 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Jul 15 23:44:39.876610 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 15 23:44:39.876818 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Jul 15 23:44:39.877042 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Jul 15 23:44:39.877239 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Jul 15 23:44:39.877403 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Jul 15 23:44:39.877568 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Jul 15 23:44:39.877723 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jul 15 23:44:39.877904 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jul 15 23:44:39.878060 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Jul 15 23:44:39.878290 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Jul 15 23:44:39.878455 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Jul 15 23:44:39.878652 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Jul 15 23:44:39.878814 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Jul 15 23:44:39.878971 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Jul 15 23:44:39.879124 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Jul 15 23:44:39.879331 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Jul 15 23:44:39.879495 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Jul 15 23:44:39.879658 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Jul 15 23:44:39.879818 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Jul 15 23:44:39.879980 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Jul 15 23:44:39.880154 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Jul 15 23:44:39.880341 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jul 15 23:44:39.880525 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Jul 15 23:44:39.880687 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Jul 15 23:44:39.880843 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Jul 15 23:44:39.881019 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Jul 15 23:44:39.881177 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Jul 15 23:44:39.881272 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jul 15 23:44:39.881285 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jul 15 23:44:39.881296 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jul 15 23:44:39.881313 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jul 15 23:44:39.881324 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jul 15 23:44:39.881334 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jul 15 23:44:39.881344 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jul 15 23:44:39.881354 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jul 15 23:44:39.881364 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jul 15 23:44:39.881373 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jul 15 23:44:39.881383 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jul 15 23:44:39.881393 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jul 15 23:44:39.881406 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jul 15 23:44:39.881416 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jul 15 23:44:39.881426 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jul 15 23:44:39.881436 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jul 15 23:44:39.881446 kernel: iommu: Default domain type: Translated Jul 15 23:44:39.881456 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 15 23:44:39.881466 kernel: PCI: Using ACPI for IRQ routing Jul 15 23:44:39.881477 kernel: PCI: pci_cache_line_size set to 64 bytes Jul 15 23:44:39.881488 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jul 15 23:44:39.881503 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Jul 15 23:44:39.881664 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jul 15 23:44:39.881818 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jul 15 23:44:39.881976 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jul 15 23:44:39.881992 kernel: vgaarb: loaded Jul 15 23:44:39.882003 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jul 15 23:44:39.882015 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jul 15 23:44:39.882027 kernel: clocksource: Switched to clocksource kvm-clock Jul 15 23:44:39.882043 kernel: VFS: Disk quotas dquot_6.6.0 Jul 15 23:44:39.882055 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 15 23:44:39.882066 kernel: pnp: PnP ACPI init Jul 15 23:44:39.882284 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jul 15 23:44:39.882303 kernel: pnp: PnP ACPI: found 6 devices Jul 15 23:44:39.882314 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 15 23:44:39.882325 kernel: NET: Registered PF_INET protocol family Jul 15 23:44:39.882336 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 15 23:44:39.882353 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 15 23:44:39.882364 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 15 23:44:39.882375 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 15 23:44:39.882385 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 15 23:44:39.882396 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 15 23:44:39.882407 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 15 23:44:39.882418 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 15 23:44:39.882429 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 15 23:44:39.882440 kernel: NET: Registered PF_XDP protocol family Jul 15 23:44:39.882596 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jul 15 23:44:39.882722 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jul 15 23:44:39.882856 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jul 15 23:44:39.882968 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jul 15 23:44:39.883076 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jul 15 23:44:39.883188 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Jul 15 23:44:39.883229 kernel: PCI: CLS 0 bytes, default 64 Jul 15 23:44:39.883241 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Jul 15 23:44:39.883257 kernel: Initialise system trusted keyrings Jul 15 23:44:39.883268 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 15 23:44:39.883279 kernel: Key type asymmetric registered Jul 15 23:44:39.883290 kernel: Asymmetric key parser 'x509' registered Jul 15 23:44:39.883301 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 15 23:44:39.883312 kernel: io scheduler mq-deadline registered Jul 15 23:44:39.883323 kernel: io scheduler kyber registered Jul 15 23:44:39.883334 kernel: io scheduler bfq registered Jul 15 23:44:39.883345 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 15 23:44:39.883362 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jul 15 23:44:39.883373 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jul 15 23:44:39.883384 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jul 15 23:44:39.883395 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 15 23:44:39.883406 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 15 23:44:39.883418 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jul 15 23:44:39.883429 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jul 15 23:44:39.883439 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jul 15 23:44:39.883643 kernel: rtc_cmos 00:04: RTC can wake from S4 Jul 15 23:44:39.883667 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jul 15 23:44:39.883820 kernel: rtc_cmos 00:04: registered as rtc0 Jul 15 23:44:39.883956 kernel: rtc_cmos 00:04: setting system clock to 2025-07-15T23:44:39 UTC (1752623079) Jul 15 23:44:39.884077 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jul 15 23:44:39.884088 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jul 15 23:44:39.884097 kernel: NET: Registered PF_INET6 protocol family Jul 15 23:44:39.884105 kernel: Segment Routing with IPv6 Jul 15 23:44:39.884113 kernel: In-situ OAM (IOAM) with IPv6 Jul 15 23:44:39.884126 kernel: NET: Registered PF_PACKET protocol family Jul 15 23:44:39.884134 kernel: Key type dns_resolver registered Jul 15 23:44:39.884142 kernel: IPI shorthand broadcast: enabled Jul 15 23:44:39.884150 kernel: sched_clock: Marking stable (3194002908, 110909899)->(3325137656, -20224849) Jul 15 23:44:39.884157 kernel: registered taskstats version 1 Jul 15 23:44:39.884165 kernel: Loading compiled-in X.509 certificates Jul 15 23:44:39.884173 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.36-flatcar: cfc533be64675f3c66ee10d42aa8c5ce2115881d' Jul 15 23:44:39.884181 kernel: Demotion targets for Node 0: null Jul 15 23:44:39.884213 kernel: Key type .fscrypt registered Jul 15 23:44:39.884228 kernel: Key type fscrypt-provisioning registered Jul 15 23:44:39.884239 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 15 23:44:39.884249 kernel: ima: Allocated hash algorithm: sha1 Jul 15 23:44:39.884259 kernel: ima: No architecture policies found Jul 15 23:44:39.884270 kernel: clk: Disabling unused clocks Jul 15 23:44:39.884278 kernel: Warning: unable to open an initial console. Jul 15 23:44:39.884287 kernel: Freeing unused kernel image (initmem) memory: 54424K Jul 15 23:44:39.884295 kernel: Write protecting the kernel read-only data: 24576k Jul 15 23:44:39.884303 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jul 15 23:44:39.884313 kernel: Run /init as init process Jul 15 23:44:39.884321 kernel: with arguments: Jul 15 23:44:39.884330 kernel: /init Jul 15 23:44:39.884338 kernel: with environment: Jul 15 23:44:39.884345 kernel: HOME=/ Jul 15 23:44:39.884353 kernel: TERM=linux Jul 15 23:44:39.884360 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 15 23:44:39.884369 systemd[1]: Successfully made /usr/ read-only. Jul 15 23:44:39.884384 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) Jul 15 23:44:39.884407 systemd[1]: Detected virtualization kvm. Jul 15 23:44:39.884415 systemd[1]: Detected architecture x86-64. Jul 15 23:44:39.884424 systemd[1]: Running in initrd. Jul 15 23:44:39.884432 systemd[1]: No hostname configured, using default hostname. Jul 15 23:44:39.884441 systemd[1]: Hostname set to . Jul 15 23:44:39.884452 systemd[1]: Initializing machine ID from VM UUID. Jul 15 23:44:39.884460 systemd[1]: Queued start job for default target initrd.target. Jul 15 23:44:39.884469 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 23:44:39.884478 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 23:44:39.884488 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 15 23:44:39.884497 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 15 23:44:39.884535 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 15 23:44:39.884548 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 15 23:44:39.884558 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 15 23:44:39.884567 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 15 23:44:39.884576 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 23:44:39.884585 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 15 23:44:39.884593 systemd[1]: Reached target paths.target - Path Units. Jul 15 23:44:39.884602 systemd[1]: Reached target slices.target - Slice Units. Jul 15 23:44:39.884613 systemd[1]: Reached target swap.target - Swaps. Jul 15 23:44:39.884624 systemd[1]: Reached target timers.target - Timer Units. Jul 15 23:44:39.884633 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 15 23:44:39.884642 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 15 23:44:39.884650 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 15 23:44:39.884659 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 15 23:44:39.884668 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 15 23:44:39.884677 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 15 23:44:39.884685 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 23:44:39.884696 systemd[1]: Reached target sockets.target - Socket Units. Jul 15 23:44:39.884705 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 15 23:44:39.884715 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 15 23:44:39.884727 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 15 23:44:39.884740 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). Jul 15 23:44:39.884758 systemd[1]: Starting systemd-fsck-usr.service... Jul 15 23:44:39.884769 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 15 23:44:39.884778 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 15 23:44:39.884786 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 23:44:39.884795 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 15 23:44:39.884804 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 23:44:39.884816 systemd[1]: Finished systemd-fsck-usr.service. Jul 15 23:44:39.884825 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 15 23:44:39.884869 systemd-journald[220]: Collecting audit messages is disabled. Jul 15 23:44:39.884894 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 15 23:44:39.884904 systemd-journald[220]: Journal started Jul 15 23:44:39.884925 systemd-journald[220]: Runtime Journal (/run/log/journal/01425c53a55644a4a5648ee831ebb5a3) is 6M, max 48.6M, 42.5M free. Jul 15 23:44:39.868847 systemd-modules-load[223]: Inserted module 'overlay' Jul 15 23:44:39.917788 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 15 23:44:39.917837 kernel: Bridge firewalling registered Jul 15 23:44:39.917857 systemd[1]: Started systemd-journald.service - Journal Service. Jul 15 23:44:39.904064 systemd-modules-load[223]: Inserted module 'br_netfilter' Jul 15 23:44:39.915808 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 15 23:44:39.917940 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 23:44:39.919555 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 15 23:44:39.922283 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 15 23:44:39.926559 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 15 23:44:39.934153 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 15 23:44:39.945938 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 15 23:44:39.947302 systemd-tmpfiles[239]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 15 23:44:39.948259 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 23:44:39.952986 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 23:44:39.956073 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 15 23:44:39.972462 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 15 23:44:39.974019 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 15 23:44:39.996917 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=e99cfd77676fb46bb6e7e7d8fcebb095dd84f43a354bdf152777c6b07182cd66 Jul 15 23:44:40.012644 systemd-resolved[255]: Positive Trust Anchors: Jul 15 23:44:40.012662 systemd-resolved[255]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 15 23:44:40.012694 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 Jul 15 23:44:40.015451 systemd-resolved[255]: Defaulting to hostname 'linux'. Jul 15 23:44:40.016814 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 15 23:44:40.024893 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 15 23:44:40.128243 kernel: SCSI subsystem initialized Jul 15 23:44:40.138241 kernel: Loading iSCSI transport class v2.0-870. Jul 15 23:44:40.150323 kernel: iscsi: registered transport (tcp) Jul 15 23:44:40.176246 kernel: iscsi: registered transport (qla4xxx) Jul 15 23:44:40.176330 kernel: QLogic iSCSI HBA Driver Jul 15 23:44:40.201678 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 15 23:44:40.229543 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 23:44:40.230236 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 15 23:44:40.305222 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 15 23:44:40.308269 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 15 23:44:40.379248 kernel: raid6: avx2x4 gen() 21051 MB/s Jul 15 23:44:40.396249 kernel: raid6: avx2x2 gen() 29034 MB/s Jul 15 23:44:40.413276 kernel: raid6: avx2x1 gen() 21172 MB/s Jul 15 23:44:40.413302 kernel: raid6: using algorithm avx2x2 gen() 29034 MB/s Jul 15 23:44:40.431314 kernel: raid6: .... xor() 19857 MB/s, rmw enabled Jul 15 23:44:40.431391 kernel: raid6: using avx2x2 recovery algorithm Jul 15 23:44:40.453241 kernel: xor: automatically using best checksumming function avx Jul 15 23:44:40.698602 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 15 23:44:40.710654 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 15 23:44:40.714161 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 23:44:40.752287 systemd-udevd[472]: Using default interface naming scheme 'v255'. Jul 15 23:44:40.758096 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 23:44:40.761831 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 15 23:44:40.802758 dracut-pre-trigger[480]: rd.md=0: removing MD RAID activation Jul 15 23:44:40.860651 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 15 23:44:40.862955 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 15 23:44:40.952385 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 23:44:40.955366 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 15 23:44:41.014232 kernel: cryptd: max_cpu_qlen set to 1000 Jul 15 23:44:41.015260 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jul 15 23:44:41.066909 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 15 23:44:41.076802 kernel: AES CTR mode by8 optimization enabled Jul 15 23:44:41.076847 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 15 23:44:41.098889 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 23:44:41.099071 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 23:44:41.112478 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 23:44:41.118879 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 23:44:41.138473 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 15 23:44:41.144224 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Jul 15 23:44:41.154243 kernel: libata version 3.00 loaded. Jul 15 23:44:41.197987 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 15 23:44:41.257255 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 23:44:41.284722 kernel: ahci 0000:00:1f.2: version 3.0 Jul 15 23:44:41.284996 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jul 15 23:44:41.285013 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Jul 15 23:44:41.286589 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Jul 15 23:44:41.286810 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jul 15 23:44:41.295578 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 15 23:44:41.306225 kernel: scsi host0: ahci Jul 15 23:44:41.306515 kernel: scsi host1: ahci Jul 15 23:44:41.308370 kernel: scsi host2: ahci Jul 15 23:44:41.308586 kernel: scsi host3: ahci Jul 15 23:44:41.308782 kernel: scsi host4: ahci Jul 15 23:44:41.309680 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 15 23:44:41.318586 kernel: scsi host5: ahci Jul 15 23:44:41.318788 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 lpm-pol 0 Jul 15 23:44:41.318812 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 lpm-pol 0 Jul 15 23:44:41.318825 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 lpm-pol 0 Jul 15 23:44:41.318838 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 lpm-pol 0 Jul 15 23:44:41.318850 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 lpm-pol 0 Jul 15 23:44:41.318863 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 lpm-pol 0 Jul 15 23:44:41.320579 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 15 23:44:41.321091 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 15 23:44:41.322611 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 15 23:44:41.555238 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 15 23:44:41.626236 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jul 15 23:44:41.636236 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jul 15 23:44:41.636317 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jul 15 23:44:41.637241 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jul 15 23:44:41.637274 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jul 15 23:44:41.638248 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 15 23:44:41.639375 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jul 15 23:44:41.639398 kernel: ata3.00: applying bridge limits Jul 15 23:44:41.640366 kernel: ata3.00: configured for UDMA/100 Jul 15 23:44:41.641222 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jul 15 23:44:41.653235 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 15 23:44:41.692217 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jul 15 23:44:41.692476 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 15 23:44:41.715227 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 15 23:44:42.120910 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 15 23:44:42.122399 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 15 23:44:42.126514 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 23:44:42.129114 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 15 23:44:42.130805 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 15 23:44:42.156877 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 15 23:44:42.732233 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 15 23:44:42.732793 disk-uuid[633]: The operation has completed successfully. Jul 15 23:44:42.770508 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 15 23:44:42.770635 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 15 23:44:42.821644 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 15 23:44:42.856458 sh[663]: Success Jul 15 23:44:42.877232 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 15 23:44:42.877318 kernel: device-mapper: uevent: version 1.0.3 Jul 15 23:44:42.877357 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 15 23:44:42.907232 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 15 23:44:42.951084 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 15 23:44:42.968581 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 15 23:44:42.997816 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 15 23:44:43.023201 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 15 23:44:43.023239 kernel: BTRFS: device fsid 5e84ae48-fef7-4576-99b7-f45b3ea9aa4e devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (675) Jul 15 23:44:43.025576 kernel: BTRFS info (device dm-0): first mount of filesystem 5e84ae48-fef7-4576-99b7-f45b3ea9aa4e Jul 15 23:44:43.025605 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 15 23:44:43.025621 kernel: BTRFS info (device dm-0): using free-space-tree Jul 15 23:44:43.031746 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 15 23:44:43.033178 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 15 23:44:43.034035 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 15 23:44:43.035181 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 15 23:44:43.040935 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 15 23:44:43.077851 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (707) Jul 15 23:44:43.077932 kernel: BTRFS info (device vda6): first mount of filesystem 00a9d8f6-6c10-4cef-8e74-b38121477a0b Jul 15 23:44:43.077948 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 15 23:44:43.078852 kernel: BTRFS info (device vda6): using free-space-tree Jul 15 23:44:43.088229 kernel: BTRFS info (device vda6): last unmount of filesystem 00a9d8f6-6c10-4cef-8e74-b38121477a0b Jul 15 23:44:43.088948 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 15 23:44:43.092846 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 15 23:44:43.259024 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 15 23:44:43.264143 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 15 23:44:43.280135 ignition[751]: Ignition 2.21.0 Jul 15 23:44:43.280148 ignition[751]: Stage: fetch-offline Jul 15 23:44:43.280184 ignition[751]: no configs at "/usr/lib/ignition/base.d" Jul 15 23:44:43.280216 ignition[751]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 15 23:44:43.280315 ignition[751]: parsed url from cmdline: "" Jul 15 23:44:43.280319 ignition[751]: no config URL provided Jul 15 23:44:43.280325 ignition[751]: reading system config file "/usr/lib/ignition/user.ign" Jul 15 23:44:43.280334 ignition[751]: no config at "/usr/lib/ignition/user.ign" Jul 15 23:44:43.280356 ignition[751]: op(1): [started] loading QEMU firmware config module Jul 15 23:44:43.280372 ignition[751]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 15 23:44:43.307476 ignition[751]: op(1): [finished] loading QEMU firmware config module Jul 15 23:44:43.309146 ignition[751]: parsing config with SHA512: 753b770de5506ca39a2c851635003342a7f15d08b109ec32e80c8c2f08a8946e7b054133ee96aa36d55d125ad90cd31e8f1b918807164b0947f4e9ea2c69a3ff Jul 15 23:44:43.319045 unknown[751]: fetched base config from "system" Jul 15 23:44:43.319063 unknown[751]: fetched user config from "qemu" Jul 15 23:44:43.319246 ignition[751]: fetch-offline: fetch-offline passed Jul 15 23:44:43.319329 ignition[751]: Ignition finished successfully Jul 15 23:44:43.322673 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 15 23:44:43.343702 systemd-networkd[851]: lo: Link UP Jul 15 23:44:43.343713 systemd-networkd[851]: lo: Gained carrier Jul 15 23:44:43.347749 systemd-networkd[851]: Enumeration completed Jul 15 23:44:43.347910 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 15 23:44:43.348236 systemd-networkd[851]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 23:44:43.348241 systemd-networkd[851]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 23:44:43.349794 systemd[1]: Reached target network.target - Network. Jul 15 23:44:43.350701 systemd-networkd[851]: eth0: Link UP Jul 15 23:44:43.350705 systemd-networkd[851]: eth0: Gained carrier Jul 15 23:44:43.350714 systemd-networkd[851]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 23:44:43.351556 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 15 23:44:43.352692 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 15 23:44:43.385290 systemd-networkd[851]: eth0: DHCPv4 address 10.0.0.4/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 15 23:44:43.415391 ignition[857]: Ignition 2.21.0 Jul 15 23:44:43.415410 ignition[857]: Stage: kargs Jul 15 23:44:43.415580 ignition[857]: no configs at "/usr/lib/ignition/base.d" Jul 15 23:44:43.415596 ignition[857]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 15 23:44:43.416601 ignition[857]: kargs: kargs passed Jul 15 23:44:43.416670 ignition[857]: Ignition finished successfully Jul 15 23:44:43.422477 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 15 23:44:43.425043 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 15 23:44:43.497369 ignition[866]: Ignition 2.21.0 Jul 15 23:44:43.497384 ignition[866]: Stage: disks Jul 15 23:44:43.497539 ignition[866]: no configs at "/usr/lib/ignition/base.d" Jul 15 23:44:43.497550 ignition[866]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 15 23:44:43.502299 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 15 23:44:43.499639 ignition[866]: disks: disks passed Jul 15 23:44:43.505944 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 15 23:44:43.499737 ignition[866]: Ignition finished successfully Jul 15 23:44:43.516172 systemd-resolved[255]: Detected conflict on linux IN A 10.0.0.4 Jul 15 23:44:43.516206 systemd-resolved[255]: Hostname conflict, changing published hostname from 'linux' to 'linux9'. Jul 15 23:44:43.517309 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 15 23:44:43.517837 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 15 23:44:43.518636 systemd[1]: Reached target sysinit.target - System Initialization. Jul 15 23:44:43.518965 systemd[1]: Reached target basic.target - Basic System. Jul 15 23:44:43.520891 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 15 23:44:43.558997 systemd-fsck[876]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 15 23:44:43.801691 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 15 23:44:43.805131 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 15 23:44:43.941243 kernel: EXT4-fs (vda9): mounted filesystem e7011b63-42ae-44ea-90bf-c826e39292b2 r/w with ordered data mode. Quota mode: none. Jul 15 23:44:43.941726 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 15 23:44:43.943210 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 15 23:44:43.945535 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 15 23:44:43.948250 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 15 23:44:43.962539 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 15 23:44:43.962607 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 15 23:44:43.962644 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 15 23:44:43.972124 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 15 23:44:43.990275 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 15 23:44:43.996236 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (884) Jul 15 23:44:43.996301 kernel: BTRFS info (device vda6): first mount of filesystem 00a9d8f6-6c10-4cef-8e74-b38121477a0b Jul 15 23:44:43.998230 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 15 23:44:43.998258 kernel: BTRFS info (device vda6): using free-space-tree Jul 15 23:44:44.004906 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 15 23:44:44.048936 initrd-setup-root[909]: cut: /sysroot/etc/passwd: No such file or directory Jul 15 23:44:44.057423 initrd-setup-root[916]: cut: /sysroot/etc/group: No such file or directory Jul 15 23:44:44.074101 initrd-setup-root[923]: cut: /sysroot/etc/shadow: No such file or directory Jul 15 23:44:44.079709 initrd-setup-root[930]: cut: /sysroot/etc/gshadow: No such file or directory Jul 15 23:44:44.189921 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 15 23:44:44.193108 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 15 23:44:44.195061 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 15 23:44:44.216929 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 15 23:44:44.218121 kernel: BTRFS info (device vda6): last unmount of filesystem 00a9d8f6-6c10-4cef-8e74-b38121477a0b Jul 15 23:44:44.234755 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 15 23:44:44.259021 ignition[1000]: INFO : Ignition 2.21.0 Jul 15 23:44:44.259021 ignition[1000]: INFO : Stage: mount Jul 15 23:44:44.260898 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 23:44:44.260898 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 15 23:44:44.263004 ignition[1000]: INFO : mount: mount passed Jul 15 23:44:44.263004 ignition[1000]: INFO : Ignition finished successfully Jul 15 23:44:44.265815 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 15 23:44:44.268243 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 15 23:44:44.290739 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 15 23:44:44.314220 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1012) Jul 15 23:44:44.316636 kernel: BTRFS info (device vda6): first mount of filesystem 00a9d8f6-6c10-4cef-8e74-b38121477a0b Jul 15 23:44:44.316665 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 15 23:44:44.316677 kernel: BTRFS info (device vda6): using free-space-tree Jul 15 23:44:44.321546 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 15 23:44:44.358968 ignition[1029]: INFO : Ignition 2.21.0 Jul 15 23:44:44.358968 ignition[1029]: INFO : Stage: files Jul 15 23:44:44.361258 ignition[1029]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 23:44:44.361258 ignition[1029]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 15 23:44:44.363982 ignition[1029]: DEBUG : files: compiled without relabeling support, skipping Jul 15 23:44:44.363982 ignition[1029]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 15 23:44:44.363982 ignition[1029]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 15 23:44:44.368724 ignition[1029]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 15 23:44:44.368724 ignition[1029]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 15 23:44:44.368724 ignition[1029]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 15 23:44:44.367658 unknown[1029]: wrote ssh authorized keys file for user: core Jul 15 23:44:44.374249 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 15 23:44:44.374249 ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 15 23:44:44.374249 ignition[1029]: INFO : files: op(4): [started] processing unit "docker.service" Jul 15 23:44:44.374249 ignition[1029]: INFO : files: op(4): [finished] processing unit "docker.service" Jul 15 23:44:44.374249 ignition[1029]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Jul 15 23:44:44.382976 ignition[1029]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 15 23:44:44.382976 ignition[1029]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 15 23:44:44.382976 ignition[1029]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Jul 15 23:44:44.382976 ignition[1029]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Jul 15 23:44:44.399006 ignition[1029]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 15 23:44:44.403800 ignition[1029]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 15 23:44:44.405416 ignition[1029]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Jul 15 23:44:44.405416 ignition[1029]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Jul 15 23:44:44.405416 ignition[1029]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Jul 15 23:44:44.405416 ignition[1029]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 15 23:44:44.405416 ignition[1029]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 15 23:44:44.405416 ignition[1029]: INFO : files: files passed Jul 15 23:44:44.405416 ignition[1029]: INFO : Ignition finished successfully Jul 15 23:44:44.411258 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 15 23:44:44.414099 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 15 23:44:44.417933 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 15 23:44:44.432230 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 15 23:44:44.432376 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 15 23:44:44.436003 initrd-setup-root-after-ignition[1059]: grep: /sysroot/oem/oem-release: No such file or directory Jul 15 23:44:44.437604 initrd-setup-root-after-ignition[1061]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 15 23:44:44.437604 initrd-setup-root-after-ignition[1061]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 15 23:44:44.441977 initrd-setup-root-after-ignition[1065]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 15 23:44:44.439062 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 15 23:44:44.439816 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 15 23:44:44.444711 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 15 23:44:44.505708 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 15 23:44:44.505834 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 15 23:44:44.506608 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 15 23:44:44.506812 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 15 23:44:44.507179 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 15 23:44:44.507996 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 15 23:44:44.528562 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 15 23:44:44.531952 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 15 23:44:44.568588 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 15 23:44:44.570876 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 23:44:44.571564 systemd[1]: Stopped target timers.target - Timer Units. Jul 15 23:44:44.571882 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 15 23:44:44.572020 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 15 23:44:44.576731 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 15 23:44:44.577118 systemd[1]: Stopped target basic.target - Basic System. Jul 15 23:44:44.577619 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 15 23:44:44.577950 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 15 23:44:44.578470 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 15 23:44:44.578809 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 15 23:44:44.579156 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 15 23:44:44.579651 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 15 23:44:44.579998 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 15 23:44:44.580515 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 15 23:44:44.580845 systemd[1]: Stopped target swap.target - Swaps. Jul 15 23:44:44.581164 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 15 23:44:44.581293 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 15 23:44:44.582016 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 15 23:44:44.582538 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 23:44:44.582836 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 15 23:44:44.583047 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 23:44:44.583641 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 15 23:44:44.583817 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 15 23:44:44.608391 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 15 23:44:44.608541 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 15 23:44:44.609046 systemd[1]: Stopped target paths.target - Path Units. Jul 15 23:44:44.613145 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 15 23:44:44.618334 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 23:44:44.621102 systemd[1]: Stopped target slices.target - Slice Units. Jul 15 23:44:44.621631 systemd[1]: Stopped target sockets.target - Socket Units. Jul 15 23:44:44.621973 systemd[1]: iscsid.socket: Deactivated successfully. Jul 15 23:44:44.622097 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 15 23:44:44.624908 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 15 23:44:44.624996 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 15 23:44:44.626656 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 15 23:44:44.626781 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 15 23:44:44.628764 systemd[1]: ignition-files.service: Deactivated successfully. Jul 15 23:44:44.628874 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 15 23:44:44.633971 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 15 23:44:44.634374 systemd-networkd[851]: eth0: Gained IPv6LL Jul 15 23:44:44.634603 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 15 23:44:44.634718 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 23:44:44.635948 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 15 23:44:44.640087 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 15 23:44:44.640287 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 23:44:44.640770 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 15 23:44:44.640870 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 15 23:44:44.649406 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 15 23:44:44.653633 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 15 23:44:44.680723 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 15 23:44:44.680859 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 15 23:44:44.684316 ignition[1085]: INFO : Ignition 2.21.0 Jul 15 23:44:44.684316 ignition[1085]: INFO : Stage: umount Jul 15 23:44:44.684316 ignition[1085]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 23:44:44.684316 ignition[1085]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 15 23:44:44.684316 ignition[1085]: INFO : umount: umount passed Jul 15 23:44:44.684316 ignition[1085]: INFO : Ignition finished successfully Jul 15 23:44:44.685363 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 15 23:44:44.685515 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 15 23:44:44.686850 systemd[1]: Stopped target network.target - Network. Jul 15 23:44:44.689025 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 15 23:44:44.689093 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 15 23:44:44.690765 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 15 23:44:44.690819 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 15 23:44:44.691079 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 15 23:44:44.691128 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 15 23:44:44.691562 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 15 23:44:44.691603 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 15 23:44:44.691873 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 15 23:44:44.691914 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 15 23:44:44.692324 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 15 23:44:44.700527 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 15 23:44:44.712111 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 15 23:44:44.712321 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 15 23:44:44.715855 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 15 23:44:44.715911 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 23:44:44.720495 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 15 23:44:44.720649 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 15 23:44:44.723710 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 15 23:44:44.724013 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 15 23:44:44.724056 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 15 23:44:44.727787 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 15 23:44:44.728493 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 15 23:44:44.728543 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 15 23:44:44.728913 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 15 23:44:44.728958 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 15 23:44:44.734996 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 15 23:44:44.735076 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 15 23:44:44.735634 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 23:44:44.754134 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 15 23:44:44.754296 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 15 23:44:44.757760 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 15 23:44:44.757938 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 23:44:44.758638 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 15 23:44:44.758684 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 15 23:44:44.761931 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 15 23:44:44.761972 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 23:44:44.762498 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 15 23:44:44.762545 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 15 23:44:44.767584 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 15 23:44:44.767634 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 15 23:44:44.770242 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 15 23:44:44.770295 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 15 23:44:44.775359 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 15 23:44:44.775762 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 15 23:44:44.775821 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 23:44:44.780268 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 15 23:44:44.780319 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 23:44:44.783721 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 23:44:44.783768 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 23:44:44.800791 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 15 23:44:44.800918 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 15 23:44:44.801659 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 15 23:44:44.806646 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 15 23:44:44.838413 systemd[1]: Switching root. Jul 15 23:44:44.878773 systemd-journald[220]: Journal stopped Jul 15 23:44:45.964517 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Jul 15 23:44:45.964602 kernel: SELinux: policy capability network_peer_controls=1 Jul 15 23:44:45.964628 kernel: SELinux: policy capability open_perms=1 Jul 15 23:44:45.964643 kernel: SELinux: policy capability extended_socket_class=1 Jul 15 23:44:45.964659 kernel: SELinux: policy capability always_check_network=0 Jul 15 23:44:45.964679 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 15 23:44:45.964700 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 15 23:44:45.964732 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 15 23:44:45.964757 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 15 23:44:45.964788 kernel: SELinux: policy capability userspace_initial_context=0 Jul 15 23:44:45.964819 kernel: audit: type=1403 audit(1752623084.986:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 15 23:44:45.964857 systemd[1]: Successfully loaded SELinux policy in 52.195ms. Jul 15 23:44:45.964934 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 13.852ms. Jul 15 23:44:45.965053 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) Jul 15 23:44:45.965091 systemd[1]: Detected virtualization kvm. Jul 15 23:44:45.965120 systemd[1]: Detected architecture x86-64. Jul 15 23:44:45.965151 systemd[1]: Detected first boot. Jul 15 23:44:45.965183 systemd[1]: Initializing machine ID from VM UUID. Jul 15 23:44:45.965231 zram_generator::config[1130]: No configuration found. Jul 15 23:44:45.965249 kernel: Guest personality initialized and is inactive Jul 15 23:44:45.965265 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Jul 15 23:44:45.965280 kernel: Initialized host personality Jul 15 23:44:45.965298 kernel: NET: Registered PF_VSOCK protocol family Jul 15 23:44:45.965313 systemd[1]: Populated /etc with preset unit settings. Jul 15 23:44:45.965330 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 15 23:44:45.965347 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 15 23:44:45.965362 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 15 23:44:45.965378 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 15 23:44:45.965407 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 15 23:44:45.965423 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 15 23:44:45.965439 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 15 23:44:45.965454 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 15 23:44:45.965470 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 15 23:44:45.965485 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 15 23:44:45.965501 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 15 23:44:45.965516 systemd[1]: Created slice user.slice - User and Session Slice. Jul 15 23:44:45.965537 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 23:44:45.965553 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 23:44:45.965570 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 15 23:44:45.965585 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 15 23:44:45.965602 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 15 23:44:45.965618 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 15 23:44:45.965633 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 15 23:44:45.965651 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 23:44:45.965667 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 15 23:44:45.965681 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 15 23:44:45.965709 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 15 23:44:45.965724 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 15 23:44:45.965740 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 15 23:44:45.965755 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 23:44:45.965771 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 15 23:44:45.965786 systemd[1]: Reached target slices.target - Slice Units. Jul 15 23:44:45.965801 systemd[1]: Reached target swap.target - Swaps. Jul 15 23:44:45.965821 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 15 23:44:45.965836 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 15 23:44:45.965851 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 15 23:44:45.965866 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 15 23:44:45.965881 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 15 23:44:45.965897 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 23:44:45.965911 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 15 23:44:45.965927 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 15 23:44:45.965943 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 15 23:44:45.965962 systemd[1]: Mounting media.mount - External Media Directory... Jul 15 23:44:45.965978 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:45.965994 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 15 23:44:45.966009 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 15 23:44:45.966038 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 15 23:44:45.966066 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). Jul 15 23:44:45.966081 systemd[1]: Reached target machines.target - Containers. Jul 15 23:44:45.966097 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 15 23:44:45.966121 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 23:44:45.966138 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 15 23:44:45.966153 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 15 23:44:45.966168 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 23:44:45.966183 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 15 23:44:45.967383 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 23:44:45.967406 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 15 23:44:45.967422 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 23:44:45.967445 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 15 23:44:45.967462 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 15 23:44:45.967484 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 15 23:44:45.967501 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 15 23:44:45.967529 systemd[1]: Stopped systemd-fsck-usr.service. Jul 15 23:44:45.967547 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). Jul 15 23:44:45.967564 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 15 23:44:45.967580 kernel: loop: module loaded Jul 15 23:44:45.967596 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 15 23:44:45.967615 kernel: fuse: init (API version 7.41) Jul 15 23:44:45.967631 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 15 23:44:45.967654 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 15 23:44:45.967671 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 15 23:44:45.967687 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 15 23:44:45.967707 systemd[1]: verity-setup.service: Deactivated successfully. Jul 15 23:44:45.967723 systemd[1]: Stopped verity-setup.service. Jul 15 23:44:45.967740 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:45.967793 systemd-journald[1201]: Collecting audit messages is disabled. Jul 15 23:44:45.967827 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 15 23:44:45.967850 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 15 23:44:45.967871 systemd-journald[1201]: Journal started Jul 15 23:44:45.968310 systemd-journald[1201]: Runtime Journal (/run/log/journal/01425c53a55644a4a5648ee831ebb5a3) is 6M, max 48.6M, 42.5M free. Jul 15 23:44:45.675212 systemd[1]: Queued start job for default target multi-user.target. Jul 15 23:44:45.699335 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 15 23:44:45.699933 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 15 23:44:45.971261 systemd[1]: Started systemd-journald.service - Journal Service. Jul 15 23:44:45.974583 kernel: ACPI: bus type drm_connector registered Jul 15 23:44:45.974929 systemd[1]: Mounted media.mount - External Media Directory. Jul 15 23:44:45.976633 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 15 23:44:45.978337 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 15 23:44:45.981633 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 15 23:44:45.983660 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 15 23:44:45.987432 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 23:44:45.989525 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 15 23:44:45.989818 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 15 23:44:45.991922 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 23:44:45.992299 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 23:44:45.994154 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 15 23:44:45.994472 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 15 23:44:45.996311 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 23:44:45.996685 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 23:44:45.998617 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 15 23:44:45.998926 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 15 23:44:46.000499 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 23:44:46.000761 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 23:44:46.002463 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 15 23:44:46.004449 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 23:44:46.006360 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 15 23:44:46.008220 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 15 23:44:46.028095 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 15 23:44:46.033530 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 15 23:44:46.036913 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 15 23:44:46.038336 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 15 23:44:46.038456 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 15 23:44:46.041215 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 15 23:44:46.049393 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 15 23:44:46.051458 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 23:44:46.054325 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 15 23:44:46.059037 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 15 23:44:46.061146 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 15 23:44:46.064901 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 15 23:44:46.067242 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 15 23:44:46.072534 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 15 23:44:46.075503 systemd-journald[1201]: Time spent on flushing to /var/log/journal/01425c53a55644a4a5648ee831ebb5a3 is 33.706ms for 941 entries. Jul 15 23:44:46.075503 systemd-journald[1201]: System Journal (/var/log/journal/01425c53a55644a4a5648ee831ebb5a3) is 8M, max 195.6M, 187.6M free. Jul 15 23:44:46.120373 systemd-journald[1201]: Received client request to flush runtime journal. Jul 15 23:44:46.120462 kernel: loop0: detected capacity change from 0 to 113872 Jul 15 23:44:46.080401 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 15 23:44:46.090306 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 15 23:44:46.096254 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 23:44:46.101577 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 15 23:44:46.103405 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 15 23:44:46.108071 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 15 23:44:46.119866 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 15 23:44:46.125138 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 15 23:44:46.130276 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 15 23:44:46.134384 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 15 23:44:46.162492 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 15 23:44:46.177429 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 15 23:44:46.185875 kernel: loop1: detected capacity change from 0 to 146240 Jul 15 23:44:46.183836 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 15 23:44:46.189914 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 15 23:44:46.242287 kernel: loop2: detected capacity change from 0 to 113872 Jul 15 23:44:46.252699 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Jul 15 23:44:46.253216 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Jul 15 23:44:46.266417 kernel: loop3: detected capacity change from 0 to 146240 Jul 15 23:44:46.263733 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 23:44:46.295460 (sd-merge)[1270]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jul 15 23:44:46.296134 (sd-merge)[1270]: Merged extensions into '/usr'. Jul 15 23:44:46.305308 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 15 23:44:46.309466 systemd[1]: Starting ensure-sysext.service... Jul 15 23:44:46.313412 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 15 23:44:46.359070 systemd[1]: Reload requested from client PID 1273 ('systemctl') (unit ensure-sysext.service)... Jul 15 23:44:46.359121 systemd[1]: Reloading... Jul 15 23:44:46.393732 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 15 23:44:46.395294 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 15 23:44:46.396973 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 15 23:44:46.398681 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 15 23:44:46.399783 systemd-tmpfiles[1274]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 15 23:44:46.400157 systemd-tmpfiles[1274]: ACLs are not supported, ignoring. Jul 15 23:44:46.400676 systemd-tmpfiles[1274]: ACLs are not supported, ignoring. Jul 15 23:44:46.409374 systemd-tmpfiles[1274]: Detected autofs mount point /boot during canonicalization of boot. Jul 15 23:44:46.409396 systemd-tmpfiles[1274]: Skipping /boot Jul 15 23:44:46.432152 systemd-tmpfiles[1274]: Detected autofs mount point /boot during canonicalization of boot. Jul 15 23:44:46.432363 systemd-tmpfiles[1274]: Skipping /boot Jul 15 23:44:46.485234 zram_generator::config[1305]: No configuration found. Jul 15 23:44:46.647397 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 15 23:44:46.762437 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 15 23:44:46.762803 systemd[1]: Reloading finished in 402 ms. Jul 15 23:44:46.810975 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 23:44:46.817491 ldconfig[1244]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 15 23:44:46.820219 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 23:44:46.827608 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 15 23:44:46.839511 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 15 23:44:46.846611 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 15 23:44:46.851028 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 15 23:44:46.861595 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 15 23:44:46.877885 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:46.878155 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 23:44:46.883541 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 23:44:46.897455 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 23:44:46.905825 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 23:44:46.908418 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 23:44:46.908571 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). Jul 15 23:44:46.913483 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 15 23:44:46.915133 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:46.921464 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 15 23:44:46.925028 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 23:44:46.925708 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 23:44:46.929090 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 23:44:46.930166 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 23:44:46.934963 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 23:44:46.935301 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 23:44:46.955829 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:46.956164 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 23:44:46.960907 augenrules[1373]: No rules Jul 15 23:44:46.961464 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 23:44:46.967704 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 23:44:46.987557 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 23:44:46.988990 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 23:44:46.989281 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). Jul 15 23:44:46.989504 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:46.992260 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 23:44:46.992670 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 23:44:46.995108 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 23:44:46.998899 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 23:44:47.002124 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 23:44:47.007775 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 23:44:47.019210 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 23:44:47.019557 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 23:44:47.022339 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 15 23:44:47.028882 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 15 23:44:47.042553 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 15 23:44:47.049944 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:47.052432 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 23:44:47.053829 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 23:44:47.057351 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 23:44:47.083680 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 15 23:44:47.089358 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 23:44:47.094066 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 23:44:47.095388 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 23:44:47.095429 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). Jul 15 23:44:47.095526 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). Jul 15 23:44:47.095550 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 23:44:47.097970 systemd[1]: Finished ensure-sysext.service. Jul 15 23:44:47.111481 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 15 23:44:47.137029 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 23:44:47.137798 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 23:44:47.139912 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 15 23:44:47.140475 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 15 23:44:47.143874 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 23:44:47.144406 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 23:44:47.146838 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 23:44:47.147174 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 23:44:47.154049 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 15 23:44:47.154166 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 15 23:44:47.155152 augenrules[1393]: /sbin/augenrules: No change Jul 15 23:44:47.170157 augenrules[1421]: No rules Jul 15 23:44:47.173071 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 23:44:47.173520 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 23:44:47.229183 systemd-resolved[1344]: Positive Trust Anchors: Jul 15 23:44:47.229739 systemd-resolved[1344]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 15 23:44:47.229926 systemd-resolved[1344]: 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 Jul 15 23:44:47.236326 systemd-resolved[1344]: Defaulting to hostname 'linux'. Jul 15 23:44:47.239152 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 15 23:44:47.241010 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 15 23:44:47.252006 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 15 23:44:47.256354 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 23:44:47.260379 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 15 23:44:47.288481 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 15 23:44:47.297964 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 15 23:44:47.299580 systemd[1]: Reached target time-set.target - System Time Set. Jul 15 23:44:47.325762 systemd-udevd[1428]: Using default interface naming scheme 'v255'. Jul 15 23:44:47.379431 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 23:44:47.381175 systemd[1]: Reached target sysinit.target - System Initialization. Jul 15 23:44:47.382721 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 15 23:44:47.384243 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 15 23:44:47.385865 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jul 15 23:44:47.387468 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 15 23:44:47.389473 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 15 23:44:47.390904 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 15 23:44:47.392366 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 15 23:44:47.392426 systemd[1]: Reached target paths.target - Path Units. Jul 15 23:44:47.393731 systemd[1]: Reached target timers.target - Timer Units. Jul 15 23:44:47.397168 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 15 23:44:47.402171 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 15 23:44:47.413671 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 15 23:44:47.415568 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 15 23:44:47.417091 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 15 23:44:47.432589 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 15 23:44:47.434700 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 15 23:44:47.443542 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 15 23:44:47.447030 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 15 23:44:47.453495 systemd[1]: Reached target sockets.target - Socket Units. Jul 15 23:44:47.454749 systemd[1]: Reached target basic.target - Basic System. Jul 15 23:44:47.456229 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 15 23:44:47.456277 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 15 23:44:47.462469 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 15 23:44:47.503713 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 15 23:44:47.508563 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 15 23:44:47.517656 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 15 23:44:47.520359 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). Jul 15 23:44:47.533419 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jul 15 23:44:47.535046 jq[1465]: false Jul 15 23:44:47.538528 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 15 23:44:47.548440 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 15 23:44:47.553637 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 15 23:44:47.563828 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 15 23:44:47.566359 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 15 23:44:47.568315 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 15 23:44:47.570657 systemd[1]: Starting update-engine.service - Update Engine... Jul 15 23:44:47.581364 extend-filesystems[1466]: Found /dev/vda6 Jul 15 23:44:47.588534 google_oslogin_nss_cache[1468]: oslogin_cache_refresh[1468]: Refreshing passwd entry cache Jul 15 23:44:47.585671 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 15 23:44:47.584065 oslogin_cache_refresh[1468]: Refreshing passwd entry cache Jul 15 23:44:47.588425 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 15 23:44:47.590646 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 15 23:44:47.591467 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 15 23:44:47.591915 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 15 23:44:47.592352 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 15 23:44:47.603241 google_oslogin_nss_cache[1468]: oslogin_cache_refresh[1468]: Failure getting users, quitting Jul 15 23:44:47.605230 oslogin_cache_refresh[1468]: Failure getting users, quitting Jul 15 23:44:47.608061 google_oslogin_nss_cache[1468]: oslogin_cache_refresh[1468]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 15 23:44:47.608061 google_oslogin_nss_cache[1468]: oslogin_cache_refresh[1468]: Refreshing group entry cache Jul 15 23:44:47.608061 google_oslogin_nss_cache[1468]: oslogin_cache_refresh[1468]: Failure getting groups, quitting Jul 15 23:44:47.608061 google_oslogin_nss_cache[1468]: oslogin_cache_refresh[1468]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 15 23:44:47.605284 oslogin_cache_refresh[1468]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 15 23:44:47.605360 oslogin_cache_refresh[1468]: Refreshing group entry cache Jul 15 23:44:47.606230 oslogin_cache_refresh[1468]: Failure getting groups, quitting Jul 15 23:44:47.606244 oslogin_cache_refresh[1468]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 15 23:44:47.609010 extend-filesystems[1466]: Found /dev/vda9 Jul 15 23:44:47.622691 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jul 15 23:44:47.623005 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jul 15 23:44:47.627824 jq[1480]: true Jul 15 23:44:47.649653 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 15 23:44:47.652713 jq[1496]: true Jul 15 23:44:47.664106 systemd[1]: motdgen.service: Deactivated successfully. Jul 15 23:44:47.664516 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 15 23:44:47.679738 update_engine[1478]: I20250715 23:44:47.679622 1478 main.cc:92] Flatcar Update Engine starting Jul 15 23:44:47.694144 extend-filesystems[1466]: Checking size of /dev/vda9 Jul 15 23:44:47.698373 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 15 23:44:47.703461 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 15 23:44:47.718288 dbus-daemon[1462]: [system] SELinux support is enabled Jul 15 23:44:47.718515 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 15 23:44:47.725771 update_engine[1478]: I20250715 23:44:47.725703 1478 update_check_scheduler.cc:74] Next update check in 3m17s Jul 15 23:44:47.730228 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). Jul 15 23:44:47.733522 extend-filesystems[1466]: Old size kept for /dev/vda9 Jul 15 23:44:47.730266 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 15 23:44:47.731923 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). Jul 15 23:44:47.731945 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 15 23:44:47.735024 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 15 23:44:47.735464 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 15 23:44:47.742938 systemd[1]: Started update-engine.service - Update Engine. Jul 15 23:44:47.761453 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 15 23:44:47.769282 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Jul 15 23:44:47.772273 kernel: mousedev: PS/2 mouse device common for all mice Jul 15 23:44:47.776524 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 15 23:44:47.783243 kernel: ACPI: button: Power Button [PWRF] Jul 15 23:44:47.783770 systemd-logind[1474]: New seat seat0. Jul 15 23:44:47.792327 systemd[1]: Started systemd-logind.service - User Login Management. Jul 15 23:44:47.797239 bash[1525]: Updated "/home/core/.ssh/authorized_keys" Jul 15 23:44:47.800076 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 15 23:44:47.802776 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 15 23:44:47.841327 locksmithd[1524]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 15 23:44:47.845437 systemd-networkd[1461]: lo: Link UP Jul 15 23:44:47.845815 systemd-networkd[1461]: lo: Gained carrier Jul 15 23:44:47.847375 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jul 15 23:44:47.848485 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jul 15 23:44:47.849374 systemd-networkd[1461]: Enumeration completed Jul 15 23:44:47.850047 systemd-networkd[1461]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 23:44:47.850058 systemd-networkd[1461]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 23:44:47.855436 systemd-networkd[1461]: eth0: Link UP Jul 15 23:44:47.855784 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 15 23:44:47.856128 systemd-networkd[1461]: eth0: Gained carrier Jul 15 23:44:47.856175 systemd-networkd[1461]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 23:44:47.858174 systemd[1]: Reached target network.target - Network. Jul 15 23:44:47.864127 systemd[1]: Starting containerd.service - containerd container runtime... Jul 15 23:44:47.869240 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 15 23:44:47.872295 systemd-networkd[1461]: eth0: DHCPv4 address 10.0.0.4/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 15 23:44:47.877226 systemd-timesyncd[1399]: Network configuration changed, trying to establish connection. Jul 15 23:44:47.878910 systemd-timesyncd[1399]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 15 23:44:47.879018 systemd-timesyncd[1399]: Initial clock synchronization to Tue 2025-07-15 23:44:47.897927 UTC. Jul 15 23:44:47.893702 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 15 23:44:47.926160 (ntainerd)[1548]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 15 23:44:47.997852 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 15 23:44:48.003629 sshd_keygen[1499]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 15 23:44:48.109918 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 23:44:48.136601 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 15 23:44:48.145701 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 15 23:44:48.225655 systemd[1]: issuegen.service: Deactivated successfully. Jul 15 23:44:48.226166 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 15 23:44:48.234578 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 15 23:44:48.241445 kernel: kvm_amd: TSC scaling supported Jul 15 23:44:48.241588 kernel: kvm_amd: Nested Virtualization enabled Jul 15 23:44:48.241612 kernel: kvm_amd: Nested Paging enabled Jul 15 23:44:48.241629 kernel: kvm_amd: LBR virtualization supported Jul 15 23:44:48.245236 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Jul 15 23:44:48.245314 kernel: kvm_amd: Virtual GIF supported Jul 15 23:44:48.253350 systemd-logind[1474]: Watching system buttons on /dev/input/event2 (Power Button) Jul 15 23:44:48.283444 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 15 23:44:48.285324 systemd-logind[1474]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jul 15 23:44:48.287798 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 15 23:44:48.311693 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 15 23:44:48.313756 systemd[1]: Reached target getty.target - Login Prompts. Jul 15 23:44:48.353238 kernel: EDAC MC: Ver: 3.0.0 Jul 15 23:44:48.513389 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 23:44:48.522880 containerd[1548]: time="2025-07-15T23:44:48Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Jul 15 23:44:48.523767 containerd[1548]: time="2025-07-15T23:44:48.523701145Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 15 23:44:48.539290 containerd[1548]: time="2025-07-15T23:44:48.539159787Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="17.312µs" Jul 15 23:44:48.539290 containerd[1548]: time="2025-07-15T23:44:48.539243384Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 15 23:44:48.539290 containerd[1548]: time="2025-07-15T23:44:48.539270300Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 15 23:44:48.539704 containerd[1548]: time="2025-07-15T23:44:48.539572418Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 15 23:44:48.539704 containerd[1548]: time="2025-07-15T23:44:48.539611736Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 15 23:44:48.539704 containerd[1548]: time="2025-07-15T23:44:48.539647574Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 23:44:48.541306 containerd[1548]: time="2025-07-15T23:44:48.540769782Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 23:44:48.541306 containerd[1548]: time="2025-07-15T23:44:48.540801300Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 15 23:44:48.543371 containerd[1548]: time="2025-07-15T23:44:48.541549251Z" 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 Jul 15 23:44:48.543371 containerd[1548]: time="2025-07-15T23:44:48.542477990Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 23:44:48.544692 containerd[1548]: time="2025-07-15T23:44:48.543858486Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 23:44:48.545623 containerd[1548]: time="2025-07-15T23:44:48.545585761Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 15 23:44:48.545979 containerd[1548]: time="2025-07-15T23:44:48.545931709Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 15 23:44:48.546443 containerd[1548]: time="2025-07-15T23:44:48.546391997Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 15 23:44:48.546491 containerd[1548]: time="2025-07-15T23:44:48.546447275Z" 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 Jul 15 23:44:48.546491 containerd[1548]: time="2025-07-15T23:44:48.546462913Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 15 23:44:48.546555 containerd[1548]: time="2025-07-15T23:44:48.546526510Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 15 23:44:48.547915 containerd[1548]: time="2025-07-15T23:44:48.547764895Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 15 23:44:48.547915 containerd[1548]: time="2025-07-15T23:44:48.547902105Z" level=info msg="metadata content store policy set" policy=shared Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563186927Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563353799Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563378881Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563396395Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563420865Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563439973Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563459732Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563477596Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563494468Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563508793Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563522627Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563540010Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563831541Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 15 23:44:48.566537 containerd[1548]: time="2025-07-15T23:44:48.563864373Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563884703Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563901836Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563917053Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563950406Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563970205Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563985072Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.563999959Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.564015196Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.564042273Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.564147624Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.564169538Z" level=info msg="Start snapshots syncer" Jul 15 23:44:48.567011 containerd[1548]: time="2025-07-15T23:44:48.564240343Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 15 23:44:48.567395 containerd[1548]: time="2025-07-15T23:44:48.564559633Z" 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\"}" Jul 15 23:44:48.567395 containerd[1548]: time="2025-07-15T23:44:48.564644173Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564752400Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564906893Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564936957Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564952757Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564967964Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564983482Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.564996855Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565011362Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565046428Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565065165Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565079270Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565121916Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565142286Z" 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 Jul 15 23:44:48.567579 containerd[1548]: time="2025-07-15T23:44:48.565154215Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565168009Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565245712Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565272047Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565288538Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565337639Z" level=info msg="runtime interface created" Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565346912Z" level=info msg="created NRI interface" Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565368947Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565386360Z" level=info msg="Connect containerd service" Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.565418850Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 15 23:44:48.567924 containerd[1548]: time="2025-07-15T23:44:48.567740376Z" 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" Jul 15 23:44:48.897886 containerd[1548]: time="2025-07-15T23:44:48.897817242Z" level=info msg="Start subscribing containerd event" Jul 15 23:44:48.898132 containerd[1548]: time="2025-07-15T23:44:48.898087330Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898087552Z" level=info msg="Start recovering state" Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898286534Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898460384Z" level=info msg="Start event monitor" Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898479953Z" level=info msg="Start cni network conf syncer for default" Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898499060Z" level=info msg="Start streaming server" Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898509295Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898517616Z" level=info msg="runtime interface starting up..." Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898524312Z" level=info msg="starting plugins..." Jul 15 23:44:48.898681 containerd[1548]: time="2025-07-15T23:44:48.898541445Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 15 23:44:48.898865 systemd[1]: Started containerd.service - containerd container runtime. Jul 15 23:44:48.901110 containerd[1548]: time="2025-07-15T23:44:48.899371850Z" level=info msg="containerd successfully booted in 0.377530s" Jul 15 23:44:49.691424 systemd-networkd[1461]: eth0: Gained IPv6LL Jul 15 23:44:49.703483 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 15 23:44:49.715082 systemd[1]: Reached target network-online.target - Network is Online. Jul 15 23:44:49.719875 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 15 23:44:49.727414 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 15 23:44:49.781772 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 15 23:44:49.796498 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 15 23:44:49.796901 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 15 23:44:49.800154 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 15 23:44:49.800779 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 15 23:44:49.806611 systemd[1]: Startup finished in 3.266s (kernel) + 5.353s (initrd) + 4.870s (userspace) = 13.490s. Jul 15 23:44:54.408358 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 15 23:44:54.410392 systemd[1]: Started sshd@0-10.0.0.4:22-10.0.0.1:56946.service - OpenSSH per-connection server daemon (10.0.0.1:56946). Jul 15 23:44:54.484855 sshd[1626]: Accepted publickey for core from 10.0.0.1 port 56946 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:54.487616 sshd-session[1626]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:54.498590 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 15 23:44:54.500280 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 15 23:44:54.507797 systemd-logind[1474]: New session 1 of user core. Jul 15 23:44:54.530185 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 15 23:44:54.534434 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 15 23:44:54.566985 (systemd)[1630]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 15 23:44:54.570525 systemd-logind[1474]: New session c1 of user core. Jul 15 23:44:54.735773 systemd[1630]: Queued start job for default target default.target. Jul 15 23:44:54.759107 systemd[1630]: Created slice app.slice - User Application Slice. Jul 15 23:44:54.759143 systemd[1630]: Reached target paths.target - Paths. Jul 15 23:44:54.759230 systemd[1630]: Reached target timers.target - Timers. Jul 15 23:44:54.761347 systemd[1630]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 15 23:44:54.774366 systemd[1630]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 15 23:44:54.774576 systemd[1630]: Reached target sockets.target - Sockets. Jul 15 23:44:54.774639 systemd[1630]: Reached target basic.target - Basic System. Jul 15 23:44:54.774679 systemd[1630]: Reached target default.target - Main User Target. Jul 15 23:44:54.774725 systemd[1630]: Startup finished in 196ms. Jul 15 23:44:54.775019 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 15 23:44:54.785623 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 15 23:44:54.857296 systemd[1]: Started sshd@1-10.0.0.4:22-10.0.0.1:56950.service - OpenSSH per-connection server daemon (10.0.0.1:56950). Jul 15 23:44:54.912373 sshd[1641]: Accepted publickey for core from 10.0.0.1 port 56950 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:54.914490 sshd-session[1641]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:54.921122 systemd-logind[1474]: New session 2 of user core. Jul 15 23:44:54.933525 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 15 23:44:54.989185 sshd[1643]: Connection closed by 10.0.0.1 port 56950 Jul 15 23:44:54.989464 sshd-session[1641]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:55.003457 systemd[1]: sshd@1-10.0.0.4:22-10.0.0.1:56950.service: Deactivated successfully. Jul 15 23:44:55.005560 systemd[1]: session-2.scope: Deactivated successfully. Jul 15 23:44:55.006491 systemd-logind[1474]: Session 2 logged out. Waiting for processes to exit. Jul 15 23:44:55.009879 systemd[1]: Started sshd@2-10.0.0.4:22-10.0.0.1:56952.service - OpenSSH per-connection server daemon (10.0.0.1:56952). Jul 15 23:44:55.010711 systemd-logind[1474]: Removed session 2. Jul 15 23:44:55.063539 sshd[1649]: Accepted publickey for core from 10.0.0.1 port 56952 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:55.065577 sshd-session[1649]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:55.070386 systemd-logind[1474]: New session 3 of user core. Jul 15 23:44:55.080443 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 15 23:44:55.132923 sshd[1651]: Connection closed by 10.0.0.1 port 56952 Jul 15 23:44:55.133385 sshd-session[1649]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:55.146150 systemd[1]: sshd@2-10.0.0.4:22-10.0.0.1:56952.service: Deactivated successfully. Jul 15 23:44:55.147979 systemd[1]: session-3.scope: Deactivated successfully. Jul 15 23:44:55.148704 systemd-logind[1474]: Session 3 logged out. Waiting for processes to exit. Jul 15 23:44:55.151712 systemd[1]: Started sshd@3-10.0.0.4:22-10.0.0.1:56960.service - OpenSSH per-connection server daemon (10.0.0.1:56960). Jul 15 23:44:55.152338 systemd-logind[1474]: Removed session 3. Jul 15 23:44:55.206559 sshd[1657]: Accepted publickey for core from 10.0.0.1 port 56960 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:55.208597 sshd-session[1657]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:55.214219 systemd-logind[1474]: New session 4 of user core. Jul 15 23:44:55.224453 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 15 23:44:55.284366 sshd[1659]: Connection closed by 10.0.0.1 port 56960 Jul 15 23:44:55.284700 sshd-session[1657]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:55.303014 systemd[1]: sshd@3-10.0.0.4:22-10.0.0.1:56960.service: Deactivated successfully. Jul 15 23:44:55.305014 systemd[1]: session-4.scope: Deactivated successfully. Jul 15 23:44:55.305816 systemd-logind[1474]: Session 4 logged out. Waiting for processes to exit. Jul 15 23:44:55.308919 systemd[1]: Started sshd@4-10.0.0.4:22-10.0.0.1:56964.service - OpenSSH per-connection server daemon (10.0.0.1:56964). Jul 15 23:44:55.309858 systemd-logind[1474]: Removed session 4. Jul 15 23:44:55.367607 sshd[1665]: Accepted publickey for core from 10.0.0.1 port 56964 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:55.369775 sshd-session[1665]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:55.374568 systemd-logind[1474]: New session 5 of user core. Jul 15 23:44:55.385336 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 15 23:44:55.444509 sudo[1668]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 15 23:44:55.444834 sudo[1668]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 23:44:55.459442 sudo[1668]: pam_unix(sudo:session): session closed for user root Jul 15 23:44:55.461007 sshd[1667]: Connection closed by 10.0.0.1 port 56964 Jul 15 23:44:55.461472 sshd-session[1665]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:55.481735 systemd[1]: sshd@4-10.0.0.4:22-10.0.0.1:56964.service: Deactivated successfully. Jul 15 23:44:55.484487 systemd[1]: session-5.scope: Deactivated successfully. Jul 15 23:44:55.485461 systemd-logind[1474]: Session 5 logged out. Waiting for processes to exit. Jul 15 23:44:55.489830 systemd[1]: Started sshd@5-10.0.0.4:22-10.0.0.1:56976.service - OpenSSH per-connection server daemon (10.0.0.1:56976). Jul 15 23:44:55.490525 systemd-logind[1474]: Removed session 5. Jul 15 23:44:55.548578 sshd[1674]: Accepted publickey for core from 10.0.0.1 port 56976 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:55.551164 sshd-session[1674]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:55.557401 systemd-logind[1474]: New session 6 of user core. Jul 15 23:44:55.567552 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 15 23:44:55.625657 sudo[1678]: 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 Jul 15 23:44:55.626081 sudo[1678]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 23:44:55.635071 sudo[1678]: pam_unix(sudo:session): session closed for user root Jul 15 23:44:55.643223 sudo[1677]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 15 23:44:55.643549 sudo[1677]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 23:44:55.655180 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 23:44:55.711665 augenrules[1700]: No rules Jul 15 23:44:55.713499 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 23:44:55.713787 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 23:44:55.715050 sudo[1677]: pam_unix(sudo:session): session closed for user root Jul 15 23:44:55.716618 sshd[1676]: Connection closed by 10.0.0.1 port 56976 Jul 15 23:44:55.716877 sshd-session[1674]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:55.734511 systemd[1]: sshd@5-10.0.0.4:22-10.0.0.1:56976.service: Deactivated successfully. Jul 15 23:44:55.736575 systemd[1]: session-6.scope: Deactivated successfully. Jul 15 23:44:55.737578 systemd-logind[1474]: Session 6 logged out. Waiting for processes to exit. Jul 15 23:44:55.740976 systemd[1]: Started sshd@6-10.0.0.4:22-10.0.0.1:56988.service - OpenSSH per-connection server daemon (10.0.0.1:56988). Jul 15 23:44:55.741713 systemd-logind[1474]: Removed session 6. Jul 15 23:44:55.795241 sshd[1709]: Accepted publickey for core from 10.0.0.1 port 56988 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:55.796991 sshd-session[1709]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:55.802561 systemd-logind[1474]: New session 7 of user core. Jul 15 23:44:55.817466 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 15 23:44:55.877604 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 15 23:44:55.904771 (dockerd)[1713]: 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 Jul 15 23:44:56.251061 dockerd[1713]: time="2025-07-15T23:44:56.250880150Z" level=info msg="Starting up" Jul 15 23:44:56.252824 dockerd[1713]: time="2025-07-15T23:44:56.252789088Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 15 23:44:56.345623 dockerd[1713]: time="2025-07-15T23:44:56.345534193Z" level=info msg="Loading containers: start." Jul 15 23:44:56.357270 kernel: Initializing XFRM netlink socket Jul 15 23:44:56.648539 systemd-networkd[1461]: docker0: Link UP Jul 15 23:44:56.654814 dockerd[1713]: time="2025-07-15T23:44:56.654745822Z" level=info msg="Loading containers: done." Jul 15 23:44:56.675177 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck594786583-merged.mount: Deactivated successfully. Jul 15 23:44:56.676846 dockerd[1713]: time="2025-07-15T23:44:56.676779371Z" 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 Jul 15 23:44:56.676982 dockerd[1713]: time="2025-07-15T23:44:56.676948918Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 15 23:44:56.677147 dockerd[1713]: time="2025-07-15T23:44:56.677113984Z" level=info msg="Initializing buildkit" Jul 15 23:44:56.714515 dockerd[1713]: time="2025-07-15T23:44:56.714426362Z" level=info msg="Completed buildkit initialization" Jul 15 23:44:56.720845 dockerd[1713]: time="2025-07-15T23:44:56.720600593Z" level=info msg="Daemon has completed initialization" Jul 15 23:44:56.721018 dockerd[1713]: time="2025-07-15T23:44:56.720917915Z" level=info msg="API listen on /run/docker.sock" Jul 15 23:44:56.721026 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 15 23:44:56.736824 sshd[1711]: Connection closed by 10.0.0.1 port 56988 Jul 15 23:44:56.737339 sshd-session[1709]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:56.751891 systemd[1]: sshd@6-10.0.0.4:22-10.0.0.1:56988.service: Deactivated successfully. Jul 15 23:44:56.754293 systemd[1]: session-7.scope: Deactivated successfully. Jul 15 23:44:56.755166 systemd-logind[1474]: Session 7 logged out. Waiting for processes to exit. Jul 15 23:44:56.758425 systemd[1]: Started sshd@7-10.0.0.4:22-10.0.0.1:57042.service - OpenSSH per-connection server daemon (10.0.0.1:57042). Jul 15 23:44:56.759004 systemd-logind[1474]: Removed session 7. Jul 15 23:44:56.808455 sshd[1917]: Accepted publickey for core from 10.0.0.1 port 57042 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:56.810782 sshd-session[1917]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:56.817162 systemd-logind[1474]: New session 8 of user core. Jul 15 23:44:56.827457 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 15 23:44:58.357273 systemd[1]: var-lib-docker-overlay2-6ff1b55046223fbbfe84d9fc62ddfa07d32c3973b35a19d1cab25f4367bd6f08\x2dinit-merged.mount: Deactivated successfully. Jul 15 23:44:58.446041 containerd[1548]: time="2025-07-15T23:44:58.445913296Z" level=info msg="connecting to shim 78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d" address="unix:///run/containerd/s/0c0da9065e4143a1c882ed23f6e22ca0fb8aa6e29f9a5c715d0f7ffd33f9ee80" namespace=moby protocol=ttrpc version=3 Jul 15 23:44:58.522417 systemd[1]: Started docker-78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d.scope - libcontainer container 78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d. Jul 15 23:44:58.545943 systemd-resolved[1344]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 15 23:44:58.583247 kernel: docker0: port 1(vethe0d339e) entered blocking state Jul 15 23:44:58.583371 kernel: docker0: port 1(vethe0d339e) entered disabled state Jul 15 23:44:58.583403 kernel: vethe0d339e: entered allmulticast mode Jul 15 23:44:58.584502 kernel: vethe0d339e: entered promiscuous mode Jul 15 23:44:58.584835 systemd-networkd[1461]: vethe0d339e: Link UP Jul 15 23:44:58.597240 kernel: eth0: renamed from veth3edeb47 Jul 15 23:44:58.601595 kernel: docker0: port 1(vethe0d339e) entered blocking state Jul 15 23:44:58.601645 kernel: docker0: port 1(vethe0d339e) entered forwarding state Jul 15 23:44:58.601681 systemd-networkd[1461]: vethe0d339e: Gained carrier Jul 15 23:44:58.602119 systemd-networkd[1461]: docker0: Gained carrier Jul 15 23:44:58.647698 sshd[1919]: Connection closed by 10.0.0.1 port 57042 Jul 15 23:44:58.648118 sshd-session[1917]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:58.656831 systemd[1]: sshd@7-10.0.0.4:22-10.0.0.1:57042.service: Deactivated successfully. Jul 15 23:44:58.658908 systemd[1]: session-8.scope: Deactivated successfully. Jul 15 23:44:58.659689 systemd-logind[1474]: Session 8 logged out. Waiting for processes to exit. Jul 15 23:44:58.662782 systemd[1]: Started sshd@8-10.0.0.4:22-10.0.0.1:33562.service - OpenSSH per-connection server daemon (10.0.0.1:33562). Jul 15 23:44:58.663420 systemd-logind[1474]: Removed session 8. Jul 15 23:44:58.725578 sshd[1992]: Accepted publickey for core from 10.0.0.1 port 33562 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:58.727493 sshd-session[1992]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:58.733136 systemd-logind[1474]: New session 9 of user core. Jul 15 23:44:58.742426 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 15 23:44:58.803786 sshd[1994]: Connection closed by 10.0.0.1 port 33562 Jul 15 23:44:58.804337 sshd-session[1992]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:58.819349 systemd[1]: sshd@8-10.0.0.4:22-10.0.0.1:33562.service: Deactivated successfully. Jul 15 23:44:58.821333 systemd[1]: session-9.scope: Deactivated successfully. Jul 15 23:44:58.822220 systemd-logind[1474]: Session 9 logged out. Waiting for processes to exit. Jul 15 23:44:58.825503 systemd[1]: Started sshd@9-10.0.0.4:22-10.0.0.1:33576.service - OpenSSH per-connection server daemon (10.0.0.1:33576). Jul 15 23:44:58.826381 systemd-logind[1474]: Removed session 9. Jul 15 23:44:58.887157 sshd[2000]: Accepted publickey for core from 10.0.0.1 port 33576 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:58.889378 sshd-session[2000]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:58.894518 systemd-logind[1474]: New session 10 of user core. Jul 15 23:44:58.908427 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 15 23:44:58.968737 sudo[2003]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1548 Jul 15 23:44:58.969235 sudo[2003]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 23:44:58.974237 sudo[2003]: pam_unix(sudo:session): session closed for user root Jul 15 23:44:58.974494 containerd[1548]: time="2025-07-15T23:44:58.974430381Z" level=info msg="Stop CRI service" Jul 15 23:44:58.974886 dockerd[1713]: time="2025-07-15T23:44:58.974824111Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 15 23:44:58.975147 dockerd[1713]: time="2025-07-15T23:44:58.974882766Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 15 23:44:58.975238 dockerd[1713]: time="2025-07-15T23:44:58.975167405Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 15 23:44:58.975238 dockerd[1713]: time="2025-07-15T23:44:58.975190268Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 15 23:44:58.975759 sshd[2002]: Connection closed by 10.0.0.1 port 33576 Jul 15 23:44:58.976116 sshd-session[2000]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:58.985576 systemd[1]: containerd.service: Deactivated successfully. Jul 15 23:44:58.985714 systemd[1]: containerd.service: Unit process 1944 (containerd-shim) remains running after unit stopped. Jul 15 23:44:58.986011 systemd[1]: containerd.service: Consumed 770ms CPU time, 136.2M memory peak. Jul 15 23:44:58.986492 systemd[1]: sshd@9-10.0.0.4:22-10.0.0.1:33576.service: Deactivated successfully. Jul 15 23:44:58.988468 systemd[1]: session-10.scope: Deactivated successfully. Jul 15 23:44:58.990093 systemd-logind[1474]: Session 10 logged out. Waiting for processes to exit. Jul 15 23:44:58.993592 systemd[1]: Started sshd@10-10.0.0.4:22-10.0.0.1:33578.service - OpenSSH per-connection server daemon (10.0.0.1:33578). Jul 15 23:44:58.994373 systemd-logind[1474]: Removed session 10. Jul 15 23:44:59.044968 sshd[2010]: Accepted publickey for core from 10.0.0.1 port 33578 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:44:59.047333 sshd-session[2010]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:44:59.052489 systemd-logind[1474]: New session 11 of user core. Jul 15 23:44:59.063360 systemd[1]: Started session-11.scope - Session 11 of User core. Jul 15 23:44:59.122567 sshd[2012]: Connection closed by 10.0.0.1 port 33578 Jul 15 23:44:59.122937 sshd-session[2010]: pam_unix(sshd:session): session closed for user core Jul 15 23:44:59.126804 systemd[1]: sshd@10-10.0.0.4:22-10.0.0.1:33578.service: Deactivated successfully. Jul 15 23:44:59.129377 systemd[1]: session-11.scope: Deactivated successfully. Jul 15 23:44:59.130231 systemd-logind[1474]: Session 11 logged out. Waiting for processes to exit. Jul 15 23:44:59.132771 systemd-logind[1474]: Removed session 11. Jul 15 23:44:59.675414 systemd-networkd[1461]: docker0: Gained IPv6LL Jul 15 23:44:59.866463 systemd-networkd[1461]: vethe0d339e: Gained IPv6LL Jul 15 23:45:04.048855 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Jul 15 23:45:04.049429 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 15 23:45:04.049523 dockerd[1713]: time="2025-07-15T23:45:04.049473969Z" level=info msg="Processing signal 'terminated'" Jul 15 23:45:05.142723 systemd[1]: Started sshd@11-10.0.0.4:22-10.0.0.1:33582.service - OpenSSH per-connection server daemon (10.0.0.1:33582). Jul 15 23:45:05.207682 sshd[2018]: Accepted publickey for core from 10.0.0.1 port 33582 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:05.209910 sshd-session[2018]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:05.215561 systemd-logind[1474]: New session 12 of user core. Jul 15 23:45:05.230423 systemd[1]: Started session-12.scope - Session 12 of User core. Jul 15 23:45:05.291278 sshd[2020]: Connection closed by 10.0.0.1 port 33582 Jul 15 23:45:05.291756 sshd-session[2018]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:05.297786 systemd[1]: sshd@11-10.0.0.4:22-10.0.0.1:33582.service: Deactivated successfully. Jul 15 23:45:05.300678 systemd[1]: session-12.scope: Deactivated successfully. Jul 15 23:45:05.301716 systemd-logind[1474]: Session 12 logged out. Waiting for processes to exit. Jul 15 23:45:05.303187 systemd-logind[1474]: Removed session 12. Jul 15 23:45:06.050483 dockerd[1713]: time="2025-07-15T23:45:06.050400642Z" level=error msg="Error sending stop (signal 15) to container" container=78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d error="Cannot kill container 78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" Jul 15 23:45:06.050483 dockerd[1713]: time="2025-07-15T23:45:06.050463280Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d Jul 15 23:45:11.307760 systemd[1]: Started sshd@12-10.0.0.4:22-10.0.0.1:49408.service - OpenSSH per-connection server daemon (10.0.0.1:49408). Jul 15 23:45:11.368799 sshd[2026]: Accepted publickey for core from 10.0.0.1 port 49408 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:11.371647 sshd-session[2026]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:11.378253 systemd-logind[1474]: New session 13 of user core. Jul 15 23:45:11.388560 systemd[1]: Started session-13.scope - Session 13 of User core. Jul 15 23:45:11.449306 sshd[2028]: Connection closed by 10.0.0.1 port 49408 Jul 15 23:45:11.449682 sshd-session[2026]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:11.454302 systemd[1]: sshd@12-10.0.0.4:22-10.0.0.1:49408.service: Deactivated successfully. Jul 15 23:45:11.457300 systemd[1]: session-13.scope: Deactivated successfully. Jul 15 23:45:11.460132 systemd-logind[1474]: Session 13 logged out. Waiting for processes to exit. Jul 15 23:45:11.462215 systemd-logind[1474]: Removed session 13. Jul 15 23:45:16.051441 dockerd[1713]: time="2025-07-15T23:45:16.051340147Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d error="context deadline exceeded" Jul 15 23:45:16.052442 systemd[1]: docker-78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d.scope: Deactivated successfully. Jul 15 23:45:17.466022 systemd[1]: Started sshd@13-10.0.0.4:22-10.0.0.1:49436.service - OpenSSH per-connection server daemon (10.0.0.1:49436). Jul 15 23:45:17.517864 sshd[2035]: Accepted publickey for core from 10.0.0.1 port 49436 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:17.519390 sshd-session[2035]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:17.524481 systemd-logind[1474]: New session 14 of user core. Jul 15 23:45:17.535341 systemd[1]: Started session-14.scope - Session 14 of User core. Jul 15 23:45:17.593523 sshd[2037]: Connection closed by 10.0.0.1 port 49436 Jul 15 23:45:17.594006 sshd-session[2035]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:17.599313 systemd[1]: sshd@13-10.0.0.4:22-10.0.0.1:49436.service: Deactivated successfully. Jul 15 23:45:17.601493 systemd[1]: session-14.scope: Deactivated successfully. Jul 15 23:45:17.602446 systemd-logind[1474]: Session 14 logged out. Waiting for processes to exit. Jul 15 23:45:17.603871 systemd-logind[1474]: Removed session 14. Jul 15 23:45:19.050463 dockerd[1713]: time="2025-07-15T23:45:19.050396256Z" level=error msg="Force shutdown daemon" Jul 15 23:45:19.051007 dockerd[1713]: time="2025-07-15T23:45:19.050612360Z" level=info msg="Daemon shutdown complete" Jul 15 23:45:19.055880 systemd[1]: docker.service: Deactivated successfully. Jul 15 23:45:19.056367 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 15 23:45:19.056431 systemd[1]: docker.service: Consumed 1.285s CPU time, 131M memory peak. Jul 15 23:45:19.057019 systemd[1]: docker.socket: Deactivated successfully. Jul 15 23:45:19.057530 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 15 23:45:19.057585 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 15 23:45:19.059775 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 15 23:45:19.060026 systemd[1]: containerd.service: Found left-over process 1944 (containerd-shim) in control group while starting unit. Ignoring. Jul 15 23:45:19.060033 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 15 23:45:19.070820 systemd[1]: Starting containerd.service - containerd container runtime... Jul 15 23:45:19.071764 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 15 23:45:19.095324 systemd[1]: containerd.service: Found left-over process 1944 (containerd-shim) in control group while starting unit. Ignoring. Jul 15 23:45:19.095333 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 15 23:45:19.119716 (ntainerd)[2048]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 15 23:45:19.139009 containerd[2048]: time="2025-07-15T23:45:19Z" 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 Jul 15 23:45:19.139776 containerd[2048]: time="2025-07-15T23:45:19.139733677Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 15 23:45:19.149426 containerd[2048]: time="2025-07-15T23:45:19.149346576Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.759µs" Jul 15 23:45:19.149426 containerd[2048]: time="2025-07-15T23:45:19.149394086Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 15 23:45:19.149426 containerd[2048]: time="2025-07-15T23:45:19.149414780Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 15 23:45:19.149636 containerd[2048]: time="2025-07-15T23:45:19.149456547Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 15 23:45:19.149636 containerd[2048]: time="2025-07-15T23:45:19.149468753Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 15 23:45:19.149768 containerd[2048]: time="2025-07-15T23:45:19.149734852Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 23:45:19.149806 containerd[2048]: time="2025-07-15T23:45:19.149770677Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 23:45:19.149806 containerd[2048]: time="2025-07-15T23:45:19.149782912Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 15 23:45:19.150104 containerd[2048]: time="2025-07-15T23:45:19.150071488Z" 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 Jul 15 23:45:19.150104 containerd[2048]: time="2025-07-15T23:45:19.150087091Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 23:45:19.150104 containerd[2048]: time="2025-07-15T23:45:19.150096881Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 23:45:19.150104 containerd[2048]: time="2025-07-15T23:45:19.150104437Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 15 23:45:19.150244 containerd[2048]: time="2025-07-15T23:45:19.150140703Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 15 23:45:19.150326 containerd[2048]: time="2025-07-15T23:45:19.150285537Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 15 23:45:19.150326 containerd[2048]: time="2025-07-15T23:45:19.150320410Z" 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 Jul 15 23:45:19.150385 containerd[2048]: time="2025-07-15T23:45:19.150330742Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 15 23:45:19.150385 containerd[2048]: time="2025-07-15T23:45:19.150369974Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 15 23:45:19.150606 containerd[2048]: time="2025-07-15T23:45:19.150573922Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 15 23:45:19.150606 containerd[2048]: time="2025-07-15T23:45:19.150598073Z" level=info msg="metadata content store policy set" policy=shared Jul 15 23:45:19.150775 containerd[2048]: time="2025-07-15T23:45:19.150743940Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 15 23:45:19.150808 containerd[2048]: time="2025-07-15T23:45:19.150777430Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 15 23:45:19.150836 containerd[2048]: time="2025-07-15T23:45:19.150820661Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 15 23:45:19.150836 containerd[2048]: time="2025-07-15T23:45:19.150833828Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 15 23:45:19.150887 containerd[2048]: time="2025-07-15T23:45:19.150847717Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 15 23:45:19.150887 containerd[2048]: time="2025-07-15T23:45:19.150858459Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 15 23:45:19.150887 containerd[2048]: time="2025-07-15T23:45:19.150870094Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 15 23:45:19.150887 containerd[2048]: time="2025-07-15T23:45:19.150880676Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 15 23:45:19.150887 containerd[2048]: time="2025-07-15T23:45:19.150889915Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 15 23:45:19.151032 containerd[2048]: time="2025-07-15T23:45:19.150899817Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 15 23:45:19.151032 containerd[2048]: time="2025-07-15T23:45:19.150909056Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 15 23:45:19.151032 containerd[2048]: time="2025-07-15T23:45:19.150924218Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 15 23:45:19.151178 containerd[2048]: time="2025-07-15T23:45:19.151145723Z" level=info msg="connecting to shim 78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d" address="unix:///run/containerd/s/0c0da9065e4143a1c882ed23f6e22ca0fb8aa6e29f9a5c715d0f7ffd33f9ee80" namespace=moby protocol=ttrpc version=3 Jul 15 23:45:19.221980 containerd[2048]: time="2025-07-15T23:45:19.221921290Z" level=info msg="cleaning leaked shim process" id=78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d namespace=moby Jul 15 23:45:19.235887 containerd[2048]: time="2025-07-15T23:45:19.235778859Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 15 23:45:19.236150 containerd[2048]: time="2025-07-15T23:45:19.236109312Z" level=info msg="shim disconnected" id=78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d namespace=moby Jul 15 23:45:19.236150 containerd[2048]: time="2025-07-15T23:45:19.236147652Z" level=warning msg="cleaning up after shim disconnected" id=78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d namespace=moby Jul 15 23:45:19.236261 containerd[2048]: time="2025-07-15T23:45:19.236156822Z" level=info msg="cleaning up dead shim" namespace=moby Jul 15 23:45:19.252449 containerd[2048]: time="2025-07-15T23:45:19.252378894Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jul 15 23:45:19.252640 containerd[2048]: time="2025-07-15T23:45:19.252608787Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 15 23:45:19.252697 containerd[2048]: time="2025-07-15T23:45:19.252672911Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 15 23:45:19.252769 containerd[2048]: time="2025-07-15T23:45:19.252721022Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 15 23:45:19.252769 containerd[2048]: time="2025-07-15T23:45:19.252747478Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 15 23:45:19.252769 containerd[2048]: time="2025-07-15T23:45:19.252762670Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 15 23:45:19.252769 containerd[2048]: time="2025-07-15T23:45:19.252779205Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252795419Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252812385Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252831244Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252860856Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252879105Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252979525Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 15 23:45:19.253025 containerd[2048]: time="2025-07-15T23:45:19.252998986Z" level=info msg="Start snapshots syncer" Jul 15 23:45:19.253253 containerd[2048]: time="2025-07-15T23:45:19.253040153Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 15 23:45:19.253555 containerd[2048]: time="2025-07-15T23:45:19.253491530Z" 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\"}" Jul 15 23:45:19.253691 containerd[2048]: time="2025-07-15T23:45:19.253566567Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 15 23:45:19.253691 containerd[2048]: time="2025-07-15T23:45:19.253656948Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 15 23:45:19.253748 containerd[2048]: time="2025-07-15T23:45:19.253715490Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 15 23:45:19.253772 containerd[2048]: time="2025-07-15T23:45:19.253743699Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 15 23:45:19.253772 containerd[2048]: time="2025-07-15T23:45:19.253761767Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 15 23:45:19.253821 containerd[2048]: time="2025-07-15T23:45:19.253778132Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 15 23:45:19.278068 containerd[2048]: time="2025-07-15T23:45:19.278009597Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 15 23:45:19.278068 containerd[2048]: time="2025-07-15T23:45:19.278054641Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 15 23:45:19.278068 containerd[2048]: time="2025-07-15T23:45:19.278072940Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 15 23:45:19.278273 containerd[2048]: time="2025-07-15T23:45:19.278121271Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 15 23:45:19.278273 containerd[2048]: time="2025-07-15T23:45:19.278135070Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 15 23:45:19.278273 containerd[2048]: time="2025-07-15T23:45:19.278147034Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 15 23:45:19.278273 containerd[2048]: time="2025-07-15T23:45:19.278230991Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 15 23:45:19.278273 containerd[2048]: time="2025-07-15T23:45:19.278267498Z" 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 Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278282129Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278295166Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278306109Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278319567Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278334970Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278371376Z" level=info msg="runtime interface created" Jul 15 23:45:19.278387 containerd[2048]: time="2025-07-15T23:45:19.278379844Z" level=info msg="created NRI interface" Jul 15 23:45:19.278528 containerd[2048]: time="2025-07-15T23:45:19.278391237Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 15 23:45:19.278528 containerd[2048]: time="2025-07-15T23:45:19.278410318Z" level=info msg="Connect containerd service" Jul 15 23:45:19.278528 containerd[2048]: time="2025-07-15T23:45:19.278443938Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 15 23:45:19.279385 containerd[2048]: time="2025-07-15T23:45:19.279344789Z" 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" Jul 15 23:45:19.291482 containerd[2048]: time="2025-07-15T23:45:19.291429326Z" level=info msg="Start subscribing containerd event" Jul 15 23:45:19.291644 containerd[2048]: time="2025-07-15T23:45:19.291493000Z" level=info msg="Start recovering state" Jul 15 23:45:19.291644 containerd[2048]: time="2025-07-15T23:45:19.291596376Z" level=info msg="Start event monitor" Jul 15 23:45:19.291644 containerd[2048]: time="2025-07-15T23:45:19.291611930Z" level=info msg="Start cni network conf syncer for default" Jul 15 23:45:19.291644 containerd[2048]: time="2025-07-15T23:45:19.291620257Z" level=info msg="Start streaming server" Jul 15 23:45:19.291644 containerd[2048]: time="2025-07-15T23:45:19.291637003Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 15 23:45:19.291644 containerd[2048]: time="2025-07-15T23:45:19.291646352Z" level=info msg="runtime interface starting up..." Jul 15 23:45:19.291763 containerd[2048]: time="2025-07-15T23:45:19.291658006Z" level=info msg="starting plugins..." Jul 15 23:45:19.291763 containerd[2048]: time="2025-07-15T23:45:19.291677007Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 15 23:45:19.291763 containerd[2048]: time="2025-07-15T23:45:19.291682498Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 15 23:45:19.291763 containerd[2048]: time="2025-07-15T23:45:19.291733154Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 15 23:45:19.291881 containerd[2048]: time="2025-07-15T23:45:19.291822581Z" level=info msg="containerd successfully booted in 0.153080s" Jul 15 23:45:19.292105 systemd[1]: Started containerd.service - containerd container runtime. Jul 15 23:45:19.295089 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 15 23:45:19.307663 (dockerd)[2097]: 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 Jul 15 23:45:19.347578 dockerd[2097]: time="2025-07-15T23:45:19.347502771Z" level=info msg="Starting up" Jul 15 23:45:19.348496 dockerd[2097]: time="2025-07-15T23:45:19.348470183Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 15 23:45:19.387053 dockerd[2097]: time="2025-07-15T23:45:19.386992406Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 15 23:45:19.412813 dockerd[2097]: time="2025-07-15T23:45:19.412718658Z" level=info msg="Loading containers: start." Jul 15 23:45:19.431304 systemd[1]: var-lib-docker-overlay2-6ff1b55046223fbbfe84d9fc62ddfa07d32c3973b35a19d1cab25f4367bd6f08-merged.mount: Deactivated successfully. Jul 15 23:45:19.859041 systemd-networkd[1461]: vethe0d339e: Link DOWN Jul 15 23:45:19.859051 systemd-networkd[1461]: vethe0d339e: Lost carrier Jul 15 23:45:19.860238 kernel: docker0: port 1(vethe0d339e) entered disabled state Jul 15 23:45:19.862877 kernel: vethe0d339e (unregistering): left allmulticast mode Jul 15 23:45:19.862927 kernel: vethe0d339e (unregistering): left promiscuous mode Jul 15 23:45:19.862967 kernel: docker0: port 1(vethe0d339e) entered disabled state Jul 15 23:45:19.863714 systemd-networkd[1461]: docker0: Lost carrier Jul 15 23:45:19.864860 dockerd[2097]: time="2025-07-15T23:45:19.864821972Z" level=info msg="Removing stale sandbox ee7891184b2ce3f6a98def425fc37681187b776ae634365e4c1d640137527a81 (78653d4f2a3ce2f5745f9a197392866b76941e5adb8274b561b6747ba1851f3d)" Jul 15 23:45:19.871830 dockerd[2097]: time="2025-07-15T23:45:19.871778535Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 15 23:45:19.871915 dockerd[2097]: time="2025-07-15T23:45:19.871834262Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 5f4520f989826ec4da9e70e1745c60c4f430b4782ff5cecc2d12b465290e0b60 5bc0690fb45a9799ac0b5373447bda6a65bc8f8a0cdb6721aba1d223b277dcc3], retrying...." Jul 15 23:45:20.143997 dockerd[2097]: time="2025-07-15T23:45:20.143874892Z" level=warning msg="error locating sandbox id ee7891184b2ce3f6a98def425fc37681187b776ae634365e4c1d640137527a81: sandbox ee7891184b2ce3f6a98def425fc37681187b776ae634365e4c1d640137527a81 not found" Jul 15 23:45:20.144249 dockerd[2097]: time="2025-07-15T23:45:20.144214442Z" level=info msg="Loading containers: done." Jul 15 23:45:20.159331 dockerd[2097]: time="2025-07-15T23:45:20.159270982Z" 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 Jul 15 23:45:20.159575 dockerd[2097]: time="2025-07-15T23:45:20.159381443Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 15 23:45:20.159575 dockerd[2097]: time="2025-07-15T23:45:20.159462573Z" level=info msg="Initializing buildkit" Jul 15 23:45:20.179289 dockerd[2097]: time="2025-07-15T23:45:20.179231903Z" level=info msg="Completed buildkit initialization" Jul 15 23:45:20.184183 dockerd[2097]: time="2025-07-15T23:45:20.184108655Z" level=info msg="Daemon has completed initialization" Jul 15 23:45:20.184359 dockerd[2097]: time="2025-07-15T23:45:20.184269442Z" level=info msg="API listen on /run/docker.sock" Jul 15 23:45:20.184428 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 15 23:45:20.371616 systemd[1]: run-docker-netns-ee7891184b2c.mount: Deactivated successfully. Jul 15 23:45:23.612818 systemd[1]: Started sshd@14-10.0.0.4:22-10.0.0.1:39546.service - OpenSSH per-connection server daemon (10.0.0.1:39546). Jul 15 23:45:23.668225 sshd[2320]: Accepted publickey for core from 10.0.0.1 port 39546 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:23.670344 sshd-session[2320]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:23.675899 systemd-logind[1474]: New session 15 of user core. Jul 15 23:45:23.687498 systemd[1]: Started session-15.scope - Session 15 of User core. Jul 15 23:45:23.750384 sshd[2322]: Connection closed by 10.0.0.1 port 39546 Jul 15 23:45:23.750840 sshd-session[2320]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:23.769108 systemd[1]: sshd@14-10.0.0.4:22-10.0.0.1:39546.service: Deactivated successfully. Jul 15 23:45:23.771624 systemd[1]: session-15.scope: Deactivated successfully. Jul 15 23:45:23.772506 systemd-logind[1474]: Session 15 logged out. Waiting for processes to exit. Jul 15 23:45:23.776692 systemd[1]: Started sshd@15-10.0.0.4:22-10.0.0.1:39568.service - OpenSSH per-connection server daemon (10.0.0.1:39568). Jul 15 23:45:23.777526 systemd-logind[1474]: Removed session 15. Jul 15 23:45:23.838476 sshd[2328]: Accepted publickey for core from 10.0.0.1 port 39568 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:23.840460 sshd-session[2328]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:23.845713 systemd-logind[1474]: New session 16 of user core. Jul 15 23:45:23.855331 systemd[1]: Started session-16.scope - Session 16 of User core. Jul 15 23:45:23.913686 sshd[2330]: Connection closed by 10.0.0.1 port 39568 Jul 15 23:45:23.913994 sshd-session[2328]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:23.927432 systemd[1]: sshd@15-10.0.0.4:22-10.0.0.1:39568.service: Deactivated successfully. Jul 15 23:45:23.929726 systemd[1]: session-16.scope: Deactivated successfully. Jul 15 23:45:23.930599 systemd-logind[1474]: Session 16 logged out. Waiting for processes to exit. Jul 15 23:45:23.933962 systemd[1]: Started sshd@16-10.0.0.4:22-10.0.0.1:39580.service - OpenSSH per-connection server daemon (10.0.0.1:39580). Jul 15 23:45:23.934673 systemd-logind[1474]: Removed session 16. Jul 15 23:45:23.987987 sshd[2336]: Accepted publickey for core from 10.0.0.1 port 39580 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:23.989904 sshd-session[2336]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:23.994966 systemd-logind[1474]: New session 17 of user core. Jul 15 23:45:24.005349 systemd[1]: Started session-17.scope - Session 17 of User core. Jul 15 23:45:24.069924 sshd[2338]: Connection closed by 10.0.0.1 port 39580 Jul 15 23:45:24.070272 sshd-session[2336]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:24.084829 systemd[1]: sshd@16-10.0.0.4:22-10.0.0.1:39580.service: Deactivated successfully. Jul 15 23:45:24.086953 systemd[1]: session-17.scope: Deactivated successfully. Jul 15 23:45:24.087939 systemd-logind[1474]: Session 17 logged out. Waiting for processes to exit. Jul 15 23:45:24.091484 systemd[1]: Started sshd@17-10.0.0.4:22-10.0.0.1:39584.service - OpenSSH per-connection server daemon (10.0.0.1:39584). Jul 15 23:45:24.092529 systemd-logind[1474]: Removed session 17. Jul 15 23:45:24.153045 sshd[2351]: Accepted publickey for core from 10.0.0.1 port 39584 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:24.155017 sshd-session[2351]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:24.160871 systemd-logind[1474]: New session 18 of user core. Jul 15 23:45:24.171474 systemd[1]: Started session-18.scope - Session 18 of User core. Jul 15 23:45:24.253487 systemd[1]: var-lib-docker-overlay2-e5df6197f1e53cf0225cd986e24f0c0986dc7b33b5eafc03cd3cd341dba17063\x2dinit-merged.mount: Deactivated successfully. Jul 15 23:45:24.304096 containerd[2048]: time="2025-07-15T23:45:24.304051461Z" level=info msg="connecting to shim f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679" address="unix:///run/containerd/s/40976bdc86092f035f89eb1f28c228228d85683f2b5e2bc74f2843d57dd0b110" namespace=moby protocol=ttrpc version=3 Jul 15 23:45:24.332414 systemd[1]: Started docker-f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679.scope - libcontainer container f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679. Jul 15 23:45:24.350806 systemd-resolved[1344]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 15 23:45:24.377557 kernel: docker0: port 1(veth5bbd8b5) entered blocking state Jul 15 23:45:24.377661 kernel: docker0: port 1(veth5bbd8b5) entered disabled state Jul 15 23:45:24.377681 kernel: veth5bbd8b5: entered allmulticast mode Jul 15 23:45:24.379354 kernel: veth5bbd8b5: entered promiscuous mode Jul 15 23:45:24.379106 systemd-networkd[1461]: veth5bbd8b5: Link UP Jul 15 23:45:24.387011 kernel: eth0: renamed from veth4ed646c Jul 15 23:45:24.387133 kernel: docker0: port 1(veth5bbd8b5) entered blocking state Jul 15 23:45:24.388305 kernel: docker0: port 1(veth5bbd8b5) entered forwarding state Jul 15 23:45:24.388852 systemd-networkd[1461]: veth5bbd8b5: Gained carrier Jul 15 23:45:24.389611 systemd-networkd[1461]: docker0: Gained carrier Jul 15 23:45:24.423128 sshd[2353]: Connection closed by 10.0.0.1 port 39584 Jul 15 23:45:24.423460 sshd-session[2351]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:24.437444 systemd[1]: sshd@17-10.0.0.4:22-10.0.0.1:39584.service: Deactivated successfully. Jul 15 23:45:24.439529 systemd[1]: session-18.scope: Deactivated successfully. Jul 15 23:45:24.440946 systemd-logind[1474]: Session 18 logged out. Waiting for processes to exit. Jul 15 23:45:24.445380 systemd[1]: Started sshd@18-10.0.0.4:22-10.0.0.1:39604.service - OpenSSH per-connection server daemon (10.0.0.1:39604). Jul 15 23:45:24.446077 systemd-logind[1474]: Removed session 18. Jul 15 23:45:24.502932 sshd[2420]: Accepted publickey for core from 10.0.0.1 port 39604 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:24.504707 sshd-session[2420]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:24.509811 systemd-logind[1474]: New session 19 of user core. Jul 15 23:45:24.525532 systemd[1]: Started session-19.scope - Session 19 of User core. Jul 15 23:45:24.587439 sshd[2422]: Connection closed by 10.0.0.1 port 39604 Jul 15 23:45:24.587894 sshd-session[2420]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:24.607081 systemd[1]: sshd@18-10.0.0.4:22-10.0.0.1:39604.service: Deactivated successfully. Jul 15 23:45:24.609469 systemd[1]: session-19.scope: Deactivated successfully. Jul 15 23:45:24.610398 systemd-logind[1474]: Session 19 logged out. Waiting for processes to exit. Jul 15 23:45:24.614541 systemd[1]: Started sshd@19-10.0.0.4:22-10.0.0.1:39620.service - OpenSSH per-connection server daemon (10.0.0.1:39620). Jul 15 23:45:24.615233 systemd-logind[1474]: Removed session 19. Jul 15 23:45:24.670921 sshd[2428]: Accepted publickey for core from 10.0.0.1 port 39620 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:24.673120 sshd-session[2428]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:24.679463 systemd-logind[1474]: New session 20 of user core. Jul 15 23:45:24.689446 systemd[1]: Started session-20.scope - Session 20 of User core. Jul 15 23:45:24.747060 sudo[2431]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2048 Jul 15 23:45:24.747553 sudo[2431]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 23:45:24.752372 sudo[2431]: pam_unix(sudo:session): session closed for user root Jul 15 23:45:24.757303 sshd[2430]: Connection closed by 10.0.0.1 port 39620 Jul 15 23:45:24.757649 sshd-session[2428]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:24.759749 dockerd[2097]: time="2025-07-15T23:45:24.759425457Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 15 23:45:24.760040 dockerd[2097]: time="2025-07-15T23:45:24.759747222Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 15 23:45:24.760040 dockerd[2097]: time="2025-07-15T23:45:24.759694133Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 15 23:45:24.760040 dockerd[2097]: time="2025-07-15T23:45:24.759915500Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 15 23:45:24.767483 systemd[1]: containerd.service: Deactivated successfully. Jul 15 23:45:24.767610 systemd[1]: containerd.service: Unit process 2370 (containerd-shim) remains running after unit stopped. Jul 15 23:45:24.767897 systemd[1]: containerd.service: Consumed 276ms CPU time, 136.8M memory peak. Jul 15 23:45:24.768387 systemd[1]: sshd@19-10.0.0.4:22-10.0.0.1:39620.service: Deactivated successfully. Jul 15 23:45:24.770210 systemd[1]: session-20.scope: Deactivated successfully. Jul 15 23:45:24.771880 systemd-logind[1474]: Session 20 logged out. Waiting for processes to exit. Jul 15 23:45:24.775070 systemd[1]: Started sshd@20-10.0.0.4:22-10.0.0.1:39626.service - OpenSSH per-connection server daemon (10.0.0.1:39626). Jul 15 23:45:24.775636 systemd-logind[1474]: Removed session 20. Jul 15 23:45:24.840391 sshd[2438]: Accepted publickey for core from 10.0.0.1 port 39626 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:24.842434 sshd-session[2438]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:24.847599 systemd-logind[1474]: New session 21 of user core. Jul 15 23:45:24.859388 systemd[1]: Started session-21.scope - Session 21 of User core. Jul 15 23:45:24.919969 sshd[2440]: Connection closed by 10.0.0.1 port 39626 Jul 15 23:45:24.920503 sshd-session[2438]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:24.926399 systemd[1]: sshd@20-10.0.0.4:22-10.0.0.1:39626.service: Deactivated successfully. Jul 15 23:45:24.928816 systemd[1]: session-21.scope: Deactivated successfully. Jul 15 23:45:24.929631 systemd-logind[1474]: Session 21 logged out. Waiting for processes to exit. Jul 15 23:45:24.931118 systemd-logind[1474]: Removed session 21. Jul 15 23:45:26.234454 systemd-networkd[1461]: veth5bbd8b5: Gained IPv6LL Jul 15 23:45:29.798814 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Jul 15 23:45:29.799434 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 15 23:45:29.799697 dockerd[2097]: time="2025-07-15T23:45:29.799612567Z" level=info msg="Processing signal 'terminated'" Jul 15 23:45:30.947675 systemd[1]: Started sshd@21-10.0.0.4:22-10.0.0.1:49446.service - OpenSSH per-connection server daemon (10.0.0.1:49446). Jul 15 23:45:31.006245 sshd[2446]: Accepted publickey for core from 10.0.0.1 port 49446 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:31.008332 sshd-session[2446]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:31.013793 systemd-logind[1474]: New session 22 of user core. Jul 15 23:45:31.025360 systemd[1]: Started session-22.scope - Session 22 of User core. Jul 15 23:45:31.294692 sshd[2448]: Connection closed by 10.0.0.1 port 49446 Jul 15 23:45:31.295152 sshd-session[2446]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:31.299785 systemd[1]: sshd@21-10.0.0.4:22-10.0.0.1:49446.service: Deactivated successfully. Jul 15 23:45:31.302167 systemd[1]: session-22.scope: Deactivated successfully. Jul 15 23:45:31.304882 systemd-logind[1474]: Session 22 logged out. Waiting for processes to exit. Jul 15 23:45:31.306136 systemd-logind[1474]: Removed session 22. Jul 15 23:45:31.801780 dockerd[2097]: time="2025-07-15T23:45:31.801635654Z" level=error msg="Error sending stop (signal 15) to container" container=f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679 error="Cannot kill container f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Jul 15 23:45:31.801780 dockerd[2097]: time="2025-07-15T23:45:31.801735185Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679 Jul 15 23:45:33.318645 update_engine[1478]: I20250715 23:45:33.318359 1478 update_attempter.cc:509] Updating boot flags... Jul 15 23:45:37.104332 systemd[1]: Started sshd@22-10.0.0.4:22-10.0.0.1:49452.service - OpenSSH per-connection server daemon (10.0.0.1:49452). Jul 15 23:45:37.169804 sshd[2472]: Accepted publickey for core from 10.0.0.1 port 49452 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:37.171949 sshd-session[2472]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:37.177167 systemd-logind[1474]: New session 23 of user core. Jul 15 23:45:37.187534 systemd[1]: Started session-23.scope - Session 23 of User core. Jul 15 23:45:37.249667 sshd[2474]: Connection closed by 10.0.0.1 port 49452 Jul 15 23:45:37.250090 sshd-session[2472]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:37.256309 systemd[1]: sshd@22-10.0.0.4:22-10.0.0.1:49452.service: Deactivated successfully. Jul 15 23:45:37.258809 systemd[1]: session-23.scope: Deactivated successfully. Jul 15 23:45:37.259818 systemd-logind[1474]: Session 23 logged out. Waiting for processes to exit. Jul 15 23:45:37.261232 systemd-logind[1474]: Removed session 23. Jul 15 23:45:41.802958 dockerd[2097]: time="2025-07-15T23:45:41.802858270Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679 error="context deadline exceeded" Jul 15 23:45:41.803923 systemd[1]: docker-f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679.scope: Deactivated successfully. Jul 15 23:45:43.266575 systemd[1]: Started sshd@23-10.0.0.4:22-10.0.0.1:58288.service - OpenSSH per-connection server daemon (10.0.0.1:58288). Jul 15 23:45:43.316509 sshd[2480]: Accepted publickey for core from 10.0.0.1 port 58288 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:43.317964 sshd-session[2480]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:43.322039 systemd-logind[1474]: New session 24 of user core. Jul 15 23:45:43.337306 systemd[1]: Started session-24.scope - Session 24 of User core. Jul 15 23:45:43.395387 sshd[2482]: Connection closed by 10.0.0.1 port 58288 Jul 15 23:45:43.395789 sshd-session[2480]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:43.399136 systemd[1]: sshd@23-10.0.0.4:22-10.0.0.1:58288.service: Deactivated successfully. Jul 15 23:45:43.401150 systemd[1]: session-24.scope: Deactivated successfully. Jul 15 23:45:43.402688 systemd-logind[1474]: Session 24 logged out. Waiting for processes to exit. Jul 15 23:45:43.404031 systemd-logind[1474]: Removed session 24. Jul 15 23:45:44.800228 dockerd[2097]: time="2025-07-15T23:45:44.800115185Z" level=error msg="Force shutdown daemon" Jul 15 23:45:44.800695 dockerd[2097]: time="2025-07-15T23:45:44.800365801Z" level=info msg="Daemon shutdown complete" Jul 15 23:45:44.807811 systemd[1]: docker.service: Deactivated successfully. Jul 15 23:45:44.808246 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 15 23:45:44.809060 systemd[1]: docker.socket: Deactivated successfully. Jul 15 23:45:44.809440 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 15 23:45:44.809486 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 15 23:45:44.811555 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 15 23:45:44.811757 systemd[1]: containerd.service: Found left-over process 2370 (containerd-shim) in control group while starting unit. Ignoring. Jul 15 23:45:44.811767 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 15 23:45:44.818837 systemd[1]: Starting containerd.service - containerd container runtime... Jul 15 23:45:44.819390 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 15 23:45:44.834268 systemd[1]: containerd.service: Found left-over process 2370 (containerd-shim) in control group while starting unit. Ignoring. Jul 15 23:45:44.834277 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 15 23:45:44.839881 (ntainerd)[2493]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 15 23:45:44.857728 containerd[2493]: time="2025-07-15T23:45:44Z" 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 Jul 15 23:45:44.858361 containerd[2493]: time="2025-07-15T23:45:44.858319541Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 15 23:45:44.866478 containerd[2493]: time="2025-07-15T23:45:44.866421653Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.431µs" Jul 15 23:45:44.866478 containerd[2493]: time="2025-07-15T23:45:44.866463887Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 15 23:45:44.866478 containerd[2493]: time="2025-07-15T23:45:44.866482483Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 15 23:45:44.866626 containerd[2493]: time="2025-07-15T23:45:44.866529597Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 15 23:45:44.866626 containerd[2493]: time="2025-07-15T23:45:44.866541430Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 15 23:45:44.866836 containerd[2493]: time="2025-07-15T23:45:44.866805171Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 23:45:44.866864 containerd[2493]: time="2025-07-15T23:45:44.866840501Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 23:45:44.866864 containerd[2493]: time="2025-07-15T23:45:44.866851734Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 15 23:45:44.867178 containerd[2493]: time="2025-07-15T23:45:44.867149051Z" 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 Jul 15 23:45:44.867178 containerd[2493]: time="2025-07-15T23:45:44.867166886Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 23:45:44.867178 containerd[2493]: time="2025-07-15T23:45:44.867177297Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 23:45:44.867272 containerd[2493]: time="2025-07-15T23:45:44.867185854Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 15 23:45:44.867272 containerd[2493]: time="2025-07-15T23:45:44.867237646Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 15 23:45:44.867360 containerd[2493]: time="2025-07-15T23:45:44.867332864Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 15 23:45:44.867390 containerd[2493]: time="2025-07-15T23:45:44.867363635Z" 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 Jul 15 23:45:44.867390 containerd[2493]: time="2025-07-15T23:45:44.867374627Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 15 23:45:44.867439 containerd[2493]: time="2025-07-15T23:45:44.867412402Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 15 23:45:44.867720 containerd[2493]: time="2025-07-15T23:45:44.867693977Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 15 23:45:44.867756 containerd[2493]: time="2025-07-15T23:45:44.867725650Z" level=info msg="metadata content store policy set" policy=shared Jul 15 23:45:44.867897 containerd[2493]: time="2025-07-15T23:45:44.867876288Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 15 23:45:44.867936 containerd[2493]: time="2025-07-15T23:45:44.867904594Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 15 23:45:44.867936 containerd[2493]: time="2025-07-15T23:45:44.867917710Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 15 23:45:44.867936 containerd[2493]: time="2025-07-15T23:45:44.867928942Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 15 23:45:44.868004 containerd[2493]: time="2025-07-15T23:45:44.867941336Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 15 23:45:44.868004 containerd[2493]: time="2025-07-15T23:45:44.867951687Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 15 23:45:44.868004 containerd[2493]: time="2025-07-15T23:45:44.867964332Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 15 23:45:44.868004 containerd[2493]: time="2025-07-15T23:45:44.867975865Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 15 23:45:44.868004 containerd[2493]: time="2025-07-15T23:45:44.867991987Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 15 23:45:44.868004 containerd[2493]: time="2025-07-15T23:45:44.868004481Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 15 23:45:44.868128 containerd[2493]: time="2025-07-15T23:45:44.868016595Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 15 23:45:44.868128 containerd[2493]: time="2025-07-15T23:45:44.868029871Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 15 23:45:44.868334 containerd[2493]: time="2025-07-15T23:45:44.868300176Z" level=info msg="connecting to shim f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679" address="unix:///run/containerd/s/40976bdc86092f035f89eb1f28c228228d85683f2b5e2bc74f2843d57dd0b110" namespace=moby protocol=ttrpc version=3 Jul 15 23:45:44.877053 containerd[2493]: time="2025-07-15T23:45:44.877010650Z" level=info msg="cleaning leaked shim process" id=f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679 namespace=moby Jul 15 23:45:44.888187 containerd[2493]: time="2025-07-15T23:45:44.888111627Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 15 23:45:44.888546 containerd[2493]: time="2025-07-15T23:45:44.888477741Z" level=info msg="shim disconnected" id=f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679 namespace=moby Jul 15 23:45:44.888546 containerd[2493]: time="2025-07-15T23:45:44.888529583Z" level=warning msg="cleaning up after shim disconnected" id=f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679 namespace=moby Jul 15 23:45:44.888619 containerd[2493]: time="2025-07-15T23:45:44.888540484Z" level=info msg="cleaning up dead shim" namespace=moby Jul 15 23:45:44.903403 containerd[2493]: time="2025-07-15T23:45:44.903239722Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jul 15 23:45:44.903403 containerd[2493]: time="2025-07-15T23:45:44.903381753Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903444788Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903466340Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903480008Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903492692Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903506108Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903530678Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903545035Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903558563Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903570105Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 15 23:45:44.903613 containerd[2493]: time="2025-07-15T23:45:44.903582750Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 15 23:45:44.903928 containerd[2493]: time="2025-07-15T23:45:44.903670444Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 15 23:45:44.903928 containerd[2493]: time="2025-07-15T23:45:44.903690934Z" level=info msg="Start snapshots syncer" Jul 15 23:45:44.903928 containerd[2493]: time="2025-07-15T23:45:44.903731444Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 15 23:45:44.904464 containerd[2493]: time="2025-07-15T23:45:44.904413372Z" 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\"}" Jul 15 23:45:44.904603 containerd[2493]: time="2025-07-15T23:45:44.904481617Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 15 23:45:44.904603 containerd[2493]: time="2025-07-15T23:45:44.904586063Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 15 23:45:44.904676 containerd[2493]: time="2025-07-15T23:45:44.904638838Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 15 23:45:44.904676 containerd[2493]: time="2025-07-15T23:45:44.904660450Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 15 23:45:44.904727 containerd[2493]: time="2025-07-15T23:45:44.904678105Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 15 23:45:44.904727 containerd[2493]: time="2025-07-15T23:45:44.904692503Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 15 23:45:44.904727 containerd[2493]: time="2025-07-15T23:45:44.904716280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 15 23:45:44.904799 containerd[2493]: time="2025-07-15T23:45:44.904735247Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 15 23:45:44.904799 containerd[2493]: time="2025-07-15T23:45:44.904750939Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 15 23:45:44.904799 containerd[2493]: time="2025-07-15T23:45:44.904784455Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 15 23:45:44.904878 containerd[2493]: time="2025-07-15T23:45:44.904796990Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 15 23:45:44.904878 containerd[2493]: time="2025-07-15T23:45:44.904812881Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 15 23:45:44.904878 containerd[2493]: time="2025-07-15T23:45:44.904857189Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 15 23:45:44.904953 containerd[2493]: time="2025-07-15T23:45:44.904878050Z" 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 Jul 15 23:45:44.904953 containerd[2493]: time="2025-07-15T23:45:44.904889272Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 23:45:44.904953 containerd[2493]: time="2025-07-15T23:45:44.904903801Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 23:45:44.904953 containerd[2493]: time="2025-07-15T23:45:44.904916867Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 15 23:45:44.904953 containerd[2493]: time="2025-07-15T23:45:44.904927097Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 15 23:45:44.904953 containerd[2493]: time="2025-07-15T23:45:44.904941485Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 15 23:45:44.905103 containerd[2493]: time="2025-07-15T23:45:44.904964161Z" level=info msg="runtime interface created" Jul 15 23:45:44.905103 containerd[2493]: time="2025-07-15T23:45:44.904970803Z" level=info msg="created NRI interface" Jul 15 23:45:44.905103 containerd[2493]: time="2025-07-15T23:45:44.904982998Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 15 23:45:44.905103 containerd[2493]: time="2025-07-15T23:45:44.905013258Z" level=info msg="Connect containerd service" Jul 15 23:45:44.905103 containerd[2493]: time="2025-07-15T23:45:44.905042455Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 15 23:45:44.905978 containerd[2493]: time="2025-07-15T23:45:44.905954036Z" 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" Jul 15 23:45:44.918402 containerd[2493]: time="2025-07-15T23:45:44.918328641Z" level=info msg="Start subscribing containerd event" Jul 15 23:45:44.918402 containerd[2493]: time="2025-07-15T23:45:44.918400172Z" level=info msg="Start recovering state" Jul 15 23:45:44.918592 containerd[2493]: time="2025-07-15T23:45:44.918547282Z" level=info msg="Start event monitor" Jul 15 23:45:44.918592 containerd[2493]: time="2025-07-15T23:45:44.918574006Z" level=info msg="Start cni network conf syncer for default" Jul 15 23:45:44.918592 containerd[2493]: time="2025-07-15T23:45:44.918584296Z" level=info msg="Start streaming server" Jul 15 23:45:44.918676 containerd[2493]: time="2025-07-15T23:45:44.918547433Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 15 23:45:44.918676 containerd[2493]: time="2025-07-15T23:45:44.918605007Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 15 23:45:44.918676 containerd[2493]: time="2025-07-15T23:45:44.918616920Z" level=info msg="runtime interface starting up..." Jul 15 23:45:44.918676 containerd[2493]: time="2025-07-15T23:45:44.918624655Z" level=info msg="starting plugins..." Jul 15 23:45:44.918676 containerd[2493]: time="2025-07-15T23:45:44.918643894Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 15 23:45:44.918676 containerd[2493]: time="2025-07-15T23:45:44.918669905Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 15 23:45:44.918821 containerd[2493]: time="2025-07-15T23:45:44.918810142Z" level=info msg="containerd successfully booted in 0.061278s" Jul 15 23:45:44.918990 systemd[1]: Started containerd.service - containerd container runtime. Jul 15 23:45:44.921594 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 15 23:45:44.945640 (dockerd)[2541]: 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 Jul 15 23:45:44.982596 dockerd[2541]: time="2025-07-15T23:45:44.982508431Z" level=info msg="Starting up" Jul 15 23:45:44.983307 dockerd[2541]: time="2025-07-15T23:45:44.983279314Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 15 23:45:45.189332 dockerd[2541]: time="2025-07-15T23:45:45.189231368Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 15 23:45:45.212823 dockerd[2541]: time="2025-07-15T23:45:45.212739329Z" level=info msg="Loading containers: start." Jul 15 23:45:45.229630 systemd[1]: var-lib-docker-overlay2-e5df6197f1e53cf0225cd986e24f0c0986dc7b33b5eafc03cd3cd341dba17063-merged.mount: Deactivated successfully. Jul 15 23:45:45.626760 systemd-networkd[1461]: veth5bbd8b5: Link DOWN Jul 15 23:45:45.627202 systemd-networkd[1461]: veth5bbd8b5: Lost carrier Jul 15 23:45:45.628850 kernel: docker0: port 1(veth5bbd8b5) entered disabled state Jul 15 23:45:45.628911 kernel: veth5bbd8b5 (unregistering): left allmulticast mode Jul 15 23:45:45.628931 kernel: veth5bbd8b5 (unregistering): left promiscuous mode Jul 15 23:45:45.629600 kernel: docker0: port 1(veth5bbd8b5) entered disabled state Jul 15 23:45:45.630906 systemd-networkd[1461]: docker0: Lost carrier Jul 15 23:45:45.633435 dockerd[2541]: time="2025-07-15T23:45:45.633395217Z" level=info msg="Removing stale sandbox b910d87f6b44d2bc641d0c5bb13437016b232457055cadf3bf6e01b12e21514d (f61d8b6b87476cec45d0aa0a2183f4fe0ccc3517f707a11e6ca21775582e2679)" Jul 15 23:45:45.639603 dockerd[2541]: time="2025-07-15T23:45:45.639557316Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 15 23:45:45.639664 dockerd[2541]: time="2025-07-15T23:45:45.639611813Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint f2b341378fcfb0e11f450f432d8eae8656441b334493c88cbf5e45a0cb5cec3b 4d47adca80e8d0b8e24f984dff233a347dc38743c8e1f6fc9739a13d04687bd7], retrying...." Jul 15 23:45:45.835476 dockerd[2541]: time="2025-07-15T23:45:45.835409700Z" level=warning msg="error locating sandbox id b910d87f6b44d2bc641d0c5bb13437016b232457055cadf3bf6e01b12e21514d: sandbox b910d87f6b44d2bc641d0c5bb13437016b232457055cadf3bf6e01b12e21514d not found" Jul 15 23:45:45.835476 dockerd[2541]: time="2025-07-15T23:45:45.835451923Z" level=warning msg="error locating sandbox id ee7891184b2ce3f6a98def425fc37681187b776ae634365e4c1d640137527a81: sandbox ee7891184b2ce3f6a98def425fc37681187b776ae634365e4c1d640137527a81 not found" Jul 15 23:45:45.835672 dockerd[2541]: time="2025-07-15T23:45:45.835597210Z" level=info msg="Loading containers: done." Jul 15 23:45:45.848857 dockerd[2541]: time="2025-07-15T23:45:45.848805990Z" 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 Jul 15 23:45:45.849020 dockerd[2541]: time="2025-07-15T23:45:45.848885737Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 15 23:45:45.849020 dockerd[2541]: time="2025-07-15T23:45:45.848934083Z" level=info msg="Initializing buildkit" Jul 15 23:45:45.864973 dockerd[2541]: time="2025-07-15T23:45:45.864948229Z" level=info msg="Completed buildkit initialization" Jul 15 23:45:45.871140 dockerd[2541]: time="2025-07-15T23:45:45.871091770Z" level=info msg="Daemon has completed initialization" Jul 15 23:45:45.871489 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 15 23:45:45.871933 dockerd[2541]: time="2025-07-15T23:45:45.871621304Z" level=info msg="API listen on /run/docker.sock" Jul 15 23:45:46.179845 systemd[1]: run-docker-netns-b910d87f6b44.mount: Deactivated successfully. Jul 15 23:45:49.414985 systemd[1]: Started sshd@24-10.0.0.4:22-10.0.0.1:53726.service - OpenSSH per-connection server daemon (10.0.0.1:53726). Jul 15 23:45:49.471852 sshd[2764]: Accepted publickey for core from 10.0.0.1 port 53726 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:49.473344 sshd-session[2764]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:49.478089 systemd-logind[1474]: New session 25 of user core. Jul 15 23:45:49.488425 systemd[1]: Started session-25.scope - Session 25 of User core. Jul 15 23:45:49.545013 sshd[2766]: Connection closed by 10.0.0.1 port 53726 Jul 15 23:45:49.545464 sshd-session[2764]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:49.558657 systemd[1]: sshd@24-10.0.0.4:22-10.0.0.1:53726.service: Deactivated successfully. Jul 15 23:45:49.560436 systemd[1]: session-25.scope: Deactivated successfully. Jul 15 23:45:49.561275 systemd-logind[1474]: Session 25 logged out. Waiting for processes to exit. Jul 15 23:45:49.564677 systemd[1]: Started sshd@25-10.0.0.4:22-10.0.0.1:53742.service - OpenSSH per-connection server daemon (10.0.0.1:53742). Jul 15 23:45:49.565395 systemd-logind[1474]: Removed session 25. Jul 15 23:45:49.612120 sshd[2772]: Accepted publickey for core from 10.0.0.1 port 53742 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:49.613808 sshd-session[2772]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:49.618703 systemd-logind[1474]: New session 26 of user core. Jul 15 23:45:49.634335 systemd[1]: Started session-26.scope - Session 26 of User core. Jul 15 23:45:49.690463 sshd[2774]: Connection closed by 10.0.0.1 port 53742 Jul 15 23:45:49.690784 sshd-session[2772]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:49.716762 systemd[1]: sshd@25-10.0.0.4:22-10.0.0.1:53742.service: Deactivated successfully. Jul 15 23:45:49.718566 systemd[1]: session-26.scope: Deactivated successfully. Jul 15 23:45:49.719397 systemd-logind[1474]: Session 26 logged out. Waiting for processes to exit. Jul 15 23:45:49.722127 systemd[1]: Started sshd@26-10.0.0.4:22-10.0.0.1:53752.service - OpenSSH per-connection server daemon (10.0.0.1:53752). Jul 15 23:45:49.722659 systemd-logind[1474]: Removed session 26. Jul 15 23:45:49.774886 sshd[2780]: Accepted publickey for core from 10.0.0.1 port 53752 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:49.776440 sshd-session[2780]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:49.780637 systemd-logind[1474]: New session 27 of user core. Jul 15 23:45:49.790329 systemd[1]: Started session-27.scope - Session 27 of User core. Jul 15 23:45:49.851129 sshd[2782]: Connection closed by 10.0.0.1 port 53752 Jul 15 23:45:49.851479 sshd-session[2780]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:49.867786 systemd[1]: sshd@26-10.0.0.4:22-10.0.0.1:53752.service: Deactivated successfully. Jul 15 23:45:49.869580 systemd[1]: session-27.scope: Deactivated successfully. Jul 15 23:45:49.870401 systemd-logind[1474]: Session 27 logged out. Waiting for processes to exit. Jul 15 23:45:49.873261 systemd[1]: Started sshd@27-10.0.0.4:22-10.0.0.1:53758.service - OpenSSH per-connection server daemon (10.0.0.1:53758). Jul 15 23:45:49.874025 systemd-logind[1474]: Removed session 27. Jul 15 23:45:49.931884 sshd[2795]: Accepted publickey for core from 10.0.0.1 port 53758 ssh2: RSA SHA256:wrO5NCJWuMjqDZoRWCG1KDLSAbftsNF14I2QAREtKoA Jul 15 23:45:49.933163 sshd-session[2795]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 23:45:49.937328 systemd-logind[1474]: New session 28 of user core. Jul 15 23:45:49.951345 systemd[1]: Started session-28.scope - Session 28 of User core. Jul 15 23:45:50.026401 systemd[1]: var-lib-docker-overlay2-0df224d47b0dbb9eff5537409d43d5cbe89bc740813669b461f427306bd30d5d\x2dinit-merged.mount: Deactivated successfully. Jul 15 23:45:50.147933 containerd[2493]: time="2025-07-15T23:45:50.147864881Z" level=info msg="connecting to shim c61c58a901e13a173b5071ad9c06e52e2bcf8d28cbad6bb9bf0a14185e6b672b" address="unix:///run/containerd/s/63c4ceb172f2f9a692f3c1ec6097d8b2f3cbb31c56fe295bef24afab0719b3d6" namespace=moby protocol=ttrpc version=3 Jul 15 23:45:50.170339 systemd[1]: Started docker-c61c58a901e13a173b5071ad9c06e52e2bcf8d28cbad6bb9bf0a14185e6b672b.scope - libcontainer container c61c58a901e13a173b5071ad9c06e52e2bcf8d28cbad6bb9bf0a14185e6b672b. Jul 15 23:45:50.184729 systemd-resolved[1344]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 15 23:45:50.207628 kernel: docker0: port 1(veth13ef4f1) entered blocking state Jul 15 23:45:50.207744 kernel: docker0: port 1(veth13ef4f1) entered disabled state Jul 15 23:45:50.207775 kernel: veth13ef4f1: entered allmulticast mode Jul 15 23:45:50.209399 kernel: veth13ef4f1: entered promiscuous mode Jul 15 23:45:50.209495 systemd-networkd[1461]: veth13ef4f1: Link UP Jul 15 23:45:50.216220 kernel: eth0: renamed from veth47572c4 Jul 15 23:45:50.219892 kernel: docker0: port 1(veth13ef4f1) entered blocking state Jul 15 23:45:50.219941 kernel: docker0: port 1(veth13ef4f1) entered forwarding state Jul 15 23:45:50.220096 systemd-networkd[1461]: veth13ef4f1: Gained carrier Jul 15 23:45:50.221035 systemd-networkd[1461]: docker0: Gained carrier Jul 15 23:45:50.255917 sshd[2797]: Connection closed by 10.0.0.1 port 53758 Jul 15 23:45:50.256182 sshd-session[2795]: pam_unix(sshd:session): session closed for user core Jul 15 23:45:50.260056 systemd[1]: sshd@27-10.0.0.4:22-10.0.0.1:53758.service: Deactivated successfully. Jul 15 23:45:50.262046 systemd[1]: session-28.scope: Deactivated successfully. Jul 15 23:45:50.262771 systemd-logind[1474]: Session 28 logged out. Waiting for processes to exit. Jul 15 23:45:50.264306 systemd-logind[1474]: Removed session 28. Jul 15 23:45:51.706531 systemd-networkd[1461]: veth13ef4f1: Gained IPv6LL