May 10 09:57:38.176389 kernel: Linux version 6.6.89-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 Sat May 10 08:33:52 -00 2025 May 10 09:57:38.176414 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=cdff7a1e66558670c3a31fd90f395811dccc4cb131ce51930f033b8634f7f080 May 10 09:57:38.176423 kernel: BIOS-provided physical RAM map: May 10 09:57:38.176430 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable May 10 09:57:38.176437 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved May 10 09:57:38.176443 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved May 10 09:57:38.176451 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable May 10 09:57:38.176460 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved May 10 09:57:38.176476 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved May 10 09:57:38.176483 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved May 10 09:57:38.176490 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 10 09:57:38.176496 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved May 10 09:57:38.176503 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 10 09:57:38.176510 kernel: NX (Execute Disable) protection: active May 10 09:57:38.176520 kernel: APIC: Static calls initialized May 10 09:57:38.176528 kernel: SMBIOS 2.8 present. May 10 09:57:38.176535 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 May 10 09:57:38.176542 kernel: Hypervisor detected: KVM May 10 09:57:38.176549 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 May 10 09:57:38.176556 kernel: kvm-clock: using sched offset of 3199558856 cycles May 10 09:57:38.176563 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns May 10 09:57:38.176570 kernel: tsc: Detected 2794.748 MHz processor May 10 09:57:38.176578 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 10 09:57:38.176590 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 10 09:57:38.176597 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 May 10 09:57:38.176604 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs May 10 09:57:38.176612 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 10 09:57:38.176619 kernel: Using GB pages for direct mapping May 10 09:57:38.176626 kernel: ACPI: Early table checksum verification disabled May 10 09:57:38.176633 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) May 10 09:57:38.176641 kernel: ACPI: RSDT 0x000000009CFE2408 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176651 kernel: ACPI: FACP 0x000000009CFE21E8 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176658 kernel: ACPI: DSDT 0x000000009CFE0040 0021A8 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176665 kernel: ACPI: FACS 0x000000009CFE0000 000040 May 10 09:57:38.176672 kernel: ACPI: APIC 0x000000009CFE22DC 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176680 kernel: ACPI: HPET 0x000000009CFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176687 kernel: ACPI: MCFG 0x000000009CFE23A4 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176694 kernel: ACPI: WAET 0x000000009CFE23E0 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 10 09:57:38.176702 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21e8-0x9cfe22db] May 10 09:57:38.176709 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21e7] May 10 09:57:38.176722 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] May 10 09:57:38.176729 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22dc-0x9cfe236b] May 10 09:57:38.176737 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe236c-0x9cfe23a3] May 10 09:57:38.176744 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23a4-0x9cfe23df] May 10 09:57:38.176752 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23e0-0x9cfe2407] May 10 09:57:38.176759 kernel: No NUMA configuration found May 10 09:57:38.176769 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] May 10 09:57:38.176776 kernel: NODE_DATA(0) allocated [mem 0x9cfd4000-0x9cfdbfff] May 10 09:57:38.176784 kernel: Zone ranges: May 10 09:57:38.176791 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 10 09:57:38.176799 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] May 10 09:57:38.176806 kernel: Normal empty May 10 09:57:38.176813 kernel: Device empty May 10 09:57:38.176821 kernel: Movable zone start for each node May 10 09:57:38.176828 kernel: Early memory node ranges May 10 09:57:38.176838 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] May 10 09:57:38.176845 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] May 10 09:57:38.176853 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] May 10 09:57:38.176860 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 10 09:57:38.176867 kernel: On node 0, zone DMA: 97 pages in unavailable ranges May 10 09:57:38.176875 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges May 10 09:57:38.176882 kernel: ACPI: PM-Timer IO Port: 0x608 May 10 09:57:38.176890 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) May 10 09:57:38.176897 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 10 09:57:38.176907 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) May 10 09:57:38.176915 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) May 10 09:57:38.176922 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 10 09:57:38.176929 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) May 10 09:57:38.176937 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) May 10 09:57:38.176944 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 10 09:57:38.176952 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 May 10 09:57:38.176959 kernel: TSC deadline timer available May 10 09:57:38.176966 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs May 10 09:57:38.176974 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() May 10 09:57:38.176984 kernel: kvm-guest: KVM setup pv remote TLB flush May 10 09:57:38.176991 kernel: kvm-guest: setup PV sched yield May 10 09:57:38.176999 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices May 10 09:57:38.177007 kernel: Booting paravirtualized kernel on KVM May 10 09:57:38.177014 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 10 09:57:38.177022 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 May 10 09:57:38.177029 kernel: percpu: Embedded 58 pages/cpu s197416 r8192 d31960 u524288 May 10 09:57:38.177037 kernel: pcpu-alloc: s197416 r8192 d31960 u524288 alloc=1*2097152 May 10 09:57:38.177044 kernel: pcpu-alloc: [0] 0 1 2 3 May 10 09:57:38.177054 kernel: kvm-guest: PV spinlocks enabled May 10 09:57:38.177061 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 10 09:57:38.177070 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=cdff7a1e66558670c3a31fd90f395811dccc4cb131ce51930f033b8634f7f080 May 10 09:57:38.177078 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 10 09:57:38.177085 kernel: random: crng init done May 10 09:57:38.177092 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 10 09:57:38.177100 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 10 09:57:38.177108 kernel: Fallback order for Node 0: 0 May 10 09:57:38.177118 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 May 10 09:57:38.177125 kernel: Policy zone: DMA32 May 10 09:57:38.177132 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 10 09:57:38.177140 kernel: Memory: 2436632K/2571752K available (14336K kernel code, 2309K rwdata, 9044K rodata, 53680K init, 1596K bss, 134860K reserved, 0K cma-reserved) May 10 09:57:38.177148 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 10 09:57:38.177155 kernel: ftrace: allocating 38190 entries in 150 pages May 10 09:57:38.177162 kernel: ftrace: allocated 150 pages with 4 groups May 10 09:57:38.177170 kernel: Dynamic Preempt: voluntary May 10 09:57:38.177177 kernel: rcu: Preemptible hierarchical RCU implementation. May 10 09:57:38.177189 kernel: rcu: RCU event tracing is enabled. May 10 09:57:38.177200 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 10 09:57:38.177209 kernel: Trampoline variant of Tasks RCU enabled. May 10 09:57:38.177219 kernel: Rude variant of Tasks RCU enabled. May 10 09:57:38.177228 kernel: Tracing variant of Tasks RCU enabled. May 10 09:57:38.177238 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 10 09:57:38.177248 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 10 09:57:38.177257 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 May 10 09:57:38.177267 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 10 09:57:38.177306 kernel: Console: colour VGA+ 80x25 May 10 09:57:38.177329 kernel: printk: console [ttyS0] enabled May 10 09:57:38.177337 kernel: ACPI: Core revision 20230628 May 10 09:57:38.177345 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns May 10 09:57:38.177352 kernel: APIC: Switch to symmetric I/O mode setup May 10 09:57:38.177360 kernel: x2apic enabled May 10 09:57:38.177367 kernel: APIC: Switched APIC routing to: physical x2apic May 10 09:57:38.177375 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() May 10 09:57:38.177383 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() May 10 09:57:38.177401 kernel: kvm-guest: setup PV IPIs May 10 09:57:38.177409 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 May 10 09:57:38.177416 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized May 10 09:57:38.177426 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) May 10 09:57:38.177434 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 10 09:57:38.177442 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 May 10 09:57:38.177450 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 May 10 09:57:38.177457 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 10 09:57:38.177465 kernel: Spectre V2 : Mitigation: Retpolines May 10 09:57:38.177482 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 10 09:57:38.177491 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls May 10 09:57:38.177499 kernel: RETBleed: Mitigation: untrained return thunk May 10 09:57:38.177506 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier May 10 09:57:38.177514 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl May 10 09:57:38.177522 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! May 10 09:57:38.177530 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. May 10 09:57:38.177541 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode May 10 09:57:38.177549 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 10 09:57:38.177557 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 10 09:57:38.177564 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 10 09:57:38.177572 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 10 09:57:38.177580 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. May 10 09:57:38.177588 kernel: Freeing SMP alternatives memory: 32K May 10 09:57:38.177596 kernel: pid_max: default: 32768 minimum: 301 May 10 09:57:38.177603 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 10 09:57:38.177614 kernel: landlock: Up and running. May 10 09:57:38.177621 kernel: SELinux: Initializing. May 10 09:57:38.177629 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 10 09:57:38.177637 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 10 09:57:38.177645 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) May 10 09:57:38.177653 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 10 09:57:38.177661 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 10 09:57:38.177669 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 10 09:57:38.177676 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. May 10 09:57:38.177687 kernel: ... version: 0 May 10 09:57:38.177695 kernel: ... bit width: 48 May 10 09:57:38.177703 kernel: ... generic registers: 6 May 10 09:57:38.177710 kernel: ... value mask: 0000ffffffffffff May 10 09:57:38.177718 kernel: ... max period: 00007fffffffffff May 10 09:57:38.177726 kernel: ... fixed-purpose events: 0 May 10 09:57:38.177733 kernel: ... event mask: 000000000000003f May 10 09:57:38.177741 kernel: signal: max sigframe size: 1776 May 10 09:57:38.177748 kernel: rcu: Hierarchical SRCU implementation. May 10 09:57:38.177759 kernel: rcu: Max phase no-delay instances is 400. May 10 09:57:38.177767 kernel: smp: Bringing up secondary CPUs ... May 10 09:57:38.177774 kernel: smpboot: x86: Booting SMP configuration: May 10 09:57:38.177782 kernel: .... node #0, CPUs: #1 #2 #3 May 10 09:57:38.177790 kernel: smp: Brought up 1 node, 4 CPUs May 10 09:57:38.177799 kernel: smpboot: Max logical packages: 1 May 10 09:57:38.177809 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) May 10 09:57:38.177819 kernel: devtmpfs: initialized May 10 09:57:38.177829 kernel: x86/mm: Memory block size: 128MB May 10 09:57:38.177840 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 10 09:57:38.177848 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 10 09:57:38.177855 kernel: pinctrl core: initialized pinctrl subsystem May 10 09:57:38.177863 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 10 09:57:38.177871 kernel: audit: initializing netlink subsys (disabled) May 10 09:57:38.177879 kernel: audit: type=2000 audit(1746871055.033:1): state=initialized audit_enabled=0 res=1 May 10 09:57:38.177886 kernel: thermal_sys: Registered thermal governor 'step_wise' May 10 09:57:38.177894 kernel: thermal_sys: Registered thermal governor 'user_space' May 10 09:57:38.177902 kernel: cpuidle: using governor menu May 10 09:57:38.177912 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 10 09:57:38.177920 kernel: dca service started, version 1.12.1 May 10 09:57:38.177928 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) May 10 09:57:38.177936 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry May 10 09:57:38.177943 kernel: PCI: Using configuration type 1 for base access May 10 09:57:38.177951 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 10 09:57:38.177959 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 10 09:57:38.177967 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 10 09:57:38.177975 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 10 09:57:38.177985 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 10 09:57:38.177993 kernel: ACPI: Added _OSI(Module Device) May 10 09:57:38.178000 kernel: ACPI: Added _OSI(Processor Device) May 10 09:57:38.178008 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 10 09:57:38.178016 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 10 09:57:38.178023 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 10 09:57:38.178031 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC May 10 09:57:38.178039 kernel: ACPI: Interpreter enabled May 10 09:57:38.178047 kernel: ACPI: PM: (supports S0 S3 S5) May 10 09:57:38.178057 kernel: ACPI: Using IOAPIC for interrupt routing May 10 09:57:38.178065 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 10 09:57:38.178072 kernel: PCI: Using E820 reservations for host bridge windows May 10 09:57:38.178080 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F May 10 09:57:38.178088 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 10 09:57:38.178276 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 10 09:57:38.178423 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] May 10 09:57:38.178561 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] May 10 09:57:38.178575 kernel: PCI host bridge to bus 0000:00 May 10 09:57:38.178702 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 10 09:57:38.178818 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 10 09:57:38.178934 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] May 10 09:57:38.179048 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] May 10 09:57:38.179160 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] May 10 09:57:38.179272 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] May 10 09:57:38.179420 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 10 09:57:38.179581 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 May 10 09:57:38.179716 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 May 10 09:57:38.179840 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] May 10 09:57:38.179964 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] May 10 09:57:38.180104 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] May 10 09:57:38.180240 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 10 09:57:38.180391 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 May 10 09:57:38.180528 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] May 10 09:57:38.180653 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] May 10 09:57:38.180779 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] May 10 09:57:38.180919 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 May 10 09:57:38.181045 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] May 10 09:57:38.181174 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] May 10 09:57:38.181323 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] May 10 09:57:38.181458 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 May 10 09:57:38.181598 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] May 10 09:57:38.181721 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] May 10 09:57:38.181844 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] May 10 09:57:38.181968 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] May 10 09:57:38.182109 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 May 10 09:57:38.182234 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO May 10 09:57:38.182408 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 May 10 09:57:38.182556 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] May 10 09:57:38.182691 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] May 10 09:57:38.182833 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 May 10 09:57:38.182973 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] May 10 09:57:38.182985 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 May 10 09:57:38.182993 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 May 10 09:57:38.183001 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 May 10 09:57:38.183009 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 May 10 09:57:38.183017 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 May 10 09:57:38.183025 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 May 10 09:57:38.183033 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 May 10 09:57:38.183040 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 May 10 09:57:38.183052 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 May 10 09:57:38.183060 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 May 10 09:57:38.183067 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 May 10 09:57:38.183075 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 May 10 09:57:38.183083 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 May 10 09:57:38.183091 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 May 10 09:57:38.183099 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 May 10 09:57:38.183106 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 May 10 09:57:38.183114 kernel: iommu: Default domain type: Translated May 10 09:57:38.183125 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 10 09:57:38.183132 kernel: PCI: Using ACPI for IRQ routing May 10 09:57:38.183140 kernel: PCI: pci_cache_line_size set to 64 bytes May 10 09:57:38.183148 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] May 10 09:57:38.183156 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] May 10 09:57:38.183291 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device May 10 09:57:38.183430 kernel: pci 0000:00:01.0: vgaarb: bridge control possible May 10 09:57:38.183570 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 10 09:57:38.183585 kernel: vgaarb: loaded May 10 09:57:38.183593 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 May 10 09:57:38.183601 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter May 10 09:57:38.183609 kernel: clocksource: Switched to clocksource kvm-clock May 10 09:57:38.183617 kernel: VFS: Disk quotas dquot_6.6.0 May 10 09:57:38.183625 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 10 09:57:38.183632 kernel: pnp: PnP ACPI init May 10 09:57:38.183764 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved May 10 09:57:38.183778 kernel: pnp: PnP ACPI: found 6 devices May 10 09:57:38.183786 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 10 09:57:38.183794 kernel: NET: Registered PF_INET protocol family May 10 09:57:38.183802 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 10 09:57:38.183810 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 10 09:57:38.183818 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 10 09:57:38.183826 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 10 09:57:38.183834 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 10 09:57:38.183841 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 10 09:57:38.183852 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 10 09:57:38.183860 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 10 09:57:38.183867 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 10 09:57:38.183875 kernel: NET: Registered PF_XDP protocol family May 10 09:57:38.183991 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 10 09:57:38.184103 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 10 09:57:38.184218 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] May 10 09:57:38.184381 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] May 10 09:57:38.184504 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] May 10 09:57:38.184621 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] May 10 09:57:38.184631 kernel: PCI: CLS 0 bytes, default 64 May 10 09:57:38.184639 kernel: Initialise system trusted keyrings May 10 09:57:38.184647 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 10 09:57:38.184655 kernel: Key type asymmetric registered May 10 09:57:38.184663 kernel: Asymmetric key parser 'x509' registered May 10 09:57:38.184671 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 10 09:57:38.184679 kernel: io scheduler mq-deadline registered May 10 09:57:38.184686 kernel: io scheduler kyber registered May 10 09:57:38.184697 kernel: io scheduler bfq registered May 10 09:57:38.184705 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 10 09:57:38.184714 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 May 10 09:57:38.184722 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 May 10 09:57:38.184730 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 May 10 09:57:38.184738 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 10 09:57:38.184746 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 10 09:57:38.184754 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 May 10 09:57:38.184762 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 May 10 09:57:38.184772 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 May 10 09:57:38.184902 kernel: rtc_cmos 00:04: RTC can wake from S4 May 10 09:57:38.185018 kernel: rtc_cmos 00:04: registered as rtc0 May 10 09:57:38.185029 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 May 10 09:57:38.185142 kernel: rtc_cmos 00:04: setting system clock to 2025-05-10T09:57:37 UTC (1746871057) May 10 09:57:38.185256 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs May 10 09:57:38.185267 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled May 10 09:57:38.185290 kernel: NET: Registered PF_INET6 protocol family May 10 09:57:38.185298 kernel: Segment Routing with IPv6 May 10 09:57:38.185306 kernel: In-situ OAM (IOAM) with IPv6 May 10 09:57:38.185314 kernel: NET: Registered PF_PACKET protocol family May 10 09:57:38.185322 kernel: Key type dns_resolver registered May 10 09:57:38.185330 kernel: IPI shorthand broadcast: enabled May 10 09:57:38.185338 kernel: sched_clock: Marking stable (2837003056, 115309559)->(2966842729, -14530114) May 10 09:57:38.185346 kernel: registered taskstats version 1 May 10 09:57:38.185353 kernel: Loading compiled-in X.509 certificates May 10 09:57:38.185361 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: f8080549509982706805ea0b811f8f4bcb4a274e' May 10 09:57:38.185372 kernel: Key type .fscrypt registered May 10 09:57:38.185380 kernel: Key type fscrypt-provisioning registered May 10 09:57:38.185388 kernel: ima: No TPM chip found, activating TPM-bypass! May 10 09:57:38.185396 kernel: ima: Allocated hash algorithm: sha1 May 10 09:57:38.185404 kernel: ima: No architecture policies found May 10 09:57:38.185411 kernel: clk: Disabling unused clocks May 10 09:57:38.185419 kernel: Warning: unable to open an initial console. May 10 09:57:38.185427 kernel: Freeing unused kernel image (initmem) memory: 53680K May 10 09:57:38.185438 kernel: Write protecting the kernel read-only data: 24576k May 10 09:57:38.185445 kernel: Freeing unused kernel image (rodata/data gap) memory: 1196K May 10 09:57:38.185453 kernel: Run /init as init process May 10 09:57:38.185461 kernel: with arguments: May 10 09:57:38.185478 kernel: /init May 10 09:57:38.185486 kernel: with environment: May 10 09:57:38.185496 kernel: HOME=/ May 10 09:57:38.185504 kernel: TERM=linux May 10 09:57:38.185512 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 10 09:57:38.185521 systemd[1]: Successfully made /usr/ read-only. May 10 09:57:38.185535 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 10 09:57:38.185544 systemd[1]: Detected virtualization kvm. May 10 09:57:38.185552 systemd[1]: Detected architecture x86-64. May 10 09:57:38.185561 systemd[1]: Running in initrd. May 10 09:57:38.185569 systemd[1]: No hostname configured, using default hostname. May 10 09:57:38.185578 systemd[1]: Hostname set to . May 10 09:57:38.185588 systemd[1]: Initializing machine ID from VM UUID. May 10 09:57:38.185597 systemd[1]: Queued start job for default target initrd.target. May 10 09:57:38.185605 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 10 09:57:38.185626 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 10 09:57:38.185637 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 10 09:57:38.185646 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 10 09:57:38.185657 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 10 09:57:38.185667 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 10 09:57:38.185677 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 10 09:57:38.185686 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 10 09:57:38.185695 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 10 09:57:38.185703 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 10 09:57:38.185711 systemd[1]: Reached target paths.target - Path Units. May 10 09:57:38.185722 systemd[1]: Reached target slices.target - Slice Units. May 10 09:57:38.185731 systemd[1]: Reached target swap.target - Swaps. May 10 09:57:38.185739 systemd[1]: Reached target timers.target - Timer Units. May 10 09:57:38.185748 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 10 09:57:38.185756 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 10 09:57:38.185767 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 10 09:57:38.185776 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 10 09:57:38.185785 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 10 09:57:38.185793 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 10 09:57:38.185805 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 10 09:57:38.185813 systemd[1]: Reached target sockets.target - Socket Units. May 10 09:57:38.185822 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 10 09:57:38.185830 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 10 09:57:38.185839 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 10 09:57:38.185848 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). May 10 09:57:38.185857 systemd[1]: Starting systemd-fsck-usr.service... May 10 09:57:38.185866 systemd[1]: Starting systemd-journald.service - Journal Service... May 10 09:57:38.185877 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 10 09:57:38.185885 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 10 09:57:38.185894 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 10 09:57:38.185903 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 10 09:57:38.185912 systemd[1]: Finished systemd-fsck-usr.service. May 10 09:57:38.185924 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 10 09:57:38.185952 systemd-journald[194]: Collecting audit messages is disabled. May 10 09:57:38.185975 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 10 09:57:38.185985 systemd-journald[194]: Journal started May 10 09:57:38.186004 systemd-journald[194]: Runtime Journal (/run/log/journal/cb710eab8a4f469e9643259fd80c104a) is 6M, max 48.6M, 42.5M free. May 10 09:57:38.168221 systemd-modules-load[195]: Inserted module 'overlay' May 10 09:57:38.219647 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 10 09:57:38.219675 kernel: Bridge firewalling registered May 10 09:57:38.219686 systemd[1]: Started systemd-journald.service - Journal Service. May 10 09:57:38.195101 systemd-modules-load[195]: Inserted module 'br_netfilter' May 10 09:57:38.213073 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 10 09:57:38.213726 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 10 09:57:38.215094 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 10 09:57:38.216225 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 10 09:57:38.219777 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 10 09:57:38.234827 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 10 09:57:38.248368 systemd-tmpfiles[212]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 10 09:57:38.250798 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 10 09:57:38.251880 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 10 09:57:38.252308 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 10 09:57:38.254615 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 10 09:57:38.256428 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 10 09:57:38.277018 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 10 09:57:38.291418 dracut-cmdline[233]: 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=cdff7a1e66558670c3a31fd90f395811dccc4cb131ce51930f033b8634f7f080 May 10 09:57:38.325209 systemd-resolved[236]: Positive Trust Anchors: May 10 09:57:38.325235 systemd-resolved[236]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 10 09:57:38.325271 systemd-resolved[236]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 10 09:57:38.328004 systemd-resolved[236]: Defaulting to hostname 'linux'. May 10 09:57:38.329189 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 10 09:57:38.335755 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 10 09:57:38.391332 kernel: SCSI subsystem initialized May 10 09:57:38.400313 kernel: Loading iSCSI transport class v2.0-870. May 10 09:57:38.411315 kernel: iscsi: registered transport (tcp) May 10 09:57:38.432319 kernel: iscsi: registered transport (qla4xxx) May 10 09:57:38.432399 kernel: QLogic iSCSI HBA Driver May 10 09:57:38.453502 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 10 09:57:38.475615 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 10 09:57:38.476745 systemd[1]: Reached target network-pre.target - Preparation for Network. May 10 09:57:38.532154 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 10 09:57:38.533764 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 10 09:57:38.588348 kernel: raid6: avx2x4 gen() 26311 MB/s May 10 09:57:38.605333 kernel: raid6: avx2x2 gen() 27547 MB/s May 10 09:57:38.622824 kernel: raid6: avx2x1 gen() 24010 MB/s May 10 09:57:38.622923 kernel: raid6: using algorithm avx2x2 gen() 27547 MB/s May 10 09:57:38.641466 kernel: raid6: .... xor() 19343 MB/s, rmw enabled May 10 09:57:38.641550 kernel: raid6: using avx2x2 recovery algorithm May 10 09:57:38.665328 kernel: xor: automatically using best checksumming function avx May 10 09:57:38.823324 kernel: Btrfs loaded, zoned=no, fsverity=no May 10 09:57:38.833706 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 10 09:57:38.837148 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 10 09:57:38.874026 systemd-udevd[445]: Using default interface naming scheme 'v255'. May 10 09:57:38.880206 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 10 09:57:38.884418 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 10 09:57:38.911076 dracut-pre-trigger[449]: rd.md=0: removing MD RAID activation May 10 09:57:38.944173 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 10 09:57:38.948266 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 10 09:57:39.042733 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 10 09:57:39.050120 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 10 09:57:39.078324 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues May 10 09:57:39.104401 kernel: cryptd: max_cpu_qlen set to 1000 May 10 09:57:39.104430 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 10 09:57:39.107545 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 May 10 09:57:39.112797 kernel: AVX2 version of gcm_enc/dec engaged. May 10 09:57:39.117401 kernel: AES CTR mode by8 optimization enabled May 10 09:57:39.117454 kernel: libata version 3.00 loaded. May 10 09:57:39.117481 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 10 09:57:39.124301 kernel: ahci 0000:00:1f.2: version 3.0 May 10 09:57:39.126297 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 May 10 09:57:39.131804 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode May 10 09:57:39.132050 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only May 10 09:57:39.134461 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 10 09:57:39.139526 kernel: scsi host0: ahci May 10 09:57:39.139788 kernel: scsi host1: ahci May 10 09:57:39.134641 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 10 09:57:39.147498 kernel: scsi host2: ahci May 10 09:57:39.147738 kernel: scsi host3: ahci May 10 09:57:39.147890 kernel: scsi host4: ahci May 10 09:57:39.148078 kernel: scsi host5: ahci May 10 09:57:39.148262 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 May 10 09:57:39.148294 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 May 10 09:57:39.148306 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 May 10 09:57:39.139562 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 10 09:57:39.155856 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 May 10 09:57:39.155901 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 May 10 09:57:39.155917 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 May 10 09:57:39.148602 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 10 09:57:39.156730 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. May 10 09:57:39.176976 kernel: BTRFS: device fsid 447a9416-2d70-470c-8858-df3b82fa5271 devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (508) May 10 09:57:39.180512 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (489) May 10 09:57:39.198404 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 10 09:57:39.259971 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 10 09:57:39.261919 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 10 09:57:39.283460 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 10 09:57:39.285074 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 10 09:57:39.300643 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 10 09:57:39.303250 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 10 09:57:39.429322 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 10 09:57:39.435318 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 10 09:57:39.460316 kernel: ata1: SATA link down (SStatus 0 SControl 300) May 10 09:57:39.460375 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) May 10 09:57:39.462587 kernel: ata2: SATA link down (SStatus 0 SControl 300) May 10 09:57:39.462641 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 May 10 09:57:39.462653 kernel: ata3.00: applying bridge limits May 10 09:57:39.465310 kernel: ata3.00: configured for UDMA/100 May 10 09:57:39.465332 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 May 10 09:57:39.469293 kernel: ata6: SATA link down (SStatus 0 SControl 300) May 10 09:57:39.469317 kernel: ata5: SATA link down (SStatus 0 SControl 300) May 10 09:57:39.470303 kernel: ata4: SATA link down (SStatus 0 SControl 300) May 10 09:57:39.503797 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray May 10 09:57:39.504056 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 10 09:57:39.526729 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 May 10 09:57:39.823248 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 10 09:57:39.823951 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 10 09:57:39.826927 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 10 09:57:39.827161 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 10 09:57:39.828516 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 10 09:57:39.856929 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 10 09:57:40.537029 disk-uuid[584]: The operation has completed successfully. May 10 09:57:40.538260 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 10 09:57:40.570743 systemd[1]: disk-uuid.service: Deactivated successfully. May 10 09:57:40.570859 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 10 09:57:40.605868 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 10 09:57:40.625278 sh[624]: Success May 10 09:57:40.656804 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 10 09:57:40.656883 kernel: device-mapper: uevent: version 1.0.3 May 10 09:57:40.658100 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 10 09:57:40.669325 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" May 10 09:57:40.706142 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 10 09:57:40.709273 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 10 09:57:40.739998 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 10 09:57:40.747159 kernel: BTRFS info (device dm-0): first mount of filesystem 447a9416-2d70-470c-8858-df3b82fa5271 May 10 09:57:40.747214 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 10 09:57:40.747229 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 10 09:57:40.748364 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 10 09:57:40.749842 kernel: BTRFS info (device dm-0): using free space tree May 10 09:57:40.754312 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 10 09:57:40.756034 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 10 09:57:40.757369 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 10 09:57:40.758389 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 10 09:57:40.760115 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 10 09:57:40.785949 kernel: BTRFS info (device vda6): first mount of filesystem b607f6a7-c99c-4217-b084-4c38060efb12 May 10 09:57:40.786003 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 10 09:57:40.786014 kernel: BTRFS info (device vda6): using free space tree May 10 09:57:40.790311 kernel: BTRFS info (device vda6): auto enabling async discard May 10 09:57:40.795360 kernel: BTRFS info (device vda6): last unmount of filesystem b607f6a7-c99c-4217-b084-4c38060efb12 May 10 09:57:40.800372 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 10 09:57:40.801954 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 10 09:57:40.896753 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 10 09:57:40.899384 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 10 09:57:41.167513 ignition[716]: Ignition 2.21.0 May 10 09:57:41.167531 ignition[716]: Stage: fetch-offline May 10 09:57:41.167581 ignition[716]: no configs at "/usr/lib/ignition/base.d" May 10 09:57:41.167596 ignition[716]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 10 09:57:41.167713 ignition[716]: parsed url from cmdline: "" May 10 09:57:41.167719 ignition[716]: no config URL provided May 10 09:57:41.167726 ignition[716]: reading system config file "/usr/lib/ignition/user.ign" May 10 09:57:41.167737 ignition[716]: no config at "/usr/lib/ignition/user.ign" May 10 09:57:41.167767 ignition[716]: op(1): [started] loading QEMU firmware config module May 10 09:57:41.167774 ignition[716]: op(1): executing: "modprobe" "qemu_fw_cfg" May 10 09:57:41.177784 ignition[716]: op(1): [finished] loading QEMU firmware config module May 10 09:57:41.179338 ignition[716]: parsing config with SHA512: 21ba5cdc3dfc89b09bcbe1f3adbcfb4b92a0008fedd5f908a5e424d0e8830f555cf9b541854da0b76ce65f2579d6bfe3a5cde20771b7d19872b2b02e6073f848 May 10 09:57:41.183936 unknown[716]: fetched base config from "system" May 10 09:57:41.183954 unknown[716]: fetched user config from "qemu" May 10 09:57:41.184134 ignition[716]: fetch-offline: fetch-offline passed May 10 09:57:41.184223 ignition[716]: Ignition finished successfully May 10 09:57:41.187637 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 10 09:57:41.191188 systemd-networkd[810]: lo: Link UP May 10 09:57:41.191202 systemd-networkd[810]: lo: Gained carrier May 10 09:57:41.193227 systemd-networkd[810]: Enumeration completed May 10 09:57:41.193343 systemd[1]: Started systemd-networkd.service - Network Configuration. May 10 09:57:41.193691 systemd-networkd[810]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 10 09:57:41.193697 systemd-networkd[810]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 10 09:57:41.194747 systemd-networkd[810]: eth0: Link UP May 10 09:57:41.194751 systemd-networkd[810]: eth0: Gained carrier May 10 09:57:41.194761 systemd-networkd[810]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 10 09:57:41.195698 systemd[1]: Reached target network.target - Network. May 10 09:57:41.197563 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 10 09:57:41.198432 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 10 09:57:41.210343 systemd-networkd[810]: eth0: DHCPv4 address 10.0.0.73/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 10 09:57:41.231811 ignition[817]: Ignition 2.21.0 May 10 09:57:41.231825 ignition[817]: Stage: kargs May 10 09:57:41.231959 ignition[817]: no configs at "/usr/lib/ignition/base.d" May 10 09:57:41.231971 ignition[817]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 10 09:57:41.232441 ignition[817]: kargs: kargs passed May 10 09:57:41.232485 ignition[817]: Ignition finished successfully May 10 09:57:41.237073 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 10 09:57:41.239205 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 10 09:57:41.417577 ignition[826]: Ignition 2.21.0 May 10 09:57:41.417593 ignition[826]: Stage: disks May 10 09:57:41.417775 ignition[826]: no configs at "/usr/lib/ignition/base.d" May 10 09:57:41.417788 ignition[826]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 10 09:57:41.418430 ignition[826]: disks: disks passed May 10 09:57:41.421549 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 10 09:57:41.418484 ignition[826]: Ignition finished successfully May 10 09:57:41.423235 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 10 09:57:41.425119 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 10 09:57:41.427078 systemd[1]: Reached target local-fs.target - Local File Systems. May 10 09:57:41.427133 systemd[1]: Reached target sysinit.target - System Initialization. May 10 09:57:41.427474 systemd[1]: Reached target basic.target - Basic System. May 10 09:57:41.428757 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 10 09:57:41.463251 systemd-resolved[236]: Detected conflict on linux IN A 10.0.0.73 May 10 09:57:41.463270 systemd-resolved[236]: Hostname conflict, changing published hostname from 'linux' to 'linux7'. May 10 09:57:41.480344 systemd-fsck[836]: ROOT: clean, 15/553520 files, 52789/553472 blocks May 10 09:57:41.611563 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 10 09:57:41.614067 systemd[1]: Mounting sysroot.mount - /sysroot... May 10 09:57:41.726296 kernel: EXT4-fs (vda9): mounted filesystem f8cce592-76ea-4219-9560-1ef21b28761f r/w with ordered data mode. Quota mode: none. May 10 09:57:41.726963 systemd[1]: Mounted sysroot.mount - /sysroot. May 10 09:57:41.729529 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 10 09:57:41.733456 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 10 09:57:41.736356 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 10 09:57:41.738772 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 10 09:57:41.738834 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 10 09:57:41.740980 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 10 09:57:41.748673 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 10 09:57:41.751999 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 10 09:57:41.757101 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (844) May 10 09:57:41.757129 kernel: BTRFS info (device vda6): first mount of filesystem b607f6a7-c99c-4217-b084-4c38060efb12 May 10 09:57:41.757152 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 10 09:57:41.757166 kernel: BTRFS info (device vda6): using free space tree May 10 09:57:41.759302 kernel: BTRFS info (device vda6): auto enabling async discard May 10 09:57:41.760176 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 10 09:57:41.863128 initrd-setup-root[868]: cut: /sysroot/etc/passwd: No such file or directory May 10 09:57:41.867889 initrd-setup-root[875]: cut: /sysroot/etc/group: No such file or directory May 10 09:57:41.872554 initrd-setup-root[882]: cut: /sysroot/etc/shadow: No such file or directory May 10 09:57:41.877194 initrd-setup-root[889]: cut: /sysroot/etc/gshadow: No such file or directory May 10 09:57:41.959526 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 10 09:57:41.960964 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 10 09:57:41.963745 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 10 09:57:41.996576 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 10 09:57:41.997882 kernel: BTRFS info (device vda6): last unmount of filesystem b607f6a7-c99c-4217-b084-4c38060efb12 May 10 09:57:42.016501 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 10 09:57:42.076518 ignition[958]: INFO : Ignition 2.21.0 May 10 09:57:42.076518 ignition[958]: INFO : Stage: mount May 10 09:57:42.078399 ignition[958]: INFO : no configs at "/usr/lib/ignition/base.d" May 10 09:57:42.078399 ignition[958]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 10 09:57:42.078399 ignition[958]: INFO : mount: mount passed May 10 09:57:42.078399 ignition[958]: INFO : Ignition finished successfully May 10 09:57:42.084210 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 10 09:57:42.085370 systemd[1]: Starting ignition-files.service - Ignition (files)... May 10 09:57:42.110524 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 10 09:57:42.136305 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (970) May 10 09:57:42.138431 kernel: BTRFS info (device vda6): first mount of filesystem b607f6a7-c99c-4217-b084-4c38060efb12 May 10 09:57:42.138449 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 10 09:57:42.138462 kernel: BTRFS info (device vda6): using free space tree May 10 09:57:42.142301 kernel: BTRFS info (device vda6): auto enabling async discard May 10 09:57:42.143928 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 10 09:57:42.237270 ignition[987]: INFO : Ignition 2.21.0 May 10 09:57:42.238442 ignition[987]: INFO : Stage: files May 10 09:57:42.240151 ignition[987]: INFO : no configs at "/usr/lib/ignition/base.d" May 10 09:57:42.241216 ignition[987]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 10 09:57:42.243054 ignition[987]: DEBUG : files: compiled without relabeling support, skipping May 10 09:57:42.244959 ignition[987]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 10 09:57:42.244959 ignition[987]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 10 09:57:42.248439 ignition[987]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 10 09:57:42.249880 ignition[987]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 10 09:57:42.251464 unknown[987]: wrote ssh authorized keys file for user: core May 10 09:57:42.252592 ignition[987]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 10 09:57:42.254865 ignition[987]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 10 09:57:42.256721 ignition[987]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 10 09:57:42.258470 ignition[987]: INFO : files: op(4): [started] processing unit "docker.service" May 10 09:57:42.258470 ignition[987]: INFO : files: op(4): [finished] processing unit "docker.service" May 10 09:57:42.258470 ignition[987]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" May 10 09:57:42.262253 ignition[987]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 10 09:57:42.264480 ignition[987]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 10 09:57:42.264480 ignition[987]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" May 10 09:57:42.267969 ignition[987]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" May 10 09:57:42.285247 ignition[987]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" May 10 09:57:42.289594 ignition[987]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 10 09:57:42.291560 ignition[987]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" May 10 09:57:42.291560 ignition[987]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" May 10 09:57:42.294748 ignition[987]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" May 10 09:57:42.296483 ignition[987]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 10 09:57:42.298612 ignition[987]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 10 09:57:42.300477 ignition[987]: INFO : files: files passed May 10 09:57:42.301362 ignition[987]: INFO : Ignition finished successfully May 10 09:57:42.305668 systemd[1]: Finished ignition-files.service - Ignition (files). May 10 09:57:42.307896 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 10 09:57:42.309939 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 10 09:57:42.329091 systemd[1]: ignition-quench.service: Deactivated successfully. May 10 09:57:42.330292 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 10 09:57:42.330605 initrd-setup-root-after-ignition[1015]: grep: /sysroot/oem/oem-release: No such file or directory May 10 09:57:42.333192 initrd-setup-root-after-ignition[1017]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 10 09:57:42.333192 initrd-setup-root-after-ignition[1017]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 10 09:57:42.338019 initrd-setup-root-after-ignition[1021]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 10 09:57:42.340133 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 10 09:57:42.345377 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 10 09:57:42.348894 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 10 09:57:42.410096 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 10 09:57:42.411389 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 10 09:57:42.414379 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 10 09:57:42.416569 systemd[1]: Reached target initrd.target - Initrd Default Target. May 10 09:57:42.418798 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 10 09:57:42.421089 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 10 09:57:42.447920 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 10 09:57:42.451957 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 10 09:57:42.475172 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 10 09:57:42.478220 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 10 09:57:42.481613 systemd[1]: Stopped target timers.target - Timer Units. May 10 09:57:42.483754 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 10 09:57:42.484785 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 10 09:57:42.487720 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 10 09:57:42.489783 systemd[1]: Stopped target basic.target - Basic System. May 10 09:57:42.491624 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 10 09:57:42.493830 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 10 09:57:42.496126 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 10 09:57:42.498363 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 10 09:57:42.500566 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 10 09:57:42.502659 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 10 09:57:42.505127 systemd[1]: Stopped target sysinit.target - System Initialization. May 10 09:57:42.507208 systemd[1]: Stopped target local-fs.target - Local File Systems. May 10 09:57:42.509230 systemd[1]: Stopped target swap.target - Swaps. May 10 09:57:42.510866 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 10 09:57:42.511878 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 10 09:57:42.514254 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 10 09:57:42.516442 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 10 09:57:42.518841 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 10 09:57:42.519791 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 10 09:57:42.522372 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 10 09:57:42.523404 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 10 09:57:42.525683 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 10 09:57:42.527764 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 10 09:57:42.530120 systemd[1]: Stopped target paths.target - Path Units. May 10 09:57:42.531867 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 10 09:57:42.532958 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 10 09:57:42.535705 systemd[1]: Stopped target slices.target - Slice Units. May 10 09:57:42.537530 systemd[1]: Stopped target sockets.target - Socket Units. May 10 09:57:42.539464 systemd[1]: iscsid.socket: Deactivated successfully. May 10 09:57:42.540438 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 10 09:57:42.542437 systemd[1]: iscsiuio.socket: Deactivated successfully. May 10 09:57:42.543322 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 10 09:57:42.545398 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 10 09:57:42.546563 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 10 09:57:42.549193 systemd[1]: ignition-files.service: Deactivated successfully. May 10 09:57:42.550177 systemd[1]: Stopped ignition-files.service - Ignition (files). May 10 09:57:42.553091 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 10 09:57:42.555363 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 10 09:57:42.556605 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 10 09:57:42.564966 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 10 09:57:42.567111 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 10 09:57:42.568398 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 10 09:57:42.571079 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 10 09:57:42.572342 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 10 09:57:42.581515 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 10 09:57:42.581676 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 10 09:57:42.597466 ignition[1043]: INFO : Ignition 2.21.0 May 10 09:57:42.597466 ignition[1043]: INFO : Stage: umount May 10 09:57:42.600736 ignition[1043]: INFO : no configs at "/usr/lib/ignition/base.d" May 10 09:57:42.600736 ignition[1043]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 10 09:57:42.600736 ignition[1043]: INFO : umount: umount passed May 10 09:57:42.600736 ignition[1043]: INFO : Ignition finished successfully May 10 09:57:42.598238 systemd[1]: sysroot-boot.service: Deactivated successfully. May 10 09:57:42.598441 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 10 09:57:42.600858 systemd[1]: ignition-mount.service: Deactivated successfully. May 10 09:57:42.600974 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 10 09:57:42.603135 systemd[1]: Stopped target network.target - Network. May 10 09:57:42.605428 systemd[1]: ignition-disks.service: Deactivated successfully. May 10 09:57:42.605487 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 10 09:57:42.607533 systemd[1]: ignition-kargs.service: Deactivated successfully. May 10 09:57:42.607586 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 10 09:57:42.609750 systemd[1]: ignition-setup.service: Deactivated successfully. May 10 09:57:42.609799 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 10 09:57:42.612026 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 10 09:57:42.612072 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 10 09:57:42.613369 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 10 09:57:42.613421 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 10 09:57:42.614881 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 10 09:57:42.616395 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 10 09:57:42.619249 systemd[1]: systemd-resolved.service: Deactivated successfully. May 10 09:57:42.619436 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 10 09:57:42.622728 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 10 09:57:42.622781 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 10 09:57:42.626716 systemd[1]: systemd-networkd.service: Deactivated successfully. May 10 09:57:42.626840 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 10 09:57:42.628582 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 10 09:57:42.630736 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 10 09:57:42.630781 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 10 09:57:42.634051 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 10 09:57:42.635671 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 10 09:57:42.635725 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 10 09:57:42.638267 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 10 09:57:42.638342 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 10 09:57:42.640717 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 10 09:57:42.640764 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 10 09:57:42.642843 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 10 09:57:42.669482 systemd[1]: systemd-udevd.service: Deactivated successfully. May 10 09:57:42.669652 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 10 09:57:42.672072 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 10 09:57:42.672123 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 10 09:57:42.674166 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 10 09:57:42.674205 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 10 09:57:42.676299 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 10 09:57:42.676357 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 10 09:57:42.677546 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 10 09:57:42.677595 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 10 09:57:42.679617 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 10 09:57:42.679664 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 10 09:57:42.682559 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 10 09:57:42.683885 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 10 09:57:42.683937 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 10 09:57:42.686193 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 10 09:57:42.686242 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 10 09:57:42.688427 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 10 09:57:42.688473 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 10 09:57:42.698509 systemd[1]: network-cleanup.service: Deactivated successfully. May 10 09:57:42.698611 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 10 09:57:42.705329 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 10 09:57:42.705438 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 10 09:57:42.706855 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 10 09:57:42.709708 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 10 09:57:42.727832 systemd[1]: Switching root. May 10 09:57:42.756874 systemd-journald[194]: Journal stopped May 10 09:57:43.692674 systemd-journald[194]: Received SIGTERM from PID 1 (systemd). May 10 09:57:43.692743 kernel: SELinux: policy capability network_peer_controls=1 May 10 09:57:43.692761 kernel: SELinux: policy capability open_perms=1 May 10 09:57:43.692777 kernel: SELinux: policy capability extended_socket_class=1 May 10 09:57:43.692792 kernel: SELinux: policy capability always_check_network=0 May 10 09:57:43.692803 kernel: SELinux: policy capability cgroup_seclabel=1 May 10 09:57:43.692815 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 10 09:57:43.692829 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 10 09:57:43.692840 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 10 09:57:43.692858 kernel: audit: type=1403 audit(1746871062.850:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 10 09:57:43.692881 systemd[1]: Successfully loaded SELinux policy in 43.885ms. May 10 09:57:43.692896 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.225ms. May 10 09:57:43.692910 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 10 09:57:43.692922 systemd[1]: Detected virtualization kvm. May 10 09:57:43.692934 systemd[1]: Detected architecture x86-64. May 10 09:57:43.692946 systemd[1]: Detected first boot. May 10 09:57:43.692960 systemd[1]: Initializing machine ID from VM UUID. May 10 09:57:43.692972 zram_generator::config[1091]: No configuration found. May 10 09:57:43.692987 kernel: Guest personality initialized and is inactive May 10 09:57:43.692999 kernel: VMCI host device registered (name=vmci, major=10, minor=125) May 10 09:57:43.693010 kernel: Initialized host personality May 10 09:57:43.693021 kernel: NET: Registered PF_VSOCK protocol family May 10 09:57:43.693033 systemd[1]: Populated /etc with preset unit settings. May 10 09:57:43.693046 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 10 09:57:43.693062 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 10 09:57:43.693074 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 10 09:57:43.693086 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 10 09:57:43.693105 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 10 09:57:43.693119 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 10 09:57:43.693134 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 10 09:57:43.693146 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 10 09:57:43.693158 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 10 09:57:43.693170 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 10 09:57:43.693183 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 10 09:57:43.693194 systemd[1]: Created slice user.slice - User and Session Slice. May 10 09:57:43.693207 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 10 09:57:43.693219 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 10 09:57:43.693231 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 10 09:57:43.693246 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 10 09:57:43.694399 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 10 09:57:43.694420 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 10 09:57:43.694437 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 10 09:57:43.694450 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 10 09:57:43.694463 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 10 09:57:43.694475 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 10 09:57:43.694488 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 10 09:57:43.694504 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 10 09:57:43.694517 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 10 09:57:43.694529 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 10 09:57:43.694541 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 10 09:57:43.694553 systemd[1]: Reached target slices.target - Slice Units. May 10 09:57:43.694566 systemd[1]: Reached target swap.target - Swaps. May 10 09:57:43.694578 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 10 09:57:43.694590 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 10 09:57:43.694602 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 10 09:57:43.694617 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 10 09:57:43.694629 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 10 09:57:43.694641 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 10 09:57:43.694653 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 10 09:57:43.694664 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 10 09:57:43.694677 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 10 09:57:43.694689 systemd[1]: Mounting media.mount - External Media Directory... May 10 09:57:43.694702 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 10 09:57:43.694715 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 10 09:57:43.694729 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 10 09:57:43.694742 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 10 09:57:43.694755 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). May 10 09:57:43.694768 systemd[1]: Reached target machines.target - Containers. May 10 09:57:43.694780 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 10 09:57:43.694792 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 10 09:57:43.694804 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 10 09:57:43.694817 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 10 09:57:43.694831 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 10 09:57:43.694843 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 10 09:57:43.694855 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 10 09:57:43.694867 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 10 09:57:43.694879 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 10 09:57:43.694892 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 10 09:57:43.694904 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 10 09:57:43.694916 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 10 09:57:43.694928 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 10 09:57:43.694942 systemd[1]: Stopped systemd-fsck-usr.service. May 10 09:57:43.694960 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 10 09:57:43.694972 kernel: loop: module loaded May 10 09:57:43.694984 systemd[1]: Starting systemd-journald.service - Journal Service... May 10 09:57:43.694997 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 10 09:57:43.695009 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 10 09:57:43.695021 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 10 09:57:43.695034 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 10 09:57:43.695049 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 10 09:57:43.695062 systemd[1]: verity-setup.service: Deactivated successfully. May 10 09:57:43.695075 systemd[1]: Stopped verity-setup.service. May 10 09:57:43.695087 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 10 09:57:43.695099 kernel: ACPI: bus type drm_connector registered May 10 09:57:43.695113 kernel: fuse: init (API version 7.39) May 10 09:57:43.695125 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 10 09:57:43.695137 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 10 09:57:43.695150 systemd[1]: Mounted media.mount - External Media Directory. May 10 09:57:43.695162 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 10 09:57:43.695174 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 10 09:57:43.695210 systemd-journald[1161]: Collecting audit messages is disabled. May 10 09:57:43.695235 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 10 09:57:43.695251 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 10 09:57:43.695263 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 10 09:57:43.695276 systemd-journald[1161]: Journal started May 10 09:57:43.695311 systemd-journald[1161]: Runtime Journal (/run/log/journal/cb710eab8a4f469e9643259fd80c104a) is 6M, max 48.6M, 42.5M free. May 10 09:57:43.439901 systemd[1]: Queued start job for default target multi-user.target. May 10 09:57:43.454212 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 10 09:57:43.454679 systemd[1]: systemd-journald.service: Deactivated successfully. May 10 09:57:43.698994 systemd[1]: Started systemd-journald.service - Journal Service. May 10 09:57:43.699858 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 10 09:57:43.700078 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 10 09:57:43.701602 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 10 09:57:43.701806 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 10 09:57:43.703313 systemd[1]: modprobe@drm.service: Deactivated successfully. May 10 09:57:43.703528 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 10 09:57:43.705064 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 10 09:57:43.705360 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 10 09:57:43.707091 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 10 09:57:43.707406 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 10 09:57:43.708947 systemd[1]: modprobe@loop.service: Deactivated successfully. May 10 09:57:43.709216 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 10 09:57:43.710826 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 10 09:57:43.712398 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 10 09:57:43.714496 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 10 09:57:43.716221 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 10 09:57:43.731784 systemd[1]: Reached target network-pre.target - Preparation for Network. May 10 09:57:43.734761 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 10 09:57:43.737050 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 10 09:57:43.738360 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 10 09:57:43.738448 systemd[1]: Reached target local-fs.target - Local File Systems. May 10 09:57:43.740688 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 10 09:57:43.756619 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 10 09:57:43.773674 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 10 09:57:43.775215 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 10 09:57:43.777510 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 10 09:57:43.778840 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 10 09:57:43.781823 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 10 09:57:43.783066 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 10 09:57:43.790805 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 10 09:57:43.794110 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 10 09:57:43.807270 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 10 09:57:43.807991 systemd-journald[1161]: Time spent on flushing to /var/log/journal/cb710eab8a4f469e9643259fd80c104a is 13.096ms for 937 entries. May 10 09:57:43.807991 systemd-journald[1161]: System Journal (/var/log/journal/cb710eab8a4f469e9643259fd80c104a) is 8M, max 195.6M, 187.6M free. May 10 09:57:43.981781 systemd-journald[1161]: Received client request to flush runtime journal. May 10 09:57:43.981835 kernel: loop0: detected capacity change from 0 to 146240 May 10 09:57:43.981849 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 10 09:57:43.828995 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 10 09:57:43.830592 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 10 09:57:43.831895 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 10 09:57:43.897616 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 10 09:57:43.959025 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 10 09:57:43.961157 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 10 09:57:43.964010 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 10 09:57:43.968412 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 10 09:57:43.972248 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 10 09:57:43.984600 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 10 09:57:44.002897 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 10 09:57:44.006232 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. May 10 09:57:44.006256 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. May 10 09:57:44.010352 kernel: loop1: detected capacity change from 0 to 113872 May 10 09:57:44.014620 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 10 09:57:44.055323 kernel: loop2: detected capacity change from 0 to 146240 May 10 09:57:44.066342 kernel: loop3: detected capacity change from 0 to 113872 May 10 09:57:44.074801 (sd-merge)[1233]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 10 09:57:44.075413 (sd-merge)[1233]: Merged extensions into '/usr'. May 10 09:57:44.079571 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 10 09:57:44.083016 systemd[1]: Starting ensure-sysext.service... May 10 09:57:44.085125 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 10 09:57:44.104979 systemd[1]: Reload requested from client PID 1235 ('systemctl') (unit ensure-sysext.service)... May 10 09:57:44.105103 systemd[1]: Reloading... May 10 09:57:44.122860 systemd-tmpfiles[1236]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 10 09:57:44.122895 systemd-tmpfiles[1236]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 10 09:57:44.123228 systemd-tmpfiles[1236]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 10 09:57:44.123531 systemd-tmpfiles[1236]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 10 09:57:44.124488 systemd-tmpfiles[1236]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 10 09:57:44.124752 systemd-tmpfiles[1236]: ACLs are not supported, ignoring. May 10 09:57:44.124828 systemd-tmpfiles[1236]: ACLs are not supported, ignoring. May 10 09:57:44.133386 systemd-tmpfiles[1236]: Detected autofs mount point /boot during canonicalization of boot. May 10 09:57:44.133516 systemd-tmpfiles[1236]: Skipping /boot May 10 09:57:44.152422 systemd-tmpfiles[1236]: Detected autofs mount point /boot during canonicalization of boot. May 10 09:57:44.152513 systemd-tmpfiles[1236]: Skipping /boot May 10 09:57:44.176395 zram_generator::config[1264]: No configuration found. May 10 09:57:44.266778 ldconfig[1205]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 10 09:57:44.288004 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 10 09:57:44.389514 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 10 09:57:44.390249 systemd[1]: Reloading finished in 284 ms. May 10 09:57:44.416082 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 10 09:57:44.441349 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 10 09:57:44.453241 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 10 09:57:44.456861 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 10 09:57:44.461668 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 10 09:57:44.473594 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 10 09:57:44.478626 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 10 09:57:44.485897 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 10 09:57:44.488541 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 10 09:57:44.490679 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 10 09:57:44.495090 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 10 09:57:44.498492 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 10 09:57:44.499698 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 10 09:57:44.499806 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 10 09:57:44.499902 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 10 09:57:44.508697 systemd[1]: modprobe@loop.service: Deactivated successfully. May 10 09:57:44.509199 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 10 09:57:44.511495 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 10 09:57:44.511748 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 10 09:57:44.513628 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 10 09:57:44.513874 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 10 09:57:44.517787 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 10 09:57:44.525643 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 10 09:57:44.525950 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 10 09:57:44.527844 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 10 09:57:44.530534 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 10 09:57:44.532851 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 10 09:57:44.536034 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 10 09:57:44.537557 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 10 09:57:44.537842 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 10 09:57:44.544237 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 10 09:57:44.548404 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 10 09:57:44.551133 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 10 09:57:44.553461 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 10 09:57:44.553744 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 10 09:57:44.555847 systemd[1]: modprobe@drm.service: Deactivated successfully. May 10 09:57:44.556194 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 10 09:57:44.558238 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 10 09:57:44.558857 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 10 09:57:44.560835 systemd[1]: modprobe@loop.service: Deactivated successfully. May 10 09:57:44.561202 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 10 09:57:44.570532 augenrules[1339]: No rules May 10 09:57:44.570716 systemd[1]: Finished ensure-sysext.service. May 10 09:57:44.572693 systemd[1]: audit-rules.service: Deactivated successfully. May 10 09:57:44.573015 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 10 09:57:44.579168 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 10 09:57:44.579276 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 10 09:57:44.582392 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 10 09:57:44.595729 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 10 09:57:44.597764 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 10 09:57:44.601494 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 10 09:57:44.603965 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 10 09:57:44.605252 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 10 09:57:44.617437 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 10 09:57:44.631506 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 10 09:57:44.656574 systemd-udevd[1354]: Using default interface naming scheme 'v255'. May 10 09:57:44.679571 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 10 09:57:44.687998 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 10 09:57:44.698562 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 10 09:57:44.700822 systemd[1]: Reached target time-set.target - System Time Set. May 10 09:57:44.726492 systemd-resolved[1306]: Positive Trust Anchors: May 10 09:57:44.726511 systemd-resolved[1306]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 10 09:57:44.726542 systemd-resolved[1306]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 10 09:57:44.731042 systemd-resolved[1306]: Defaulting to hostname 'linux'. May 10 09:57:44.732971 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 10 09:57:44.734923 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 10 09:57:44.736686 systemd[1]: Reached target sysinit.target - System Initialization. May 10 09:57:44.738327 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 10 09:57:44.739797 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 10 09:57:44.741215 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. May 10 09:57:44.743081 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 10 09:57:44.744553 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 10 09:57:44.746654 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 10 09:57:44.748112 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 10 09:57:44.748142 systemd[1]: Reached target paths.target - Path Units. May 10 09:57:44.749228 systemd[1]: Reached target timers.target - Timer Units. May 10 09:57:44.751408 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 10 09:57:44.755990 systemd[1]: Starting docker.socket - Docker Socket for the API... May 10 09:57:44.758313 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1364) May 10 09:57:44.763892 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 10 09:57:44.766304 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 10 09:57:44.767846 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 10 09:57:44.777784 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 10 09:57:44.779519 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 10 09:57:44.782619 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 10 09:57:44.787060 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 10 09:57:44.807323 kernel: mousedev: PS/2 mouse device common for all mice May 10 09:57:44.812189 systemd[1]: Reached target sockets.target - Socket Units. May 10 09:57:44.816454 systemd[1]: Reached target basic.target - Basic System. May 10 09:57:44.817562 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 10 09:57:44.817592 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 10 09:57:44.819031 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 10 09:57:44.822267 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 10 09:57:44.826138 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 May 10 09:57:44.825090 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 10 09:57:44.828421 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 10 09:57:44.830359 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). May 10 09:57:44.836418 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... May 10 09:57:44.840194 jq[1407]: false May 10 09:57:44.843514 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 10 09:57:44.846844 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 10 09:57:44.852462 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 10 09:57:44.859304 kernel: ACPI: button: Power Button [PWRF] May 10 09:57:44.860610 systemd[1]: Starting systemd-logind.service - User Login Management... May 10 09:57:44.864172 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 10 09:57:44.864742 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 10 09:57:44.866760 systemd[1]: Starting update-engine.service - Update Engine... May 10 09:57:44.870047 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 10 09:57:44.875941 google_oslogin_nss_cache[1409]: oslogin_cache_refresh[1409]: Refreshing passwd entry cache May 10 09:57:44.894954 google_oslogin_nss_cache[1409]: oslogin_cache_refresh[1409]: Failure getting users, quitting May 10 09:57:44.894954 google_oslogin_nss_cache[1409]: oslogin_cache_refresh[1409]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 10 09:57:44.894954 google_oslogin_nss_cache[1409]: oslogin_cache_refresh[1409]: Refreshing group entry cache May 10 09:57:44.894954 google_oslogin_nss_cache[1409]: oslogin_cache_refresh[1409]: Failure getting groups, quitting May 10 09:57:44.894954 google_oslogin_nss_cache[1409]: oslogin_cache_refresh[1409]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 10 09:57:44.882781 oslogin_cache_refresh[1409]: Refreshing passwd entry cache May 10 09:57:44.877100 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 10 09:57:44.889784 oslogin_cache_refresh[1409]: Failure getting users, quitting May 10 09:57:44.881861 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 10 09:57:44.889801 oslogin_cache_refresh[1409]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 10 09:57:44.882166 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 10 09:57:44.889842 oslogin_cache_refresh[1409]: Refreshing group entry cache May 10 09:57:44.895688 jq[1418]: true May 10 09:57:44.890347 oslogin_cache_refresh[1409]: Failure getting groups, quitting May 10 09:57:44.890358 oslogin_cache_refresh[1409]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 10 09:57:44.897156 systemd[1]: google-oslogin-cache.service: Deactivated successfully. May 10 09:57:44.902214 jq[1420]: true May 10 09:57:44.897462 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. May 10 09:57:44.901847 systemd[1]: motdgen.service: Deactivated successfully. May 10 09:57:44.906489 extend-filesystems[1408]: Found loop2 May 10 09:57:44.906489 extend-filesystems[1408]: Found loop3 May 10 09:57:44.906489 extend-filesystems[1408]: Found sr0 May 10 09:57:44.906489 extend-filesystems[1408]: Found vda May 10 09:57:44.906489 extend-filesystems[1408]: Found vda1 May 10 09:57:44.906489 extend-filesystems[1408]: Found vda2 May 10 09:57:44.906489 extend-filesystems[1408]: Found vda3 May 10 09:57:44.906489 extend-filesystems[1408]: Found usr May 10 09:57:44.906489 extend-filesystems[1408]: Found vda4 May 10 09:57:44.906489 extend-filesystems[1408]: Found vda6 May 10 09:57:44.906489 extend-filesystems[1408]: Found vda7 May 10 09:57:44.906489 extend-filesystems[1408]: Found vda9 May 10 09:57:44.906489 extend-filesystems[1408]: Checking size of /dev/vda9 May 10 09:57:44.955404 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt May 10 09:57:44.955652 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) May 10 09:57:44.955852 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD May 10 09:57:44.902842 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 10 09:57:44.956166 update_engine[1417]: I20250510 09:57:44.948904 1417 main.cc:92] Flatcar Update Engine starting May 10 09:57:44.953704 dbus-daemon[1404]: [system] SELinux support is enabled May 10 09:57:44.911541 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 10 09:57:44.911922 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 10 09:57:44.923051 systemd-networkd[1372]: lo: Link UP May 10 09:57:44.923055 systemd-networkd[1372]: lo: Gained carrier May 10 09:57:44.925746 systemd-networkd[1372]: Enumeration completed May 10 09:57:44.926453 systemd-networkd[1372]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 10 09:57:44.926458 systemd-networkd[1372]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 10 09:57:44.928175 systemd-networkd[1372]: eth0: Link UP May 10 09:57:44.928179 systemd-networkd[1372]: eth0: Gained carrier May 10 09:57:44.928192 systemd-networkd[1372]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 10 09:57:44.942780 systemd-networkd[1372]: eth0: DHCPv4 address 10.0.0.73/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 10 09:57:44.944350 systemd-timesyncd[1351]: Network configuration changed, trying to establish connection. May 10 09:57:44.946512 systemd-timesyncd[1351]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 10 09:57:44.962254 update_engine[1417]: I20250510 09:57:44.958467 1417 update_check_scheduler.cc:74] Next update check in 6m10s May 10 09:57:44.946561 systemd-timesyncd[1351]: Initial clock synchronization to Sat 2025-05-10 09:57:45.327354 UTC. May 10 09:57:44.956383 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 10 09:57:44.957926 systemd[1]: Started systemd-networkd.service - Network Configuration. May 10 09:57:44.959453 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 10 09:57:44.968258 extend-filesystems[1408]: Old size kept for /dev/vda9 May 10 09:57:44.972428 bash[1455]: Updated "/home/core/.ssh/authorized_keys" May 10 09:57:44.975853 systemd[1]: extend-filesystems.service: Deactivated successfully. May 10 09:57:44.976756 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 10 09:57:44.979234 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 10 09:57:44.990511 systemd[1]: Started update-engine.service - Update Engine. May 10 09:57:44.992152 systemd[1]: Reached target network.target - Network. May 10 09:57:44.997566 systemd[1]: Starting containerd.service - containerd container runtime... May 10 09:57:44.999662 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 10 09:57:44.999833 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). May 10 09:57:44.999959 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 10 09:57:45.011551 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 10 09:57:45.017652 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 10 09:57:45.023531 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 10 09:57:45.025136 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). May 10 09:57:45.025314 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 10 09:57:45.029667 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 10 09:57:45.050675 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 10 09:57:45.112170 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1384) May 10 09:57:45.115851 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 10 09:57:45.129772 (ntainerd)[1476]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 10 09:57:45.145406 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 10 09:57:45.158789 systemd-logind[1414]: Watching system buttons on /dev/input/event2 (Power Button) May 10 09:57:45.158823 systemd-logind[1414]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) May 10 09:57:45.161495 systemd-logind[1414]: New seat seat0. May 10 09:57:45.163624 systemd[1]: Started systemd-logind.service - User Login Management. May 10 09:57:45.171017 locksmithd[1470]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 10 09:57:45.288374 kernel: kvm_amd: TSC scaling supported May 10 09:57:45.288630 kernel: kvm_amd: Nested Virtualization enabled May 10 09:57:45.288687 kernel: kvm_amd: Nested Paging enabled May 10 09:57:45.288719 kernel: kvm_amd: LBR virtualization supported May 10 09:57:45.288778 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported May 10 09:57:45.288810 kernel: kvm_amd: Virtual GIF supported May 10 09:57:45.330362 kernel: EDAC MC: Ver: 3.0.0 May 10 09:57:45.394583 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 10 09:57:45.399385 containerd[1476]: time="2025-05-10T09:57:45Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 10 09:57:45.400043 containerd[1476]: time="2025-05-10T09:57:45.400008886Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 10 09:57:45.409190 containerd[1476]: time="2025-05-10T09:57:45.409147356Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.216µs" May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409254046Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409276948Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409491389Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409508109Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409534034Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409598143Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409608293Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409906838Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409919716Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409929593Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.409937790Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 10 09:57:45.410809 containerd[1476]: time="2025-05-10T09:57:45.410036336Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 10 09:57:45.411088 containerd[1476]: time="2025-05-10T09:57:45.410279232Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 10 09:57:45.411088 containerd[1476]: time="2025-05-10T09:57:45.410308589Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 10 09:57:45.411088 containerd[1476]: time="2025-05-10T09:57:45.410318539Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 10 09:57:45.411088 containerd[1476]: time="2025-05-10T09:57:45.410367775Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 10 09:57:45.411088 containerd[1476]: time="2025-05-10T09:57:45.410580958Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 10 09:57:45.411088 containerd[1476]: time="2025-05-10T09:57:45.410645843Z" level=info msg="metadata content store policy set" policy=shared May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416361696Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416406608Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416421155Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416444655Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416459045Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416470885Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416486104Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416508565Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416521412Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416544189Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416554821Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416567626Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416689756Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 10 09:57:45.417491 containerd[1476]: time="2025-05-10T09:57:45.416715765Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416730847Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416742193Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416753592Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416764129Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416775014Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416786203Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416796793Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416807131Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416817365Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416881799Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416896955Z" level=info msg="Start snapshots syncer" May 10 09:57:45.417776 containerd[1476]: time="2025-05-10T09:57:45.416928821Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 10 09:57:45.417999 containerd[1476]: time="2025-05-10T09:57:45.417192814Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 10 09:57:45.417999 containerd[1476]: time="2025-05-10T09:57:45.417244380Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 10 09:57:45.418656 containerd[1476]: time="2025-05-10T09:57:45.418636460Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 10 09:57:45.418804 containerd[1476]: time="2025-05-10T09:57:45.418787665Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 10 09:57:45.418865 containerd[1476]: time="2025-05-10T09:57:45.418853012Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 10 09:57:45.418912 containerd[1476]: time="2025-05-10T09:57:45.418901198Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 10 09:57:45.418973 containerd[1476]: time="2025-05-10T09:57:45.418960332Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 10 09:57:45.419023 containerd[1476]: time="2025-05-10T09:57:45.419011541Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 10 09:57:45.419071 containerd[1476]: time="2025-05-10T09:57:45.419059403Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 10 09:57:45.419118 containerd[1476]: time="2025-05-10T09:57:45.419105889Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 10 09:57:45.419179 containerd[1476]: time="2025-05-10T09:57:45.419167448Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 10 09:57:45.419250 containerd[1476]: time="2025-05-10T09:57:45.419237455Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 10 09:57:45.419377 containerd[1476]: time="2025-05-10T09:57:45.419350643Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 10 09:57:45.419500 containerd[1476]: time="2025-05-10T09:57:45.419479333Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 10 09:57:45.419578 containerd[1476]: time="2025-05-10T09:57:45.419559542Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 10 09:57:45.419632 containerd[1476]: time="2025-05-10T09:57:45.419618834Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 10 09:57:45.419696 containerd[1476]: time="2025-05-10T09:57:45.419678450Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 10 09:57:45.419757 containerd[1476]: time="2025-05-10T09:57:45.419740523Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 10 09:57:45.419823 containerd[1476]: time="2025-05-10T09:57:45.419806931Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 10 09:57:45.419904 containerd[1476]: time="2025-05-10T09:57:45.419886910Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 10 09:57:45.419976 containerd[1476]: time="2025-05-10T09:57:45.419962018Z" level=info msg="runtime interface created" May 10 09:57:45.420029 containerd[1476]: time="2025-05-10T09:57:45.420016209Z" level=info msg="created NRI interface" May 10 09:57:45.420089 containerd[1476]: time="2025-05-10T09:57:45.420073538Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 10 09:57:45.420155 containerd[1476]: time="2025-05-10T09:57:45.420141057Z" level=info msg="Connect containerd service" May 10 09:57:45.420247 containerd[1476]: time="2025-05-10T09:57:45.420228940Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 10 09:57:45.422931 containerd[1476]: time="2025-05-10T09:57:45.422907207Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" May 10 09:57:45.526864 sshd_keygen[1428]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 10 09:57:45.528811 containerd[1476]: time="2025-05-10T09:57:45.528699391Z" level=info msg="Start subscribing containerd event" May 10 09:57:45.528811 containerd[1476]: time="2025-05-10T09:57:45.528771267Z" level=info msg="Start recovering state" May 10 09:57:45.530371 containerd[1476]: time="2025-05-10T09:57:45.529632528Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 10 09:57:45.530371 containerd[1476]: time="2025-05-10T09:57:45.529806718Z" level=info msg=serving... address=/run/containerd/containerd.sock May 10 09:57:45.530657 containerd[1476]: time="2025-05-10T09:57:45.530606001Z" level=info msg="Start event monitor" May 10 09:57:45.530657 containerd[1476]: time="2025-05-10T09:57:45.530654608Z" level=info msg="Start cni network conf syncer for default" May 10 09:57:45.530721 containerd[1476]: time="2025-05-10T09:57:45.530664506Z" level=info msg="Start streaming server" May 10 09:57:45.530721 containerd[1476]: time="2025-05-10T09:57:45.530677447Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 10 09:57:45.530721 containerd[1476]: time="2025-05-10T09:57:45.530690944Z" level=info msg="runtime interface starting up..." May 10 09:57:45.530721 containerd[1476]: time="2025-05-10T09:57:45.530698659Z" level=info msg="starting plugins..." May 10 09:57:45.530721 containerd[1476]: time="2025-05-10T09:57:45.530714980Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 10 09:57:45.530962 containerd[1476]: time="2025-05-10T09:57:45.530935928Z" level=info msg="containerd successfully booted in 0.132349s" May 10 09:57:45.531218 systemd[1]: Started containerd.service - containerd container runtime. May 10 09:57:45.559850 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 10 09:57:45.563466 systemd[1]: Starting issuegen.service - Generate /run/issue... May 10 09:57:45.588891 systemd[1]: issuegen.service: Deactivated successfully. May 10 09:57:45.589299 systemd[1]: Finished issuegen.service - Generate /run/issue. May 10 09:57:45.593012 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 10 09:57:45.613964 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 10 09:57:45.617990 systemd[1]: Started getty@tty1.service - Getty on tty1. May 10 09:57:45.620762 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 10 09:57:45.622359 systemd[1]: Reached target getty.target - Login Prompts. May 10 09:57:46.903089 systemd-networkd[1372]: eth0: Gained IPv6LL May 10 09:57:46.906725 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 10 09:57:46.908835 systemd[1]: Reached target network-online.target - Network is Online. May 10 09:57:46.912202 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 10 09:57:46.914762 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 10 09:57:46.963860 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 10 09:57:46.966917 systemd[1]: coreos-metadata.service: Deactivated successfully. May 10 09:57:46.967212 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 10 09:57:46.969307 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 10 09:57:46.969482 systemd[1]: Reached target multi-user.target - Multi-User System. May 10 09:57:46.971033 systemd[1]: Startup finished in 2.990s (kernel) + 5.133s (initrd) + 4.162s (userspace) = 12.285s. May 10 09:57:51.788960 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 10 09:57:51.790298 systemd[1]: Started sshd@0-10.0.0.73:22-10.0.0.1:40480.service - OpenSSH per-connection server daemon (10.0.0.1:40480). May 10 09:57:51.858943 sshd[1552]: Accepted publickey for core from 10.0.0.1 port 40480 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:51.861606 sshd-session[1552]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:51.868941 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 10 09:57:51.870260 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 10 09:57:51.877497 systemd-logind[1414]: New session 1 of user core. May 10 09:57:51.897383 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 10 09:57:51.901017 systemd[1]: Starting user@500.service - User Manager for UID 500... May 10 09:57:51.918833 (systemd)[1556]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 10 09:57:51.921901 systemd-logind[1414]: New session c1 of user core. May 10 09:57:52.070700 systemd[1556]: Queued start job for default target default.target. May 10 09:57:52.079661 systemd[1556]: Created slice app.slice - User Application Slice. May 10 09:57:52.079686 systemd[1556]: Reached target paths.target - Paths. May 10 09:57:52.079731 systemd[1556]: Reached target timers.target - Timers. May 10 09:57:52.081392 systemd[1556]: Starting dbus.socket - D-Bus User Message Bus Socket... May 10 09:57:52.093209 systemd[1556]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 10 09:57:52.093376 systemd[1556]: Reached target sockets.target - Sockets. May 10 09:57:52.093427 systemd[1556]: Reached target basic.target - Basic System. May 10 09:57:52.093470 systemd[1556]: Reached target default.target - Main User Target. May 10 09:57:52.093504 systemd[1556]: Startup finished in 163ms. May 10 09:57:52.093986 systemd[1]: Started user@500.service - User Manager for UID 500. May 10 09:57:52.095893 systemd[1]: Started session-1.scope - Session 1 of User core. May 10 09:57:52.163473 systemd[1]: Started sshd@1-10.0.0.73:22-10.0.0.1:40484.service - OpenSSH per-connection server daemon (10.0.0.1:40484). May 10 09:57:52.212951 sshd[1567]: Accepted publickey for core from 10.0.0.1 port 40484 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:52.214410 sshd-session[1567]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:52.219655 systemd-logind[1414]: New session 2 of user core. May 10 09:57:52.228526 systemd[1]: Started session-2.scope - Session 2 of User core. May 10 09:57:52.283078 sshd[1569]: Connection closed by 10.0.0.1 port 40484 May 10 09:57:52.283436 sshd-session[1567]: pam_unix(sshd:session): session closed for user core May 10 09:57:52.300483 systemd[1]: sshd@1-10.0.0.73:22-10.0.0.1:40484.service: Deactivated successfully. May 10 09:57:52.302514 systemd[1]: session-2.scope: Deactivated successfully. May 10 09:57:52.304070 systemd-logind[1414]: Session 2 logged out. Waiting for processes to exit. May 10 09:57:52.305711 systemd[1]: Started sshd@2-10.0.0.73:22-10.0.0.1:40488.service - OpenSSH per-connection server daemon (10.0.0.1:40488). May 10 09:57:52.306714 systemd-logind[1414]: Removed session 2. May 10 09:57:52.362109 sshd[1574]: Accepted publickey for core from 10.0.0.1 port 40488 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:52.363570 sshd-session[1574]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:52.369100 systemd-logind[1414]: New session 3 of user core. May 10 09:57:52.379647 systemd[1]: Started session-3.scope - Session 3 of User core. May 10 09:57:52.433002 sshd[1577]: Connection closed by 10.0.0.1 port 40488 May 10 09:57:52.433491 sshd-session[1574]: pam_unix(sshd:session): session closed for user core May 10 09:57:52.446459 systemd[1]: sshd@2-10.0.0.73:22-10.0.0.1:40488.service: Deactivated successfully. May 10 09:57:52.448602 systemd[1]: session-3.scope: Deactivated successfully. May 10 09:57:52.450384 systemd-logind[1414]: Session 3 logged out. Waiting for processes to exit. May 10 09:57:52.451794 systemd[1]: Started sshd@3-10.0.0.73:22-10.0.0.1:40492.service - OpenSSH per-connection server daemon (10.0.0.1:40492). May 10 09:57:52.452711 systemd-logind[1414]: Removed session 3. May 10 09:57:52.516176 sshd[1582]: Accepted publickey for core from 10.0.0.1 port 40492 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:52.517669 sshd-session[1582]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:52.522581 systemd-logind[1414]: New session 4 of user core. May 10 09:57:52.540609 systemd[1]: Started session-4.scope - Session 4 of User core. May 10 09:57:52.596152 sshd[1585]: Connection closed by 10.0.0.1 port 40492 May 10 09:57:52.596577 sshd-session[1582]: pam_unix(sshd:session): session closed for user core May 10 09:57:52.608254 systemd[1]: sshd@3-10.0.0.73:22-10.0.0.1:40492.service: Deactivated successfully. May 10 09:57:52.610170 systemd[1]: session-4.scope: Deactivated successfully. May 10 09:57:52.611899 systemd-logind[1414]: Session 4 logged out. Waiting for processes to exit. May 10 09:57:52.613230 systemd[1]: Started sshd@4-10.0.0.73:22-10.0.0.1:40498.service - OpenSSH per-connection server daemon (10.0.0.1:40498). May 10 09:57:52.614637 systemd-logind[1414]: Removed session 4. May 10 09:57:52.667253 sshd[1590]: Accepted publickey for core from 10.0.0.1 port 40498 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:52.669117 sshd-session[1590]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:52.673809 systemd-logind[1414]: New session 5 of user core. May 10 09:57:52.683436 systemd[1]: Started session-5.scope - Session 5 of User core. May 10 09:57:52.743470 sudo[1594]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 10 09:57:52.743825 sudo[1594]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 10 09:57:52.767882 sudo[1594]: pam_unix(sudo:session): session closed for user root May 10 09:57:52.769746 sshd[1593]: Connection closed by 10.0.0.1 port 40498 May 10 09:57:52.770196 sshd-session[1590]: pam_unix(sshd:session): session closed for user core May 10 09:57:52.786649 systemd[1]: sshd@4-10.0.0.73:22-10.0.0.1:40498.service: Deactivated successfully. May 10 09:57:52.788623 systemd[1]: session-5.scope: Deactivated successfully. May 10 09:57:52.790434 systemd-logind[1414]: Session 5 logged out. Waiting for processes to exit. May 10 09:57:52.791845 systemd[1]: Started sshd@5-10.0.0.73:22-10.0.0.1:40506.service - OpenSSH per-connection server daemon (10.0.0.1:40506). May 10 09:57:52.792756 systemd-logind[1414]: Removed session 5. May 10 09:57:52.844874 sshd[1599]: Accepted publickey for core from 10.0.0.1 port 40506 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:52.846235 sshd-session[1599]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:52.851058 systemd-logind[1414]: New session 6 of user core. May 10 09:57:52.861461 systemd[1]: Started session-6.scope - Session 6 of User core. May 10 09:57:52.915860 sudo[1604]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 10 09:57:52.916194 sudo[1604]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 10 09:57:52.920461 sudo[1604]: pam_unix(sudo:session): session closed for user root May 10 09:57:52.927207 sudo[1603]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 10 09:57:52.927561 sudo[1603]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 10 09:57:52.937869 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 10 09:57:52.983726 augenrules[1626]: No rules May 10 09:57:52.985966 systemd[1]: audit-rules.service: Deactivated successfully. May 10 09:57:52.986367 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 10 09:57:52.987609 sudo[1603]: pam_unix(sudo:session): session closed for user root May 10 09:57:52.989151 sshd[1602]: Connection closed by 10.0.0.1 port 40506 May 10 09:57:52.989530 sshd-session[1599]: pam_unix(sshd:session): session closed for user core May 10 09:57:52.999425 systemd[1]: sshd@5-10.0.0.73:22-10.0.0.1:40506.service: Deactivated successfully. May 10 09:57:53.001179 systemd[1]: session-6.scope: Deactivated successfully. May 10 09:57:53.002728 systemd-logind[1414]: Session 6 logged out. Waiting for processes to exit. May 10 09:57:53.004001 systemd[1]: Started sshd@6-10.0.0.73:22-10.0.0.1:40510.service - OpenSSH per-connection server daemon (10.0.0.1:40510). May 10 09:57:53.004861 systemd-logind[1414]: Removed session 6. May 10 09:57:53.054610 sshd[1634]: Accepted publickey for core from 10.0.0.1 port 40510 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:53.056472 sshd-session[1634]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:53.061255 systemd-logind[1414]: New session 7 of user core. May 10 09:57:53.074440 systemd[1]: Started session-7.scope - Session 7 of User core. May 10 09:57:53.132667 systemd[1]: Starting docker.service - Docker Application Container Engine... May 10 09:57:53.146835 (dockerd)[1639]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU May 10 09:57:53.545136 dockerd[1639]: time="2025-05-10T09:57:53.545057637Z" level=info msg="Starting up" May 10 09:57:53.547059 dockerd[1639]: time="2025-05-10T09:57:53.547015114Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 10 09:57:53.641911 dockerd[1639]: time="2025-05-10T09:57:53.641816017Z" level=info msg="Loading containers: start." May 10 09:57:53.655314 kernel: Initializing XFRM netlink socket May 10 09:57:53.908387 systemd-networkd[1372]: docker0: Link UP May 10 09:57:53.913832 dockerd[1639]: time="2025-05-10T09:57:53.913780811Z" level=info msg="Loading containers: done." May 10 09:57:53.928677 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3977489144-merged.mount: Deactivated successfully. May 10 09:57:53.929105 dockerd[1639]: time="2025-05-10T09:57:53.929015880Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 May 10 09:57:53.929169 dockerd[1639]: time="2025-05-10T09:57:53.929110915Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 10 09:57:53.929310 dockerd[1639]: time="2025-05-10T09:57:53.929272536Z" level=info msg="Initializing buildkit" May 10 09:57:53.958194 dockerd[1639]: time="2025-05-10T09:57:53.958162334Z" level=info msg="Completed buildkit initialization" May 10 09:57:53.963779 dockerd[1639]: time="2025-05-10T09:57:53.963627087Z" level=info msg="Daemon has completed initialization" May 10 09:57:53.963779 dockerd[1639]: time="2025-05-10T09:57:53.963684060Z" level=info msg="API listen on /run/docker.sock" May 10 09:57:53.963991 systemd[1]: Started docker.service - Docker Application Container Engine. May 10 09:57:53.974814 sshd[1637]: Connection closed by 10.0.0.1 port 40510 May 10 09:57:53.975196 sshd-session[1634]: pam_unix(sshd:session): session closed for user core May 10 09:57:53.988052 systemd[1]: sshd@6-10.0.0.73:22-10.0.0.1:40510.service: Deactivated successfully. May 10 09:57:53.989853 systemd[1]: session-7.scope: Deactivated successfully. May 10 09:57:53.991333 systemd-logind[1414]: Session 7 logged out. Waiting for processes to exit. May 10 09:57:53.992583 systemd[1]: Started sshd@7-10.0.0.73:22-10.0.0.1:40526.service - OpenSSH per-connection server daemon (10.0.0.1:40526). May 10 09:57:53.993630 systemd-logind[1414]: Removed session 7. May 10 09:57:54.037642 sshd[1842]: Accepted publickey for core from 10.0.0.1 port 40526 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:54.039126 sshd-session[1842]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:54.043626 systemd-logind[1414]: New session 8 of user core. May 10 09:57:54.053443 systemd[1]: Started session-8.scope - Session 8 of User core. May 10 09:57:55.950279 systemd[1]: var-lib-docker-overlay2-4260372fc166e144c7ba02a1f2e1c9e844e70479823d28a84c30d22f4a4bf1b2\x2dinit-merged.mount: Deactivated successfully. May 10 09:57:56.052847 containerd[1476]: time="2025-05-10T09:57:56.052784364Z" level=info msg="connecting to shim e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda" address="unix:///run/containerd/s/cdc5088644764338f71077c08d64064eb5f1b6cb25f02090b57a8b7cf35f6ad5" namespace=moby protocol=ttrpc version=3 May 10 09:57:56.098521 systemd[1]: Started docker-e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda.scope - libcontainer container e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda. May 10 09:57:56.146469 systemd-resolved[1306]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 10 09:57:56.177388 kernel: docker0: port 1(veth853046e) entered blocking state May 10 09:57:56.177498 kernel: docker0: port 1(veth853046e) entered disabled state May 10 09:57:56.177529 kernel: veth853046e: entered allmulticast mode May 10 09:57:56.178668 kernel: veth853046e: entered promiscuous mode May 10 09:57:56.178889 systemd-networkd[1372]: veth853046e: Link UP May 10 09:57:56.188324 kernel: eth0: renamed from veth826bda4 May 10 09:57:56.193697 kernel: docker0: port 1(veth853046e) entered blocking state May 10 09:57:56.194256 kernel: docker0: port 1(veth853046e) entered forwarding state May 10 09:57:56.193786 systemd-networkd[1372]: veth853046e: Gained carrier May 10 09:57:56.194063 systemd-networkd[1372]: docker0: Gained carrier May 10 09:57:56.229468 sshd[1845]: Connection closed by 10.0.0.1 port 40526 May 10 09:57:56.229580 sshd-session[1842]: pam_unix(sshd:session): session closed for user core May 10 09:57:56.245215 systemd[1]: sshd@7-10.0.0.73:22-10.0.0.1:40526.service: Deactivated successfully. May 10 09:57:56.247055 systemd[1]: session-8.scope: Deactivated successfully. May 10 09:57:56.247867 systemd-logind[1414]: Session 8 logged out. Waiting for processes to exit. May 10 09:57:56.249983 systemd[1]: Started sshd@8-10.0.0.73:22-10.0.0.1:40534.service - OpenSSH per-connection server daemon (10.0.0.1:40534). May 10 09:57:56.250973 systemd-logind[1414]: Removed session 8. May 10 09:57:56.308621 sshd[1917]: Accepted publickey for core from 10.0.0.1 port 40534 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:56.310605 sshd-session[1917]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:56.315260 systemd-logind[1414]: New session 9 of user core. May 10 09:57:56.330447 systemd[1]: Started session-9.scope - Session 9 of User core. May 10 09:57:56.394314 sshd[1920]: Connection closed by 10.0.0.1 port 40534 May 10 09:57:56.394736 sshd-session[1917]: pam_unix(sshd:session): session closed for user core May 10 09:57:56.409228 systemd[1]: sshd@8-10.0.0.73:22-10.0.0.1:40534.service: Deactivated successfully. May 10 09:57:56.411206 systemd[1]: session-9.scope: Deactivated successfully. May 10 09:57:56.412710 systemd-logind[1414]: Session 9 logged out. Waiting for processes to exit. May 10 09:57:56.413952 systemd[1]: Started sshd@9-10.0.0.73:22-10.0.0.1:40536.service - OpenSSH per-connection server daemon (10.0.0.1:40536). May 10 09:57:56.414929 systemd-logind[1414]: Removed session 9. May 10 09:57:56.463702 sshd[1925]: Accepted publickey for core from 10.0.0.1 port 40536 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:56.465415 sshd-session[1925]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:56.470327 systemd-logind[1414]: New session 10 of user core. May 10 09:57:56.479475 systemd[1]: Started session-10.scope - Session 10 of User core. May 10 09:57:56.535646 sudo[1929]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1476 May 10 09:57:56.536003 sudo[1929]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 10 09:57:56.540505 sudo[1929]: pam_unix(sudo:session): session closed for user root May 10 09:57:56.540643 containerd[1476]: time="2025-05-10T09:57:56.540540434Z" level=info msg="Stop CRI service" May 10 09:57:56.541205 dockerd[1639]: time="2025-05-10T09:57:56.540912275Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 10 09:57:56.541205 dockerd[1639]: time="2025-05-10T09:57:56.540967233Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 10 09:57:56.541205 dockerd[1639]: time="2025-05-10T09:57:56.540969603Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 10 09:57:56.541205 dockerd[1639]: time="2025-05-10T09:57:56.541058938Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 10 09:57:56.541623 containerd[1476]: time="2025-05-10T09:57:56.541179265Z" level=info msg="Stop CRI service" May 10 09:57:56.542492 sshd[1928]: Connection closed by 10.0.0.1 port 40536 May 10 09:57:56.542841 sshd-session[1925]: pam_unix(sshd:session): session closed for user core May 10 09:57:56.551653 systemd[1]: containerd.service: Deactivated successfully. May 10 09:57:56.551798 systemd[1]: containerd.service: Unit process 1868 (containerd-shim) remains running after unit stopped. May 10 09:57:56.552122 systemd[1]: containerd.service: Consumed 432ms CPU time, 141.7M memory peak. May 10 09:57:56.552656 systemd[1]: sshd@9-10.0.0.73:22-10.0.0.1:40536.service: Deactivated successfully. May 10 09:57:56.554977 systemd[1]: session-10.scope: Deactivated successfully. May 10 09:57:56.556887 systemd-logind[1414]: Session 10 logged out. Waiting for processes to exit. May 10 09:57:56.559810 systemd[1]: Started sshd@10-10.0.0.73:22-10.0.0.1:40550.service - OpenSSH per-connection server daemon (10.0.0.1:40550). May 10 09:57:56.560451 systemd-logind[1414]: Removed session 10. May 10 09:57:56.614827 sshd[1935]: Accepted publickey for core from 10.0.0.1 port 40550 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:57:56.616579 sshd-session[1935]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:57:56.621527 systemd-logind[1414]: New session 11 of user core. May 10 09:57:56.635536 systemd[1]: Started session-11.scope - Session 11 of User core. May 10 09:57:56.694312 sshd[1938]: Connection closed by 10.0.0.1 port 40550 May 10 09:57:56.694613 sshd-session[1935]: pam_unix(sshd:session): session closed for user core May 10 09:57:56.698360 systemd[1]: sshd@10-10.0.0.73:22-10.0.0.1:40550.service: Deactivated successfully. May 10 09:57:56.700133 systemd[1]: session-11.scope: Deactivated successfully. May 10 09:57:56.700879 systemd-logind[1414]: Session 11 logged out. Waiting for processes to exit. May 10 09:57:56.701937 systemd-logind[1414]: Removed session 11. May 10 09:57:57.524495 systemd-networkd[1372]: veth853046e: Gained IPv6LL May 10 09:57:58.037048 systemd-networkd[1372]: docker0: Gained IPv6LL May 10 09:58:01.680491 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. May 10 09:58:01.680977 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 10 09:58:01.681104 dockerd[1639]: time="2025-05-10T09:58:01.681017967Z" level=info msg="Processing signal 'terminated'" May 10 09:58:02.753564 systemd[1]: Started sshd@11-10.0.0.73:22-10.0.0.1:39904.service - OpenSSH per-connection server daemon (10.0.0.1:39904). May 10 09:58:02.805906 sshd[1944]: Accepted publickey for core from 10.0.0.1 port 39904 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:02.807895 sshd-session[1944]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:02.813099 systemd-logind[1414]: New session 12 of user core. May 10 09:58:02.820500 systemd[1]: Started session-12.scope - Session 12 of User core. May 10 09:58:02.879697 sshd[1946]: Connection closed by 10.0.0.1 port 39904 May 10 09:58:02.880082 sshd-session[1944]: pam_unix(sshd:session): session closed for user core May 10 09:58:02.884652 systemd[1]: sshd@11-10.0.0.73:22-10.0.0.1:39904.service: Deactivated successfully. May 10 09:58:02.886671 systemd[1]: session-12.scope: Deactivated successfully. May 10 09:58:02.887612 systemd-logind[1414]: Session 12 logged out. Waiting for processes to exit. May 10 09:58:02.888700 systemd-logind[1414]: Removed session 12. May 10 09:58:03.682796 dockerd[1639]: time="2025-05-10T09:58:03.682719234Z" level=error msg="Error sending stop (signal 15) to container" container=e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda error="Cannot kill container e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" May 10 09:58:03.682796 dockerd[1639]: time="2025-05-10T09:58:03.682789275Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda May 10 09:58:08.911932 systemd[1]: Started sshd@12-10.0.0.73:22-10.0.0.1:59310.service - OpenSSH per-connection server daemon (10.0.0.1:59310). May 10 09:58:08.954541 sshd[1952]: Accepted publickey for core from 10.0.0.1 port 59310 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:08.955934 sshd-session[1952]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:08.960213 systemd-logind[1414]: New session 13 of user core. May 10 09:58:08.968427 systemd[1]: Started session-13.scope - Session 13 of User core. May 10 09:58:09.023481 sshd[1954]: Connection closed by 10.0.0.1 port 59310 May 10 09:58:09.023844 sshd-session[1952]: pam_unix(sshd:session): session closed for user core May 10 09:58:09.027755 systemd[1]: sshd@12-10.0.0.73:22-10.0.0.1:59310.service: Deactivated successfully. May 10 09:58:09.029544 systemd[1]: session-13.scope: Deactivated successfully. May 10 09:58:09.030225 systemd-logind[1414]: Session 13 logged out. Waiting for processes to exit. May 10 09:58:09.031121 systemd-logind[1414]: Removed session 13. May 10 09:58:13.684037 dockerd[1639]: time="2025-05-10T09:58:13.683963913Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda error="context deadline exceeded" May 10 09:58:13.684708 systemd[1]: docker-e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda.scope: Deactivated successfully. May 10 09:58:15.047211 systemd[1]: Started sshd@13-10.0.0.73:22-10.0.0.1:59316.service - OpenSSH per-connection server daemon (10.0.0.1:59316). May 10 09:58:15.096116 sshd[1960]: Accepted publickey for core from 10.0.0.1 port 59316 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:15.097504 sshd-session[1960]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:15.101369 systemd-logind[1414]: New session 14 of user core. May 10 09:58:15.113429 systemd[1]: Started session-14.scope - Session 14 of User core. May 10 09:58:15.167759 sshd[1962]: Connection closed by 10.0.0.1 port 59316 May 10 09:58:15.168051 sshd-session[1960]: pam_unix(sshd:session): session closed for user core May 10 09:58:15.171515 systemd[1]: sshd@13-10.0.0.73:22-10.0.0.1:59316.service: Deactivated successfully. May 10 09:58:15.173200 systemd[1]: session-14.scope: Deactivated successfully. May 10 09:58:15.173845 systemd-logind[1414]: Session 14 logged out. Waiting for processes to exit. May 10 09:58:15.174676 systemd-logind[1414]: Removed session 14. May 10 09:58:16.682064 dockerd[1639]: time="2025-05-10T09:58:16.682002922Z" level=error msg="Force shutdown daemon" May 10 09:58:16.682525 dockerd[1639]: time="2025-05-10T09:58:16.682163404Z" level=info msg="Daemon shutdown complete" May 10 09:58:16.687718 systemd[1]: docker.service: Deactivated successfully. May 10 09:58:16.688131 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 10 09:58:16.688200 systemd[1]: docker.service: Consumed 1.395s CPU time, 128.8M memory peak. May 10 09:58:16.688683 systemd[1]: docker.socket: Deactivated successfully. May 10 09:58:16.689029 systemd[1]: Closed docker.socket - Docker Socket for the API. May 10 09:58:16.689068 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 10 09:58:16.691082 systemd[1]: Starting docker.socket - Docker Socket for the API... May 10 09:58:16.691293 systemd[1]: containerd.service: Found left-over process 1868 (containerd-shim) in control group while starting unit. Ignoring. May 10 09:58:16.691302 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 10 09:58:16.697685 systemd[1]: Starting containerd.service - containerd container runtime... May 10 09:58:16.698627 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 10 09:58:16.713813 systemd[1]: containerd.service: Found left-over process 1868 (containerd-shim) in control group while starting unit. Ignoring. May 10 09:58:16.713823 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 10 09:58:16.726698 (ntainerd)[1973]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 10 09:58:16.745579 containerd[1973]: time="2025-05-10T09:58:16Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 10 09:58:16.746263 containerd[1973]: time="2025-05-10T09:58:16.746224655Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 10 09:58:16.756768 containerd[1973]: time="2025-05-10T09:58:16.756715367Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.139µs" May 10 09:58:16.756768 containerd[1973]: time="2025-05-10T09:58:16.756759754Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 10 09:58:16.756851 containerd[1973]: time="2025-05-10T09:58:16.756786012Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 10 09:58:16.757016 containerd[1973]: time="2025-05-10T09:58:16.756981658Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 10 09:58:16.757071 containerd[1973]: time="2025-05-10T09:58:16.757023297Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 10 09:58:16.757593 containerd[1973]: time="2025-05-10T09:58:16.757407217Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 10 09:58:16.757593 containerd[1973]: time="2025-05-10T09:58:16.757464909Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 10 09:58:16.757593 containerd[1973]: time="2025-05-10T09:58:16.757494066Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 10 09:58:16.758078 containerd[1973]: time="2025-05-10T09:58:16.758006736Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 10 09:58:16.758078 containerd[1973]: time="2025-05-10T09:58:16.758058542Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 10 09:58:16.758078 containerd[1973]: time="2025-05-10T09:58:16.758077191Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 10 09:58:16.758078 containerd[1973]: time="2025-05-10T09:58:16.758088080Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 10 09:58:16.758440 containerd[1973]: time="2025-05-10T09:58:16.758120375Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 10 09:58:16.758440 containerd[1973]: time="2025-05-10T09:58:16.758240250Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 10 09:58:16.758440 containerd[1973]: time="2025-05-10T09:58:16.758265527Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 10 09:58:16.758440 containerd[1973]: time="2025-05-10T09:58:16.758275172Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 10 09:58:16.758440 containerd[1973]: time="2025-05-10T09:58:16.758344405Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 10 09:58:16.758582 containerd[1973]: time="2025-05-10T09:58:16.758555370Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 10 09:58:16.758582 containerd[1973]: time="2025-05-10T09:58:16.758576114Z" level=info msg="metadata content store policy set" policy=shared May 10 09:58:16.758738 containerd[1973]: time="2025-05-10T09:58:16.758709054Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 10 09:58:16.758795 containerd[1973]: time="2025-05-10T09:58:16.758760851Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 10 09:58:16.758795 containerd[1973]: time="2025-05-10T09:58:16.758776351Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 10 09:58:16.758845 containerd[1973]: time="2025-05-10T09:58:16.758794108Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 10 09:58:16.758845 containerd[1973]: time="2025-05-10T09:58:16.758816297Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 10 09:58:16.758845 containerd[1973]: time="2025-05-10T09:58:16.758828168Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 10 09:58:16.758845 containerd[1973]: time="2025-05-10T09:58:16.758841051Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 10 09:58:16.758959 containerd[1973]: time="2025-05-10T09:58:16.758854688Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 10 09:58:16.758959 containerd[1973]: time="2025-05-10T09:58:16.758866649Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 10 09:58:16.758959 containerd[1973]: time="2025-05-10T09:58:16.758876154Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 10 09:58:16.758959 containerd[1973]: time="2025-05-10T09:58:16.758886772Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 10 09:58:16.758959 containerd[1973]: time="2025-05-10T09:58:16.758903897Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 10 09:58:16.759158 containerd[1973]: time="2025-05-10T09:58:16.759135988Z" level=info msg="connecting to shim e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda" address="unix:///run/containerd/s/cdc5088644764338f71077c08d64064eb5f1b6cb25f02090b57a8b7cf35f6ad5" namespace=moby protocol=ttrpc version=3 May 10 09:58:16.769468 containerd[1973]: time="2025-05-10T09:58:16.769434894Z" level=info msg="cleaning leaked shim process" id=e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda namespace=moby May 10 09:58:16.782305 containerd[1973]: time="2025-05-10T09:58:16.782161802Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 10 09:58:16.782655 containerd[1973]: time="2025-05-10T09:58:16.782541551Z" level=info msg="shim disconnected" id=e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda namespace=moby May 10 09:58:16.782655 containerd[1973]: time="2025-05-10T09:58:16.782575200Z" level=warning msg="cleaning up after shim disconnected" id=e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda namespace=moby May 10 09:58:16.782655 containerd[1973]: time="2025-05-10T09:58:16.782595905Z" level=info msg="cleaning up dead shim" namespace=moby May 10 09:58:16.798103 containerd[1973]: time="2025-05-10T09:58:16.798019781Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 10 09:58:16.798304 containerd[1973]: time="2025-05-10T09:58:16.798247470Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 10 09:58:16.798335 containerd[1973]: time="2025-05-10T09:58:16.798312070Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 10 09:58:16.798362 containerd[1973]: time="2025-05-10T09:58:16.798338148Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 10 09:58:16.798362 containerd[1973]: time="2025-05-10T09:58:16.798350962Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 10 09:58:16.798400 containerd[1973]: time="2025-05-10T09:58:16.798362092Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 10 09:58:16.798400 containerd[1973]: time="2025-05-10T09:58:16.798373732Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 10 09:58:16.798400 containerd[1973]: time="2025-05-10T09:58:16.798384882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 10 09:58:16.798400 containerd[1973]: time="2025-05-10T09:58:16.798395951Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 10 09:58:16.798484 containerd[1973]: time="2025-05-10T09:58:16.798406368Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 10 09:58:16.798484 containerd[1973]: time="2025-05-10T09:58:16.798419433Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 10 09:58:16.798484 containerd[1973]: time="2025-05-10T09:58:16.798449131Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 10 09:58:16.798543 containerd[1973]: time="2025-05-10T09:58:16.798514703Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 10 09:58:16.798543 containerd[1973]: time="2025-05-10T09:58:16.798530274Z" level=info msg="Start snapshots syncer" May 10 09:58:16.798588 containerd[1973]: time="2025-05-10T09:58:16.798560945Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 10 09:58:16.798826 containerd[1973]: time="2025-05-10T09:58:16.798793528Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 10 09:58:16.798925 containerd[1973]: time="2025-05-10T09:58:16.798843790Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 10 09:58:16.798948 containerd[1973]: time="2025-05-10T09:58:16.798926568Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 10 09:58:16.798978 containerd[1973]: time="2025-05-10T09:58:16.798969430Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 10 09:58:16.799000 containerd[1973]: time="2025-05-10T09:58:16.798987176Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 10 09:58:16.799020 containerd[1973]: time="2025-05-10T09:58:16.798998998Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 10 09:58:16.799020 containerd[1973]: time="2025-05-10T09:58:16.799010057Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 10 09:58:16.799058 containerd[1973]: time="2025-05-10T09:58:16.799021888Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 10 09:58:16.799058 containerd[1973]: time="2025-05-10T09:58:16.799033118Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 10 09:58:16.799058 containerd[1973]: time="2025-05-10T09:58:16.799043836Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 10 09:58:16.799129 containerd[1973]: time="2025-05-10T09:58:16.799079751Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 10 09:58:16.799129 containerd[1973]: time="2025-05-10T09:58:16.799091772Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 10 09:58:16.799129 containerd[1973]: time="2025-05-10T09:58:16.799103042Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 10 09:58:16.799187 containerd[1973]: time="2025-05-10T09:58:16.799134855Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 10 09:58:16.799187 containerd[1973]: time="2025-05-10T09:58:16.799150286Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 10 09:58:16.799187 containerd[1973]: time="2025-05-10T09:58:16.799159290Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 10 09:58:16.799187 containerd[1973]: time="2025-05-10T09:58:16.799169577Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 10 09:58:16.799187 containerd[1973]: time="2025-05-10T09:58:16.799177268Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 10 09:58:16.799187 containerd[1973]: time="2025-05-10T09:58:16.799188587Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 10 09:58:16.799325 containerd[1973]: time="2025-05-10T09:58:16.799200027Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 10 09:58:16.799325 containerd[1973]: time="2025-05-10T09:58:16.799219287Z" level=info msg="runtime interface created" May 10 09:58:16.799325 containerd[1973]: time="2025-05-10T09:58:16.799225845Z" level=info msg="created NRI interface" May 10 09:58:16.799325 containerd[1973]: time="2025-05-10T09:58:16.799234458Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 10 09:58:16.799325 containerd[1973]: time="2025-05-10T09:58:16.799244465Z" level=info msg="Connect containerd service" May 10 09:58:16.799325 containerd[1973]: time="2025-05-10T09:58:16.799269079Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 10 09:58:16.799857 containerd[1973]: time="2025-05-10T09:58:16.799835028Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" May 10 09:58:16.817174 containerd[1973]: time="2025-05-10T09:58:16.817071896Z" level=info msg="Start subscribing containerd event" May 10 09:58:16.817174 containerd[1973]: time="2025-05-10T09:58:16.817154895Z" level=info msg="Start recovering state" May 10 09:58:16.817321 containerd[1973]: time="2025-05-10T09:58:16.817202319Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 10 09:58:16.817437 containerd[1973]: time="2025-05-10T09:58:16.817348965Z" level=info msg=serving... address=/run/containerd/containerd.sock May 10 09:58:16.817437 containerd[1973]: time="2025-05-10T09:58:16.817351532Z" level=info msg="Start event monitor" May 10 09:58:16.817437 containerd[1973]: time="2025-05-10T09:58:16.817390295Z" level=info msg="Start cni network conf syncer for default" May 10 09:58:16.817437 containerd[1973]: time="2025-05-10T09:58:16.817404612Z" level=info msg="Start streaming server" May 10 09:58:16.817437 containerd[1973]: time="2025-05-10T09:58:16.817426940Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 10 09:58:16.817437 containerd[1973]: time="2025-05-10T09:58:16.817438030Z" level=info msg="runtime interface starting up..." May 10 09:58:16.817587 containerd[1973]: time="2025-05-10T09:58:16.817446091Z" level=info msg="starting plugins..." May 10 09:58:16.817587 containerd[1973]: time="2025-05-10T09:58:16.817459867Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 10 09:58:16.817587 containerd[1973]: time="2025-05-10T09:58:16.817584746Z" level=info msg="containerd successfully booted in 0.072220s" May 10 09:58:16.817836 systemd[1]: Started containerd.service - containerd container runtime. May 10 09:58:16.819675 systemd[1]: Starting docker.service - Docker Application Container Engine... May 10 09:58:16.832671 (dockerd)[2022]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU May 10 09:58:16.866677 dockerd[2022]: time="2025-05-10T09:58:16.866613761Z" level=info msg="Starting up" May 10 09:58:16.867345 dockerd[2022]: time="2025-05-10T09:58:16.867314817Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 10 09:58:16.901967 dockerd[2022]: time="2025-05-10T09:58:16.901921021Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 10 09:58:16.926695 dockerd[2022]: time="2025-05-10T09:58:16.926618636Z" level=info msg="Loading containers: start." May 10 09:58:16.942612 systemd[1]: var-lib-docker-overlay2-4260372fc166e144c7ba02a1f2e1c9e844e70479823d28a84c30d22f4a4bf1b2-merged.mount: Deactivated successfully. May 10 09:58:17.373613 dockerd[2022]: time="2025-05-10T09:58:17.373467635Z" level=info msg="Removing stale sandbox f7115eb59a7b1f7ee23d90c4a7b9dd8ad62318cb2e35afb037e6603d4a54b92d (e596217c411a808da05bb1e85631b0d85ab9cc50607bc1d1f6795c87345b7bda)" May 10 09:58:17.378612 systemd-networkd[1372]: veth853046e: Link DOWN May 10 09:58:17.378623 systemd-networkd[1372]: veth853046e: Lost carrier May 10 09:58:17.379805 dockerd[2022]: time="2025-05-10T09:58:17.379774360Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 10 09:58:17.379863 dockerd[2022]: time="2025-05-10T09:58:17.379822176Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint cc13a288089aed342cf80c37e935ad405a04df2aceaf889684ed40bcdc8515c7 613f3638839d57d21354e237507f7df2afeff0d1dbe192e37e10cd152298c5ff], retrying...." May 10 09:58:17.381156 kernel: docker0: port 1(veth853046e) entered disabled state May 10 09:58:17.381234 kernel: veth853046e (unregistering): left allmulticast mode May 10 09:58:17.381267 kernel: veth853046e (unregistering): left promiscuous mode May 10 09:58:17.382009 kernel: docker0: port 1(veth853046e) entered disabled state May 10 09:58:17.389024 systemd-networkd[1372]: docker0: Lost carrier May 10 09:58:17.570641 dockerd[2022]: time="2025-05-10T09:58:17.570582561Z" level=warning msg="error locating sandbox id f7115eb59a7b1f7ee23d90c4a7b9dd8ad62318cb2e35afb037e6603d4a54b92d: sandbox f7115eb59a7b1f7ee23d90c4a7b9dd8ad62318cb2e35afb037e6603d4a54b92d not found" May 10 09:58:17.570761 dockerd[2022]: time="2025-05-10T09:58:17.570735096Z" level=info msg="Loading containers: done." May 10 09:58:17.585437 dockerd[2022]: time="2025-05-10T09:58:17.585375223Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 May 10 09:58:17.585689 dockerd[2022]: time="2025-05-10T09:58:17.585473635Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 10 09:58:17.585689 dockerd[2022]: time="2025-05-10T09:58:17.585530957Z" level=info msg="Initializing buildkit" May 10 09:58:17.601969 dockerd[2022]: time="2025-05-10T09:58:17.601946485Z" level=info msg="Completed buildkit initialization" May 10 09:58:17.608070 dockerd[2022]: time="2025-05-10T09:58:17.607990121Z" level=info msg="Daemon has completed initialization" May 10 09:58:17.608184 dockerd[2022]: time="2025-05-10T09:58:17.608137613Z" level=info msg="API listen on /run/docker.sock" May 10 09:58:17.608272 systemd[1]: Started docker.service - Docker Application Container Engine. May 10 09:58:17.889691 systemd[1]: run-docker-netns-f7115eb59a7b.mount: Deactivated successfully. May 10 09:58:21.189685 systemd[1]: Started sshd@14-10.0.0.73:22-10.0.0.1:36236.service - OpenSSH per-connection server daemon (10.0.0.1:36236). May 10 09:58:21.242955 sshd[2243]: Accepted publickey for core from 10.0.0.1 port 36236 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:21.244681 sshd-session[2243]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:21.249388 systemd-logind[1414]: New session 15 of user core. May 10 09:58:21.259425 systemd[1]: Started session-15.scope - Session 15 of User core. May 10 09:58:21.316266 sshd[2245]: Connection closed by 10.0.0.1 port 36236 May 10 09:58:21.316645 sshd-session[2243]: pam_unix(sshd:session): session closed for user core May 10 09:58:21.332900 systemd[1]: sshd@14-10.0.0.73:22-10.0.0.1:36236.service: Deactivated successfully. May 10 09:58:21.335196 systemd[1]: session-15.scope: Deactivated successfully. May 10 09:58:21.336909 systemd-logind[1414]: Session 15 logged out. Waiting for processes to exit. May 10 09:58:21.338477 systemd[1]: Started sshd@15-10.0.0.73:22-10.0.0.1:36248.service - OpenSSH per-connection server daemon (10.0.0.1:36248). May 10 09:58:21.339547 systemd-logind[1414]: Removed session 15. May 10 09:58:21.395823 sshd[2250]: Accepted publickey for core from 10.0.0.1 port 36248 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:21.397358 sshd-session[2250]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:21.401675 systemd-logind[1414]: New session 16 of user core. May 10 09:58:21.412429 systemd[1]: Started session-16.scope - Session 16 of User core. May 10 09:58:21.469615 sshd[2253]: Connection closed by 10.0.0.1 port 36248 May 10 09:58:21.469811 sshd-session[2250]: pam_unix(sshd:session): session closed for user core May 10 09:58:21.491760 systemd[1]: sshd@15-10.0.0.73:22-10.0.0.1:36248.service: Deactivated successfully. May 10 09:58:21.493845 systemd[1]: session-16.scope: Deactivated successfully. May 10 09:58:21.495997 systemd-logind[1414]: Session 16 logged out. Waiting for processes to exit. May 10 09:58:21.497455 systemd[1]: Started sshd@16-10.0.0.73:22-10.0.0.1:36250.service - OpenSSH per-connection server daemon (10.0.0.1:36250). May 10 09:58:21.498934 systemd-logind[1414]: Removed session 16. May 10 09:58:21.556156 sshd[2258]: Accepted publickey for core from 10.0.0.1 port 36250 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:21.557873 sshd-session[2258]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:21.562566 systemd-logind[1414]: New session 17 of user core. May 10 09:58:21.572496 systemd[1]: Started session-17.scope - Session 17 of User core. May 10 09:58:21.635107 sshd[2261]: Connection closed by 10.0.0.1 port 36250 May 10 09:58:21.635434 sshd-session[2258]: pam_unix(sshd:session): session closed for user core May 10 09:58:21.644114 systemd[1]: sshd@16-10.0.0.73:22-10.0.0.1:36250.service: Deactivated successfully. May 10 09:58:21.645921 systemd[1]: session-17.scope: Deactivated successfully. May 10 09:58:21.647463 systemd-logind[1414]: Session 17 logged out. Waiting for processes to exit. May 10 09:58:21.648779 systemd[1]: Started sshd@17-10.0.0.73:22-10.0.0.1:36258.service - OpenSSH per-connection server daemon (10.0.0.1:36258). May 10 09:58:21.649910 systemd-logind[1414]: Removed session 17. May 10 09:58:21.707490 sshd[2273]: Accepted publickey for core from 10.0.0.1 port 36258 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:21.709538 sshd-session[2273]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:21.714465 systemd-logind[1414]: New session 18 of user core. May 10 09:58:21.724404 systemd[1]: Started session-18.scope - Session 18 of User core. May 10 09:58:21.801622 systemd[1]: var-lib-docker-overlay2-15fe6701d7cc7c5b53d5afbce19e2fa734c0ed98a8764dd80602c590e49494e4\x2dinit-merged.mount: Deactivated successfully. May 10 09:58:21.846216 containerd[1973]: time="2025-05-10T09:58:21.846171933Z" level=info msg="connecting to shim 1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d" address="unix:///run/containerd/s/0e0548363fa6fc64bacf1673384c58d3e59cab35ea8aa748e7ecdba04a12c85c" namespace=moby protocol=ttrpc version=3 May 10 09:58:21.872446 systemd[1]: Started docker-1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d.scope - libcontainer container 1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d. May 10 09:58:21.884941 systemd-resolved[1306]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 10 09:58:21.909653 kernel: docker0: port 1(veth7901519) entered blocking state May 10 09:58:21.909748 kernel: docker0: port 1(veth7901519) entered disabled state May 10 09:58:21.909768 kernel: veth7901519: entered allmulticast mode May 10 09:58:21.911342 kernel: veth7901519: entered promiscuous mode May 10 09:58:21.911449 systemd-networkd[1372]: veth7901519: Link UP May 10 09:58:21.919319 kernel: eth0: renamed from vetha8a82a8 May 10 09:58:21.929555 kernel: docker0: port 1(veth7901519) entered blocking state May 10 09:58:21.929654 kernel: docker0: port 1(veth7901519) entered forwarding state May 10 09:58:21.929753 systemd-networkd[1372]: veth7901519: Gained carrier May 10 09:58:21.929994 systemd-networkd[1372]: docker0: Gained carrier May 10 09:58:21.979231 sshd[2276]: Connection closed by 10.0.0.1 port 36258 May 10 09:58:21.979523 sshd-session[2273]: pam_unix(sshd:session): session closed for user core May 10 09:58:21.992168 systemd[1]: sshd@17-10.0.0.73:22-10.0.0.1:36258.service: Deactivated successfully. May 10 09:58:21.994068 systemd[1]: session-18.scope: Deactivated successfully. May 10 09:58:21.994951 systemd-logind[1414]: Session 18 logged out. Waiting for processes to exit. May 10 09:58:21.997027 systemd[1]: Started sshd@18-10.0.0.73:22-10.0.0.1:36272.service - OpenSSH per-connection server daemon (10.0.0.1:36272). May 10 09:58:21.998173 systemd-logind[1414]: Removed session 18. May 10 09:58:22.051569 sshd[2345]: Accepted publickey for core from 10.0.0.1 port 36272 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:22.052889 sshd-session[2345]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:22.057873 systemd-logind[1414]: New session 19 of user core. May 10 09:58:22.072455 systemd[1]: Started session-19.scope - Session 19 of User core. May 10 09:58:22.131735 sshd[2348]: Connection closed by 10.0.0.1 port 36272 May 10 09:58:22.132066 sshd-session[2345]: pam_unix(sshd:session): session closed for user core May 10 09:58:22.140910 systemd[1]: sshd@18-10.0.0.73:22-10.0.0.1:36272.service: Deactivated successfully. May 10 09:58:22.142770 systemd[1]: session-19.scope: Deactivated successfully. May 10 09:58:22.143594 systemd-logind[1414]: Session 19 logged out. Waiting for processes to exit. May 10 09:58:22.145517 systemd[1]: Started sshd@19-10.0.0.73:22-10.0.0.1:36282.service - OpenSSH per-connection server daemon (10.0.0.1:36282). May 10 09:58:22.146679 systemd-logind[1414]: Removed session 19. May 10 09:58:22.196311 sshd[2353]: Accepted publickey for core from 10.0.0.1 port 36282 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:22.197699 sshd-session[2353]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:22.202340 systemd-logind[1414]: New session 20 of user core. May 10 09:58:22.220420 systemd[1]: Started session-20.scope - Session 20 of User core. May 10 09:58:22.272847 sudo[2357]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1973 May 10 09:58:22.273232 sudo[2357]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 10 09:58:22.277074 sudo[2357]: pam_unix(sudo:session): session closed for user root May 10 09:58:22.278236 sshd[2356]: Connection closed by 10.0.0.1 port 36282 May 10 09:58:22.278615 sshd-session[2353]: pam_unix(sshd:session): session closed for user core May 10 09:58:22.283073 dockerd[2022]: time="2025-05-10T09:58:22.283014549Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 10 09:58:22.283073 dockerd[2022]: time="2025-05-10T09:58:22.283068204Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 10 09:58:22.284308 dockerd[2022]: time="2025-05-10T09:58:22.283036097Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 10 09:58:22.284308 dockerd[2022]: time="2025-05-10T09:58:22.283208234Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 10 09:58:22.287977 systemd[1]: containerd.service: Deactivated successfully. May 10 09:58:22.288135 systemd[1]: containerd.service: Unit process 2293 (containerd-shim) remains running after unit stopped. May 10 09:58:22.288524 systemd[1]: containerd.service: Consumed 231ms CPU time, 141.7M memory peak. May 10 09:58:22.289151 systemd[1]: sshd@19-10.0.0.73:22-10.0.0.1:36282.service: Deactivated successfully. May 10 09:58:22.291407 systemd[1]: session-20.scope: Deactivated successfully. May 10 09:58:22.292189 systemd-logind[1414]: Session 20 logged out. Waiting for processes to exit. May 10 09:58:22.296076 systemd[1]: Started sshd@20-10.0.0.73:22-10.0.0.1:36298.service - OpenSSH per-connection server daemon (10.0.0.1:36298). May 10 09:58:22.296823 systemd-logind[1414]: Removed session 20. May 10 09:58:22.351466 sshd[2363]: Accepted publickey for core from 10.0.0.1 port 36298 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:22.352824 sshd-session[2363]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:22.358507 systemd-logind[1414]: New session 21 of user core. May 10 09:58:22.368461 systemd[1]: Started session-21.scope - Session 21 of User core. May 10 09:58:22.426351 sshd[2366]: Connection closed by 10.0.0.1 port 36298 May 10 09:58:22.426698 sshd-session[2363]: pam_unix(sshd:session): session closed for user core May 10 09:58:22.431737 systemd[1]: sshd@20-10.0.0.73:22-10.0.0.1:36298.service: Deactivated successfully. May 10 09:58:22.433861 systemd[1]: session-21.scope: Deactivated successfully. May 10 09:58:22.434685 systemd-logind[1414]: Session 21 logged out. Waiting for processes to exit. May 10 09:58:22.435595 systemd-logind[1414]: Removed session 21. May 10 09:58:23.828779 systemd-networkd[1372]: veth7901519: Gained IPv6LL May 10 09:58:27.430457 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. May 10 09:58:27.430852 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 10 09:58:27.431061 dockerd[2022]: time="2025-05-10T09:58:27.430978298Z" level=info msg="Processing signal 'terminated'" May 10 09:58:28.444603 systemd[1]: Started sshd@21-10.0.0.73:22-10.0.0.1:33916.service - OpenSSH per-connection server daemon (10.0.0.1:33916). May 10 09:58:28.500176 sshd[2372]: Accepted publickey for core from 10.0.0.1 port 33916 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:28.501945 sshd-session[2372]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:28.507183 systemd-logind[1414]: New session 22 of user core. May 10 09:58:28.522483 systemd[1]: Started session-22.scope - Session 22 of User core. May 10 09:58:28.579696 sshd[2374]: Connection closed by 10.0.0.1 port 33916 May 10 09:58:28.580026 sshd-session[2372]: pam_unix(sshd:session): session closed for user core May 10 09:58:28.584427 systemd[1]: sshd@21-10.0.0.73:22-10.0.0.1:33916.service: Deactivated successfully. May 10 09:58:28.586524 systemd[1]: session-22.scope: Deactivated successfully. May 10 09:58:28.587345 systemd-logind[1414]: Session 22 logged out. Waiting for processes to exit. May 10 09:58:28.588317 systemd-logind[1414]: Removed session 22. May 10 09:58:29.432126 dockerd[2022]: time="2025-05-10T09:58:29.432004979Z" level=error msg="Error sending stop (signal 15) to container" container=1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d error="Cannot kill container 1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" May 10 09:58:29.432126 dockerd[2022]: time="2025-05-10T09:58:29.432104973Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d May 10 09:58:30.687573 update_engine[1417]: I20250510 09:58:30.687470 1417 update_attempter.cc:509] Updating boot flags... May 10 09:58:30.718330 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2386) May 10 09:58:30.767352 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2385) May 10 09:58:30.787367 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2385) May 10 09:58:34.595248 systemd[1]: Started sshd@22-10.0.0.73:22-10.0.0.1:33928.service - OpenSSH per-connection server daemon (10.0.0.1:33928). May 10 09:58:34.652952 sshd[2395]: Accepted publickey for core from 10.0.0.1 port 33928 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:34.654776 sshd-session[2395]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:34.659795 systemd-logind[1414]: New session 23 of user core. May 10 09:58:34.673487 systemd[1]: Started session-23.scope - Session 23 of User core. May 10 09:58:34.731457 sshd[2397]: Connection closed by 10.0.0.1 port 33928 May 10 09:58:34.731781 sshd-session[2395]: pam_unix(sshd:session): session closed for user core May 10 09:58:34.736591 systemd[1]: sshd@22-10.0.0.73:22-10.0.0.1:33928.service: Deactivated successfully. May 10 09:58:34.738626 systemd[1]: session-23.scope: Deactivated successfully. May 10 09:58:34.739627 systemd-logind[1414]: Session 23 logged out. Waiting for processes to exit. May 10 09:58:34.740761 systemd-logind[1414]: Removed session 23. May 10 09:58:39.432709 dockerd[2022]: time="2025-05-10T09:58:39.432580088Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d error="context deadline exceeded" May 10 09:58:39.433795 systemd[1]: docker-1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d.scope: Deactivated successfully. May 10 09:58:40.750649 systemd[1]: Started sshd@23-10.0.0.73:22-10.0.0.1:50226.service - OpenSSH per-connection server daemon (10.0.0.1:50226). May 10 09:58:40.805674 sshd[2404]: Accepted publickey for core from 10.0.0.1 port 50226 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:40.807438 sshd-session[2404]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:40.812027 systemd-logind[1414]: New session 24 of user core. May 10 09:58:40.828454 systemd[1]: Started session-24.scope - Session 24 of User core. May 10 09:58:40.885234 sshd[2406]: Connection closed by 10.0.0.1 port 50226 May 10 09:58:40.885522 sshd-session[2404]: pam_unix(sshd:session): session closed for user core May 10 09:58:40.889173 systemd[1]: sshd@23-10.0.0.73:22-10.0.0.1:50226.service: Deactivated successfully. May 10 09:58:40.890923 systemd[1]: session-24.scope: Deactivated successfully. May 10 09:58:40.891749 systemd-logind[1414]: Session 24 logged out. Waiting for processes to exit. May 10 09:58:40.892726 systemd-logind[1414]: Removed session 24. May 10 09:58:42.432243 dockerd[2022]: time="2025-05-10T09:58:42.432120284Z" level=error msg="Force shutdown daemon" May 10 09:58:42.432898 dockerd[2022]: time="2025-05-10T09:58:42.432346839Z" level=info msg="Daemon shutdown complete" May 10 09:58:42.439803 systemd[1]: docker.service: Deactivated successfully. May 10 09:58:42.440235 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 10 09:58:42.440753 systemd[1]: docker.socket: Deactivated successfully. May 10 09:58:42.441104 systemd[1]: Closed docker.socket - Docker Socket for the API. May 10 09:58:42.441145 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 10 09:58:42.443174 systemd[1]: Starting docker.socket - Docker Socket for the API... May 10 09:58:42.443468 systemd[1]: containerd.service: Found left-over process 2293 (containerd-shim) in control group while starting unit. Ignoring. May 10 09:58:42.443476 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 10 09:58:42.452848 systemd[1]: Starting containerd.service - containerd container runtime... May 10 09:58:42.454133 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 10 09:58:42.488605 systemd[1]: containerd.service: Found left-over process 2293 (containerd-shim) in control group while starting unit. Ignoring. May 10 09:58:42.488617 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 10 09:58:42.493646 (ntainerd)[2417]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 10 09:58:42.510313 containerd[2417]: time="2025-05-10T09:58:42Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 10 09:58:42.511128 containerd[2417]: time="2025-05-10T09:58:42.510993821Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 10 09:58:42.520891 containerd[2417]: time="2025-05-10T09:58:42.520824989Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.771µs" May 10 09:58:42.520891 containerd[2417]: time="2025-05-10T09:58:42.520872734Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 10 09:58:42.520891 containerd[2417]: time="2025-05-10T09:58:42.520895844Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 10 09:58:42.521086 containerd[2417]: time="2025-05-10T09:58:42.520931231Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 10 09:58:42.521086 containerd[2417]: time="2025-05-10T09:58:42.520943939Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 10 09:58:42.521189 containerd[2417]: time="2025-05-10T09:58:42.521168000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 10 09:58:42.521225 containerd[2417]: time="2025-05-10T09:58:42.521199229Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 10 09:58:42.521225 containerd[2417]: time="2025-05-10T09:58:42.521210453Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 10 09:58:42.521527 containerd[2417]: time="2025-05-10T09:58:42.521495126Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 10 09:58:42.521527 containerd[2417]: time="2025-05-10T09:58:42.521511422Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 10 09:58:42.521527 containerd[2417]: time="2025-05-10T09:58:42.521521514Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 10 09:58:42.521527 containerd[2417]: time="2025-05-10T09:58:42.521529972Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 10 09:58:42.521660 containerd[2417]: time="2025-05-10T09:58:42.521552903Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 10 09:58:42.521660 containerd[2417]: time="2025-05-10T09:58:42.521636175Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 10 09:58:42.521721 containerd[2417]: time="2025-05-10T09:58:42.521660237Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 10 09:58:42.521721 containerd[2417]: time="2025-05-10T09:58:42.521670059Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 10 09:58:42.521721 containerd[2417]: time="2025-05-10T09:58:42.521703292Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 10 09:58:42.521934 containerd[2417]: time="2025-05-10T09:58:42.521888397Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 10 09:58:42.521934 containerd[2417]: time="2025-05-10T09:58:42.521910996Z" level=info msg="metadata content store policy set" policy=shared May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522051313Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522074684Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522086470Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522097375Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522108629Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522119804Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522130176Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522140178Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 10 09:58:42.522143 containerd[2417]: time="2025-05-10T09:58:42.522149278Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 10 09:58:42.522463 containerd[2417]: time="2025-05-10T09:58:42.522158819Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 10 09:58:42.522463 containerd[2417]: time="2025-05-10T09:58:42.522168069Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 10 09:58:42.522463 containerd[2417]: time="2025-05-10T09:58:42.522178722Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 10 09:58:42.522463 containerd[2417]: time="2025-05-10T09:58:42.522386657Z" level=info msg="connecting to shim 1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d" address="unix:///run/containerd/s/0e0548363fa6fc64bacf1673384c58d3e59cab35ea8aa748e7ecdba04a12c85c" namespace=moby protocol=ttrpc version=3 May 10 09:58:42.532822 containerd[2417]: time="2025-05-10T09:58:42.532785999Z" level=info msg="cleaning leaked shim process" id=1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d namespace=moby May 10 09:58:42.546311 containerd[2417]: time="2025-05-10T09:58:42.546082623Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 10 09:58:42.546485 containerd[2417]: time="2025-05-10T09:58:42.546361844Z" level=info msg="shim disconnected" id=1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d namespace=moby May 10 09:58:42.546485 containerd[2417]: time="2025-05-10T09:58:42.546393583Z" level=warning msg="cleaning up after shim disconnected" id=1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d namespace=moby May 10 09:58:42.546485 containerd[2417]: time="2025-05-10T09:58:42.546401852Z" level=info msg="cleaning up dead shim" namespace=moby May 10 09:58:42.560826 containerd[2417]: time="2025-05-10T09:58:42.560748985Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560884180Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560911610Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560933028Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560948160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560962542Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560986815Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.560998671Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.561010517Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.561022433Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 10 09:58:42.561033 containerd[2417]: time="2025-05-10T09:58:42.561033397Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 10 09:58:42.561360 containerd[2417]: time="2025-05-10T09:58:42.561052749Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 10 09:58:42.561360 containerd[2417]: time="2025-05-10T09:58:42.561145582Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 10 09:58:42.561360 containerd[2417]: time="2025-05-10T09:58:42.561168603Z" level=info msg="Start snapshots syncer" May 10 09:58:42.561360 containerd[2417]: time="2025-05-10T09:58:42.561206295Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 10 09:58:42.561509 containerd[2417]: time="2025-05-10T09:58:42.561455882Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 10 09:58:42.561644 containerd[2417]: time="2025-05-10T09:58:42.561514179Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 10 09:58:42.561644 containerd[2417]: time="2025-05-10T09:58:42.561588051Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 10 09:58:42.561644 containerd[2417]: time="2025-05-10T09:58:42.561626977Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 10 09:58:42.561644 containerd[2417]: time="2025-05-10T09:58:42.561645166Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561657533Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561668898Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561680995Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561692279Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561704877Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561738681Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561755688Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561769618Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561809566Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561823366Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561831905Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561843139Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561851237Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 10 09:58:42.561896 containerd[2417]: time="2025-05-10T09:58:42.561863524Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 10 09:58:42.562318 containerd[2417]: time="2025-05-10T09:58:42.561874448Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 10 09:58:42.562318 containerd[2417]: time="2025-05-10T09:58:42.561892507Z" level=info msg="runtime interface created" May 10 09:58:42.562318 containerd[2417]: time="2025-05-10T09:58:42.561898611Z" level=info msg="created NRI interface" May 10 09:58:42.562318 containerd[2417]: time="2025-05-10T09:58:42.561908853Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 10 09:58:42.562318 containerd[2417]: time="2025-05-10T09:58:42.561926362Z" level=info msg="Connect containerd service" May 10 09:58:42.562318 containerd[2417]: time="2025-05-10T09:58:42.561962611Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 10 09:58:42.562574 containerd[2417]: time="2025-05-10T09:58:42.562534864Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" May 10 09:58:42.577891 containerd[2417]: time="2025-05-10T09:58:42.577822565Z" level=info msg="Start subscribing containerd event" May 10 09:58:42.578072 containerd[2417]: time="2025-05-10T09:58:42.577917923Z" level=info msg="Start recovering state" May 10 09:58:42.578072 containerd[2417]: time="2025-05-10T09:58:42.578033286Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 10 09:58:42.578134 containerd[2417]: time="2025-05-10T09:58:42.578044320Z" level=info msg="Start event monitor" May 10 09:58:42.578134 containerd[2417]: time="2025-05-10T09:58:42.578104582Z" level=info msg="Start cni network conf syncer for default" May 10 09:58:42.578134 containerd[2417]: time="2025-05-10T09:58:42.578117340Z" level=info msg="Start streaming server" May 10 09:58:42.578134 containerd[2417]: time="2025-05-10T09:58:42.578122752Z" level=info msg=serving... address=/run/containerd/containerd.sock May 10 09:58:42.578264 containerd[2417]: time="2025-05-10T09:58:42.578131671Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 10 09:58:42.578264 containerd[2417]: time="2025-05-10T09:58:42.578175607Z" level=info msg="runtime interface starting up..." May 10 09:58:42.578264 containerd[2417]: time="2025-05-10T09:58:42.578186362Z" level=info msg="starting plugins..." May 10 09:58:42.578264 containerd[2417]: time="2025-05-10T09:58:42.578201965Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 10 09:58:42.578486 systemd[1]: Started containerd.service - containerd container runtime. May 10 09:58:42.579048 containerd[2417]: time="2025-05-10T09:58:42.579005264Z" level=info msg="containerd successfully booted in 0.068869s" May 10 09:58:42.580599 systemd[1]: Starting docker.service - Docker Application Container Engine... May 10 09:58:42.594745 (dockerd)[2464]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU May 10 09:58:42.635843 dockerd[2464]: time="2025-05-10T09:58:42.635760639Z" level=info msg="Starting up" May 10 09:58:42.636793 dockerd[2464]: time="2025-05-10T09:58:42.636768905Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 10 09:58:42.675331 dockerd[2464]: time="2025-05-10T09:58:42.675257970Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 10 09:58:42.699695 dockerd[2464]: time="2025-05-10T09:58:42.699527952Z" level=info msg="Loading containers: start." May 10 09:58:42.718659 systemd[1]: var-lib-docker-overlay2-15fe6701d7cc7c5b53d5afbce19e2fa734c0ed98a8764dd80602c590e49494e4-merged.mount: Deactivated successfully. May 10 09:58:43.158451 dockerd[2464]: time="2025-05-10T09:58:43.158323217Z" level=info msg="Removing stale sandbox 398ba96b0840d4399b9d658c4a899a362325ce0ec0d5203a41e33e3eaa148cf9 (1fdc9fd94160b282f249de1f8412f98e2b7328f6673b70f1f69617a0e536286d)" May 10 09:58:43.163610 systemd-networkd[1372]: veth7901519: Link DOWN May 10 09:58:43.163618 systemd-networkd[1372]: veth7901519: Lost carrier May 10 09:58:43.163987 dockerd[2464]: time="2025-05-10T09:58:43.163714591Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" May 10 09:58:43.163987 dockerd[2464]: time="2025-05-10T09:58:43.163757104Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 69563f86804e19eb92587c6143187c8aadb7cdae4b4cd826e25f9cfee21b0a3a 13b0b4153f2ab17ef5e49d8bd3aec3eec2965660805c0d60356744ba793bc470], retrying...." May 10 09:58:43.166050 kernel: docker0: port 1(veth7901519) entered disabled state May 10 09:58:43.166108 kernel: veth7901519 (unregistering): left allmulticast mode May 10 09:58:43.166139 kernel: veth7901519 (unregistering): left promiscuous mode May 10 09:58:43.167743 kernel: docker0: port 1(veth7901519) entered disabled state May 10 09:58:43.174026 systemd-networkd[1372]: docker0: Lost carrier May 10 09:58:43.369450 dockerd[2464]: time="2025-05-10T09:58:43.369384433Z" level=warning msg="error locating sandbox id 398ba96b0840d4399b9d658c4a899a362325ce0ec0d5203a41e33e3eaa148cf9: sandbox 398ba96b0840d4399b9d658c4a899a362325ce0ec0d5203a41e33e3eaa148cf9 not found" May 10 09:58:43.369450 dockerd[2464]: time="2025-05-10T09:58:43.369424690Z" level=warning msg="error locating sandbox id f7115eb59a7b1f7ee23d90c4a7b9dd8ad62318cb2e35afb037e6603d4a54b92d: sandbox f7115eb59a7b1f7ee23d90c4a7b9dd8ad62318cb2e35afb037e6603d4a54b92d not found" May 10 09:58:43.369656 dockerd[2464]: time="2025-05-10T09:58:43.369593147Z" level=info msg="Loading containers: done." May 10 09:58:43.383862 dockerd[2464]: time="2025-05-10T09:58:43.383806321Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 May 10 09:58:43.384088 dockerd[2464]: time="2025-05-10T09:58:43.383895355Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 10 09:58:43.384088 dockerd[2464]: time="2025-05-10T09:58:43.383951948Z" level=info msg="Initializing buildkit" May 10 09:58:43.401723 dockerd[2464]: time="2025-05-10T09:58:43.401672246Z" level=info msg="Completed buildkit initialization" May 10 09:58:43.407445 dockerd[2464]: time="2025-05-10T09:58:43.407417801Z" level=info msg="Daemon has completed initialization" May 10 09:58:43.407573 dockerd[2464]: time="2025-05-10T09:58:43.407495861Z" level=info msg="API listen on /run/docker.sock" May 10 09:58:43.407713 systemd[1]: Started docker.service - Docker Application Container Engine. May 10 09:58:43.662266 systemd[1]: run-docker-netns-398ba96b0840.mount: Deactivated successfully. May 10 09:58:46.904323 systemd[1]: Started sshd@24-10.0.0.73:22-10.0.0.1:40836.service - OpenSSH per-connection server daemon (10.0.0.1:40836). May 10 09:58:46.964527 sshd[2685]: Accepted publickey for core from 10.0.0.1 port 40836 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:46.966442 sshd-session[2685]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:46.971720 systemd-logind[1414]: New session 25 of user core. May 10 09:58:46.985401 systemd[1]: Started session-25.scope - Session 25 of User core. May 10 09:58:47.042960 sshd[2687]: Connection closed by 10.0.0.1 port 40836 May 10 09:58:47.043399 sshd-session[2685]: pam_unix(sshd:session): session closed for user core May 10 09:58:47.059023 systemd[1]: sshd@24-10.0.0.73:22-10.0.0.1:40836.service: Deactivated successfully. May 10 09:58:47.061361 systemd[1]: session-25.scope: Deactivated successfully. May 10 09:58:47.063600 systemd-logind[1414]: Session 25 logged out. Waiting for processes to exit. May 10 09:58:47.065238 systemd[1]: Started sshd@25-10.0.0.73:22-10.0.0.1:40840.service - OpenSSH per-connection server daemon (10.0.0.1:40840). May 10 09:58:47.066243 systemd-logind[1414]: Removed session 25. May 10 09:58:47.120988 sshd[2692]: Accepted publickey for core from 10.0.0.1 port 40840 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:47.122615 sshd-session[2692]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:47.127386 systemd-logind[1414]: New session 26 of user core. May 10 09:58:47.140424 systemd[1]: Started session-26.scope - Session 26 of User core. May 10 09:58:47.198706 sshd[2695]: Connection closed by 10.0.0.1 port 40840 May 10 09:58:47.199102 sshd-session[2692]: pam_unix(sshd:session): session closed for user core May 10 09:58:47.212425 systemd[1]: sshd@25-10.0.0.73:22-10.0.0.1:40840.service: Deactivated successfully. May 10 09:58:47.214390 systemd[1]: session-26.scope: Deactivated successfully. May 10 09:58:47.216323 systemd-logind[1414]: Session 26 logged out. Waiting for processes to exit. May 10 09:58:47.217758 systemd[1]: Started sshd@26-10.0.0.73:22-10.0.0.1:40842.service - OpenSSH per-connection server daemon (10.0.0.1:40842). May 10 09:58:47.218719 systemd-logind[1414]: Removed session 26. May 10 09:58:47.281763 sshd[2700]: Accepted publickey for core from 10.0.0.1 port 40842 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:47.283634 sshd-session[2700]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:47.289238 systemd-logind[1414]: New session 27 of user core. May 10 09:58:47.296516 systemd[1]: Started session-27.scope - Session 27 of User core. May 10 09:58:47.365830 sshd[2703]: Connection closed by 10.0.0.1 port 40842 May 10 09:58:47.366367 sshd-session[2700]: pam_unix(sshd:session): session closed for user core May 10 09:58:47.380607 systemd[1]: sshd@26-10.0.0.73:22-10.0.0.1:40842.service: Deactivated successfully. May 10 09:58:47.383113 systemd[1]: session-27.scope: Deactivated successfully. May 10 09:58:47.385214 systemd-logind[1414]: Session 27 logged out. Waiting for processes to exit. May 10 09:58:47.386782 systemd[1]: Started sshd@27-10.0.0.73:22-10.0.0.1:40848.service - OpenSSH per-connection server daemon (10.0.0.1:40848). May 10 09:58:47.387899 systemd-logind[1414]: Removed session 27. May 10 09:58:47.443959 sshd[2715]: Accepted publickey for core from 10.0.0.1 port 40848 ssh2: RSA SHA256:ZOMyKPM9vG3Y5Dtmxr1HvCP8ZBfjY8jTU8Db0jmo1gs May 10 09:58:47.445588 sshd-session[2715]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 10 09:58:47.451271 systemd-logind[1414]: New session 28 of user core. May 10 09:58:47.462625 systemd[1]: Started session-28.scope - Session 28 of User core. May 10 09:58:47.648206 systemd[1]: var-lib-docker-overlay2-ea2a272832a08868e734464283a1a661e0135e457c56f0b7b2c460ba9712d923\x2dinit-merged.mount: Deactivated successfully. May 10 09:58:47.749478 containerd[2417]: time="2025-05-10T09:58:47.749297291Z" level=info msg="connecting to shim 6c00748b3edc40567bc0f38754f38514f5e204c51e6be37327b69f55a92be6a8" address="unix:///run/containerd/s/d1a4eae9c8a87105de7102b11e7c9498b50fa5e418add8f9b1b4f81e17b388e6" namespace=moby protocol=ttrpc version=3 May 10 09:58:47.780479 systemd[1]: Started docker-6c00748b3edc40567bc0f38754f38514f5e204c51e6be37327b69f55a92be6a8.scope - libcontainer container 6c00748b3edc40567bc0f38754f38514f5e204c51e6be37327b69f55a92be6a8. May 10 09:58:47.798353 systemd-resolved[1306]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 10 09:58:47.823472 kernel: docker0: port 1(vethec8db8f) entered blocking state May 10 09:58:47.823599 kernel: docker0: port 1(vethec8db8f) entered disabled state May 10 09:58:47.823634 kernel: vethec8db8f: entered allmulticast mode May 10 09:58:47.825677 kernel: vethec8db8f: entered promiscuous mode May 10 09:58:47.825379 systemd-networkd[1372]: vethec8db8f: Link UP May 10 09:58:47.833389 kernel: eth0: renamed from vethdffabb5 May 10 09:58:47.843998 kernel: docker0: port 1(vethec8db8f) entered blocking state May 10 09:58:47.844075 kernel: docker0: port 1(vethec8db8f) entered forwarding state May 10 09:58:47.844153 systemd-networkd[1372]: vethec8db8f: Gained carrier May 10 09:58:47.844446 systemd-networkd[1372]: docker0: Gained carrier May 10 09:58:47.886077 sshd[2718]: Connection closed by 10.0.0.1 port 40848 May 10 09:58:47.885941 sshd-session[2715]: pam_unix(sshd:session): session closed for user core May 10 09:58:47.890879 systemd-logind[1414]: Session 28 logged out. Waiting for processes to exit. May 10 09:58:47.891310 systemd[1]: sshd@27-10.0.0.73:22-10.0.0.1:40848.service: Deactivated successfully. May 10 09:58:47.893594 systemd[1]: session-28.scope: Deactivated successfully. May 10 09:58:47.894737 systemd-logind[1414]: Removed session 28.