May 9 00:06:38.899300 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT_DYNAMIC Thu May 8 22:21:52 -00 2025 May 9 00:06:38.899320 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=8e6c4805303143bfaf51e786bee05d9a5466809f675df313b1f69aaa84c2d4ce May 9 00:06:38.899332 kernel: BIOS-provided physical RAM map: May 9 00:06:38.899338 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable May 9 00:06:38.899344 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved May 9 00:06:38.899351 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved May 9 00:06:38.899366 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable May 9 00:06:38.899372 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved May 9 00:06:38.899378 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved May 9 00:06:38.899387 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved May 9 00:06:38.899393 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved May 9 00:06:38.899400 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved May 9 00:06:38.899406 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved May 9 00:06:38.899412 kernel: NX (Execute Disable) protection: active May 9 00:06:38.899420 kernel: APIC: Static calls initialized May 9 00:06:38.899429 kernel: SMBIOS 2.8 present. May 9 00:06:38.899435 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 May 9 00:06:38.899442 kernel: Hypervisor detected: KVM May 9 00:06:38.899449 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 May 9 00:06:38.899456 kernel: kvm-clock: using sched offset of 2304364529 cycles May 9 00:06:38.899463 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns May 9 00:06:38.899470 kernel: tsc: Detected 2794.748 MHz processor May 9 00:06:38.899477 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 9 00:06:38.899484 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 9 00:06:38.899491 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 May 9 00:06:38.899500 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs May 9 00:06:38.899507 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 9 00:06:38.899514 kernel: Using GB pages for direct mapping May 9 00:06:38.899521 kernel: ACPI: Early table checksum verification disabled May 9 00:06:38.899528 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) May 9 00:06:38.899535 kernel: ACPI: RSDT 0x000000009CFE2408 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899542 kernel: ACPI: FACP 0x000000009CFE21E8 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899549 kernel: ACPI: DSDT 0x000000009CFE0040 0021A8 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899558 kernel: ACPI: FACS 0x000000009CFE0000 000040 May 9 00:06:38.899565 kernel: ACPI: APIC 0x000000009CFE22DC 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899572 kernel: ACPI: HPET 0x000000009CFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899579 kernel: ACPI: MCFG 0x000000009CFE23A4 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899585 kernel: ACPI: WAET 0x000000009CFE23E0 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) May 9 00:06:38.899603 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21e8-0x9cfe22db] May 9 00:06:38.899610 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21e7] May 9 00:06:38.899621 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] May 9 00:06:38.899630 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22dc-0x9cfe236b] May 9 00:06:38.899638 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe236c-0x9cfe23a3] May 9 00:06:38.899645 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23a4-0x9cfe23df] May 9 00:06:38.899652 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23e0-0x9cfe2407] May 9 00:06:38.899659 kernel: No NUMA configuration found May 9 00:06:38.899667 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] May 9 00:06:38.899674 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] May 9 00:06:38.899683 kernel: Zone ranges: May 9 00:06:38.899690 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 9 00:06:38.899698 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] May 9 00:06:38.899705 kernel: Normal empty May 9 00:06:38.899712 kernel: Movable zone start for each node May 9 00:06:38.899719 kernel: Early memory node ranges May 9 00:06:38.899726 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] May 9 00:06:38.899733 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] May 9 00:06:38.899740 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] May 9 00:06:38.899750 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 9 00:06:38.899757 kernel: On node 0, zone DMA: 97 pages in unavailable ranges May 9 00:06:38.899765 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges May 9 00:06:38.899772 kernel: ACPI: PM-Timer IO Port: 0x608 May 9 00:06:38.899779 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) May 9 00:06:38.899786 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 9 00:06:38.899793 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) May 9 00:06:38.899801 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) May 9 00:06:38.899808 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 9 00:06:38.899818 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) May 9 00:06:38.899825 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) May 9 00:06:38.899832 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 9 00:06:38.899839 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 May 9 00:06:38.899847 kernel: TSC deadline timer available May 9 00:06:38.899854 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs May 9 00:06:38.899861 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() May 9 00:06:38.899869 kernel: kvm-guest: KVM setup pv remote TLB flush May 9 00:06:38.899876 kernel: kvm-guest: setup PV sched yield May 9 00:06:38.899883 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices May 9 00:06:38.899893 kernel: Booting paravirtualized kernel on KVM May 9 00:06:38.899902 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 9 00:06:38.899911 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 May 9 00:06:38.899920 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u524288 May 9 00:06:38.899929 kernel: pcpu-alloc: s197032 r8192 d32344 u524288 alloc=1*2097152 May 9 00:06:38.899938 kernel: pcpu-alloc: [0] 0 1 2 3 May 9 00:06:38.899947 kernel: kvm-guest: PV spinlocks enabled May 9 00:06:38.899956 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 9 00:06:38.899966 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=8e6c4805303143bfaf51e786bee05d9a5466809f675df313b1f69aaa84c2d4ce May 9 00:06:38.899980 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 9 00:06:38.899989 kernel: random: crng init done May 9 00:06:38.899998 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 9 00:06:38.900007 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 9 00:06:38.900016 kernel: Fallback order for Node 0: 0 May 9 00:06:38.900050 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 May 9 00:06:38.900060 kernel: Policy zone: DMA32 May 9 00:06:38.900085 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 9 00:06:38.900097 kernel: Memory: 2434592K/2571752K available (12288K kernel code, 2295K rwdata, 22752K rodata, 43000K init, 2192K bss, 136900K reserved, 0K cma-reserved) May 9 00:06:38.900104 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 9 00:06:38.900112 kernel: ftrace: allocating 37946 entries in 149 pages May 9 00:06:38.900119 kernel: ftrace: allocated 149 pages with 4 groups May 9 00:06:38.900126 kernel: Dynamic Preempt: voluntary May 9 00:06:38.900134 kernel: rcu: Preemptible hierarchical RCU implementation. May 9 00:06:38.900142 kernel: rcu: RCU event tracing is enabled. May 9 00:06:38.900149 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 9 00:06:38.900157 kernel: Trampoline variant of Tasks RCU enabled. May 9 00:06:38.900166 kernel: Rude variant of Tasks RCU enabled. May 9 00:06:38.900174 kernel: Tracing variant of Tasks RCU enabled. May 9 00:06:38.900181 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 9 00:06:38.900191 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 9 00:06:38.900199 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 May 9 00:06:38.900206 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 9 00:06:38.900213 kernel: Console: colour VGA+ 80x25 May 9 00:06:38.900220 kernel: printk: console [ttyS0] enabled May 9 00:06:38.900228 kernel: ACPI: Core revision 20230628 May 9 00:06:38.900237 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns May 9 00:06:38.900245 kernel: APIC: Switch to symmetric I/O mode setup May 9 00:06:38.900252 kernel: x2apic enabled May 9 00:06:38.900259 kernel: APIC: Switched APIC routing to: physical x2apic May 9 00:06:38.900267 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() May 9 00:06:38.900274 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() May 9 00:06:38.900282 kernel: kvm-guest: setup PV IPIs May 9 00:06:38.900299 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 May 9 00:06:38.900306 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized May 9 00:06:38.900314 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) May 9 00:06:38.900321 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 9 00:06:38.900329 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 May 9 00:06:38.900339 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 May 9 00:06:38.900346 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 9 00:06:38.900361 kernel: Spectre V2 : Mitigation: Retpolines May 9 00:06:38.900370 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 9 00:06:38.900377 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls May 9 00:06:38.900387 kernel: RETBleed: Mitigation: untrained return thunk May 9 00:06:38.900395 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier May 9 00:06:38.900402 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl May 9 00:06:38.900410 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! May 9 00:06:38.900418 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. May 9 00:06:38.900426 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode May 9 00:06:38.900434 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 9 00:06:38.900441 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 9 00:06:38.900451 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 9 00:06:38.900459 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 9 00:06:38.900467 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. May 9 00:06:38.900474 kernel: Freeing SMP alternatives memory: 32K May 9 00:06:38.900482 kernel: pid_max: default: 32768 minimum: 301 May 9 00:06:38.900489 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 9 00:06:38.900497 kernel: landlock: Up and running. May 9 00:06:38.900504 kernel: SELinux: Initializing. May 9 00:06:38.900512 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 9 00:06:38.900522 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 9 00:06:38.900529 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) May 9 00:06:38.900537 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 9 00:06:38.900544 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 9 00:06:38.900552 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 9 00:06:38.900560 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. May 9 00:06:38.900567 kernel: ... version: 0 May 9 00:06:38.900575 kernel: ... bit width: 48 May 9 00:06:38.900582 kernel: ... generic registers: 6 May 9 00:06:38.900642 kernel: ... value mask: 0000ffffffffffff May 9 00:06:38.900650 kernel: ... max period: 00007fffffffffff May 9 00:06:38.900658 kernel: ... fixed-purpose events: 0 May 9 00:06:38.900665 kernel: ... event mask: 000000000000003f May 9 00:06:38.900673 kernel: signal: max sigframe size: 1776 May 9 00:06:38.900680 kernel: rcu: Hierarchical SRCU implementation. May 9 00:06:38.900688 kernel: rcu: Max phase no-delay instances is 400. May 9 00:06:38.900695 kernel: smp: Bringing up secondary CPUs ... May 9 00:06:38.900703 kernel: smpboot: x86: Booting SMP configuration: May 9 00:06:38.900713 kernel: .... node #0, CPUs: #1 #2 #3 May 9 00:06:38.900720 kernel: smp: Brought up 1 node, 4 CPUs May 9 00:06:38.900728 kernel: smpboot: Max logical packages: 1 May 9 00:06:38.900736 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) May 9 00:06:38.900743 kernel: devtmpfs: initialized May 9 00:06:38.900751 kernel: x86/mm: Memory block size: 128MB May 9 00:06:38.900758 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 9 00:06:38.900766 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 9 00:06:38.900774 kernel: pinctrl core: initialized pinctrl subsystem May 9 00:06:38.900784 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 9 00:06:38.900791 kernel: audit: initializing netlink subsys (disabled) May 9 00:06:38.900799 kernel: audit: type=2000 audit(1746749197.845:1): state=initialized audit_enabled=0 res=1 May 9 00:06:38.900806 kernel: thermal_sys: Registered thermal governor 'step_wise' May 9 00:06:38.900814 kernel: thermal_sys: Registered thermal governor 'user_space' May 9 00:06:38.900821 kernel: cpuidle: using governor menu May 9 00:06:38.900829 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 9 00:06:38.900836 kernel: dca service started, version 1.12.1 May 9 00:06:38.900844 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) May 9 00:06:38.900854 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry May 9 00:06:38.900862 kernel: PCI: Using configuration type 1 for base access May 9 00:06:38.900869 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 9 00:06:38.900877 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 9 00:06:38.900885 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 9 00:06:38.900893 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 9 00:06:38.900902 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 9 00:06:38.900910 kernel: ACPI: Added _OSI(Module Device) May 9 00:06:38.900917 kernel: ACPI: Added _OSI(Processor Device) May 9 00:06:38.900927 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 9 00:06:38.900934 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 9 00:06:38.900942 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 9 00:06:38.900950 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC May 9 00:06:38.900957 kernel: ACPI: Interpreter enabled May 9 00:06:38.900965 kernel: ACPI: PM: (supports S0 S3 S5) May 9 00:06:38.900972 kernel: ACPI: Using IOAPIC for interrupt routing May 9 00:06:38.900980 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 9 00:06:38.900988 kernel: PCI: Using E820 reservations for host bridge windows May 9 00:06:38.900997 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F May 9 00:06:38.901005 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 9 00:06:38.901232 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 9 00:06:38.901374 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] May 9 00:06:38.901498 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] May 9 00:06:38.901508 kernel: PCI host bridge to bus 0000:00 May 9 00:06:38.901647 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] May 9 00:06:38.901766 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] May 9 00:06:38.901878 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] May 9 00:06:38.901987 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] May 9 00:06:38.902097 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] May 9 00:06:38.902206 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] May 9 00:06:38.902316 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 9 00:06:38.902462 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 May 9 00:06:38.902610 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 May 9 00:06:38.902736 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] May 9 00:06:38.902857 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] May 9 00:06:38.902977 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] May 9 00:06:38.903097 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] May 9 00:06:38.903226 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 May 9 00:06:38.903353 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] May 9 00:06:38.903485 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] May 9 00:06:38.903621 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] May 9 00:06:38.903752 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 May 9 00:06:38.903874 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] May 9 00:06:38.903995 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] May 9 00:06:38.904116 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] May 9 00:06:38.904256 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 May 9 00:06:38.904387 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] May 9 00:06:38.904509 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] May 9 00:06:38.904645 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] May 9 00:06:38.904768 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] May 9 00:06:38.904895 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 May 9 00:06:38.905015 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO May 9 00:06:38.905147 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 May 9 00:06:38.905267 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] May 9 00:06:38.905396 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] May 9 00:06:38.905526 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 May 9 00:06:38.905714 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] May 9 00:06:38.905725 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 May 9 00:06:38.905733 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 May 9 00:06:38.905745 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 May 9 00:06:38.905752 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 May 9 00:06:38.905760 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 May 9 00:06:38.905767 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 May 9 00:06:38.905775 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 May 9 00:06:38.905782 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 May 9 00:06:38.905790 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 May 9 00:06:38.905797 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 May 9 00:06:38.905805 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 May 9 00:06:38.905814 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 May 9 00:06:38.905822 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 May 9 00:06:38.905829 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 May 9 00:06:38.905837 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 May 9 00:06:38.905844 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 May 9 00:06:38.905852 kernel: iommu: Default domain type: Translated May 9 00:06:38.905859 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 9 00:06:38.905867 kernel: PCI: Using ACPI for IRQ routing May 9 00:06:38.905874 kernel: PCI: pci_cache_line_size set to 64 bytes May 9 00:06:38.905884 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] May 9 00:06:38.905891 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] May 9 00:06:38.906015 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device May 9 00:06:38.906140 kernel: pci 0000:00:01.0: vgaarb: bridge control possible May 9 00:06:38.906259 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none May 9 00:06:38.906269 kernel: vgaarb: loaded May 9 00:06:38.906277 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 May 9 00:06:38.906284 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter May 9 00:06:38.906295 kernel: clocksource: Switched to clocksource kvm-clock May 9 00:06:38.906303 kernel: VFS: Disk quotas dquot_6.6.0 May 9 00:06:38.906311 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 9 00:06:38.906319 kernel: pnp: PnP ACPI init May 9 00:06:38.906457 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved May 9 00:06:38.906468 kernel: pnp: PnP ACPI: found 6 devices May 9 00:06:38.906476 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 9 00:06:38.906483 kernel: NET: Registered PF_INET protocol family May 9 00:06:38.906494 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 9 00:06:38.906502 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 9 00:06:38.906510 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 9 00:06:38.906518 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 9 00:06:38.906526 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 9 00:06:38.906533 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 9 00:06:38.906541 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 9 00:06:38.906549 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 9 00:06:38.906556 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 9 00:06:38.906566 kernel: NET: Registered PF_XDP protocol family May 9 00:06:38.906709 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] May 9 00:06:38.906820 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] May 9 00:06:38.906932 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] May 9 00:06:38.907040 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] May 9 00:06:38.907149 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] May 9 00:06:38.907257 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] May 9 00:06:38.907267 kernel: PCI: CLS 0 bytes, default 64 May 9 00:06:38.907278 kernel: Initialise system trusted keyrings May 9 00:06:38.907286 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 9 00:06:38.907294 kernel: Key type asymmetric registered May 9 00:06:38.907301 kernel: Asymmetric key parser 'x509' registered May 9 00:06:38.907309 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) May 9 00:06:38.907316 kernel: io scheduler mq-deadline registered May 9 00:06:38.907324 kernel: io scheduler kyber registered May 9 00:06:38.907331 kernel: io scheduler bfq registered May 9 00:06:38.907339 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 9 00:06:38.907349 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 May 9 00:06:38.907366 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 May 9 00:06:38.907373 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 May 9 00:06:38.907381 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 9 00:06:38.907388 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 9 00:06:38.907396 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 May 9 00:06:38.907403 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 May 9 00:06:38.907411 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 May 9 00:06:38.907535 kernel: rtc_cmos 00:04: RTC can wake from S4 May 9 00:06:38.907549 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 May 9 00:06:38.907677 kernel: rtc_cmos 00:04: registered as rtc0 May 9 00:06:38.907793 kernel: rtc_cmos 00:04: setting system clock to 2025-05-09T00:06:38 UTC (1746749198) May 9 00:06:38.907907 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs May 9 00:06:38.907917 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled May 9 00:06:38.907924 kernel: NET: Registered PF_INET6 protocol family May 9 00:06:38.907932 kernel: Segment Routing with IPv6 May 9 00:06:38.907939 kernel: In-situ OAM (IOAM) with IPv6 May 9 00:06:38.907951 kernel: NET: Registered PF_PACKET protocol family May 9 00:06:38.907958 kernel: Key type dns_resolver registered May 9 00:06:38.907966 kernel: IPI shorthand broadcast: enabled May 9 00:06:38.907973 kernel: sched_clock: Marking stable (601003145, 107012048)->(727681653, -19666460) May 9 00:06:38.907981 kernel: registered taskstats version 1 May 9 00:06:38.907988 kernel: Loading compiled-in X.509 certificates May 9 00:06:38.907996 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: eadd5f695247828f81e51397e7264f8efd327b51' May 9 00:06:38.908003 kernel: Key type .fscrypt registered May 9 00:06:38.908011 kernel: Key type fscrypt-provisioning registered May 9 00:06:38.908021 kernel: ima: No TPM chip found, activating TPM-bypass! May 9 00:06:38.908028 kernel: ima: Allocated hash algorithm: sha1 May 9 00:06:38.908036 kernel: ima: No architecture policies found May 9 00:06:38.908043 kernel: clk: Disabling unused clocks May 9 00:06:38.908050 kernel: Freeing unused kernel image (initmem) memory: 43000K May 9 00:06:38.908058 kernel: Write protecting the kernel read-only data: 36864k May 9 00:06:38.908065 kernel: Freeing unused kernel image (rodata/data gap) memory: 1824K May 9 00:06:38.908073 kernel: Run /init as init process May 9 00:06:38.908080 kernel: with arguments: May 9 00:06:38.908090 kernel: /init May 9 00:06:38.908097 kernel: with environment: May 9 00:06:38.908104 kernel: HOME=/ May 9 00:06:38.908111 kernel: TERM=linux May 9 00:06:38.908119 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 9 00:06:38.908128 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) May 9 00:06:38.908138 systemd[1]: Detected virtualization kvm. May 9 00:06:38.908146 systemd[1]: Detected architecture x86-64. May 9 00:06:38.908156 systemd[1]: Running in initrd. May 9 00:06:38.908164 systemd[1]: No hostname configured, using default hostname. May 9 00:06:38.908172 systemd[1]: Hostname set to . May 9 00:06:38.908180 systemd[1]: Initializing machine ID from VM UUID. May 9 00:06:38.908188 systemd[1]: Queued start job for default target initrd.target. May 9 00:06:38.908196 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 9 00:06:38.908204 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 9 00:06:38.908213 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 9 00:06:38.908223 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 9 00:06:38.908243 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 9 00:06:38.908254 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 9 00:06:38.908264 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 9 00:06:38.908274 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 9 00:06:38.908283 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 9 00:06:38.908291 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 9 00:06:38.908299 systemd[1]: Reached target paths.target - Path Units. May 9 00:06:38.908307 systemd[1]: Reached target slices.target - Slice Units. May 9 00:06:38.908316 systemd[1]: Reached target swap.target - Swaps. May 9 00:06:38.908324 systemd[1]: Reached target timers.target - Timer Units. May 9 00:06:38.908332 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 9 00:06:38.908340 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 9 00:06:38.908351 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 9 00:06:38.908370 systemd[1]: Listening on systemd-journald.socket - Journal Socket. May 9 00:06:38.908378 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 9 00:06:38.908386 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 9 00:06:38.908395 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 9 00:06:38.908403 systemd[1]: Reached target sockets.target - Socket Units. May 9 00:06:38.908411 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 9 00:06:38.908419 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 9 00:06:38.908427 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 9 00:06:38.908438 systemd[1]: Starting systemd-fsck-usr.service... May 9 00:06:38.908446 systemd[1]: Starting systemd-journald.service - Journal Service... May 9 00:06:38.908455 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 9 00:06:38.908465 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 9 00:06:38.908473 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 9 00:06:38.908482 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 9 00:06:38.908490 systemd[1]: Finished systemd-fsck-usr.service. May 9 00:06:38.908501 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 9 00:06:38.908527 systemd-journald[193]: Collecting audit messages is disabled. May 9 00:06:38.908548 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 9 00:06:38.908559 systemd-journald[193]: Journal started May 9 00:06:38.908579 systemd-journald[193]: Runtime Journal (/run/log/journal/1c3de6d1bb664e959957b45e34cfd29d) is 6.0M, max 48.4M, 42.3M free. May 9 00:06:38.898572 systemd-modules-load[195]: Inserted module 'overlay' May 9 00:06:38.934195 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 9 00:06:38.934210 kernel: Bridge firewalling registered May 9 00:06:38.934221 systemd[1]: Started systemd-journald.service - Journal Service. May 9 00:06:38.925989 systemd-modules-load[195]: Inserted module 'br_netfilter' May 9 00:06:38.934407 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 9 00:06:38.936381 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 9 00:06:38.943744 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 9 00:06:38.945558 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 9 00:06:38.947205 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 9 00:06:38.950752 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 9 00:06:38.960551 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 9 00:06:38.962424 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 9 00:06:38.963683 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 00:06:38.978699 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 9 00:06:38.982512 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 9 00:06:38.986380 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 9 00:06:38.992150 dracut-cmdline[226]: dracut-dracut-053 May 9 00:06:38.994673 dracut-cmdline[226]: Using kernel command line parameters: rd.driver.pre=btrfs 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=8e6c4805303143bfaf51e786bee05d9a5466809f675df313b1f69aaa84c2d4ce May 9 00:06:39.030453 systemd-resolved[233]: Positive Trust Anchors: May 9 00:06:39.030473 systemd-resolved[233]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 9 00:06:39.030514 systemd-resolved[233]: 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 9 00:06:39.033101 systemd-resolved[233]: Defaulting to hostname 'linux'. May 9 00:06:39.034114 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 9 00:06:39.040212 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 9 00:06:39.089620 kernel: SCSI subsystem initialized May 9 00:06:39.098616 kernel: Loading iSCSI transport class v2.0-870. May 9 00:06:39.109619 kernel: iscsi: registered transport (tcp) May 9 00:06:39.129606 kernel: iscsi: registered transport (qla4xxx) May 9 00:06:39.129628 kernel: QLogic iSCSI HBA Driver May 9 00:06:39.172539 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 9 00:06:39.185716 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 9 00:06:39.216320 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 9 00:06:39.216368 kernel: device-mapper: uevent: version 1.0.3 May 9 00:06:39.216397 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 9 00:06:39.256622 kernel: raid6: avx2x4 gen() 29772 MB/s May 9 00:06:39.274614 kernel: raid6: avx2x2 gen() 30155 MB/s May 9 00:06:39.308619 kernel: raid6: avx2x1 gen() 25385 MB/s May 9 00:06:39.308648 kernel: raid6: using algorithm avx2x2 gen() 30155 MB/s May 9 00:06:39.325727 kernel: raid6: .... xor() 19616 MB/s, rmw enabled May 9 00:06:39.325748 kernel: raid6: using avx2x2 recovery algorithm May 9 00:06:39.345616 kernel: xor: automatically using best checksumming function avx May 9 00:06:39.503634 kernel: Btrfs loaded, zoned=no, fsverity=no May 9 00:06:39.517000 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 9 00:06:39.525756 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 9 00:06:39.537620 systemd-udevd[415]: Using default interface naming scheme 'v255'. May 9 00:06:39.541939 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 9 00:06:39.559884 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 9 00:06:39.573548 dracut-pre-trigger[420]: rd.md=0: removing MD RAID activation May 9 00:06:39.606118 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 9 00:06:39.617714 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 9 00:06:39.683288 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 9 00:06:39.694756 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 9 00:06:39.707630 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues May 9 00:06:39.707776 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 9 00:06:39.709486 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 9 00:06:39.716422 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 9 00:06:39.717652 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 9 00:06:39.722399 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 9 00:06:39.719729 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 9 00:06:39.727616 kernel: cryptd: max_cpu_qlen set to 1000 May 9 00:06:39.729858 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 9 00:06:39.744897 kernel: libata version 3.00 loaded. May 9 00:06:39.744979 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 9 00:06:39.754017 kernel: ahci 0000:00:1f.2: version 3.0 May 9 00:06:39.754204 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 May 9 00:06:39.754217 kernel: AVX2 version of gcm_enc/dec engaged. May 9 00:06:39.752858 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 9 00:06:39.757794 kernel: AES CTR mode by8 optimization enabled May 9 00:06:39.757809 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode May 9 00:06:39.757968 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only May 9 00:06:39.752969 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 00:06:39.757905 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 9 00:06:39.762778 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 9 00:06:39.766015 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 9 00:06:39.768796 kernel: BTRFS: device fsid cea98156-267a-4592-a459-5921031522cf devid 1 transid 40 /dev/vda3 scanned by (udev-worker) (470) May 9 00:06:39.769872 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 9 00:06:39.772615 kernel: scsi host0: ahci May 9 00:06:39.775363 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (460) May 9 00:06:39.775387 kernel: scsi host1: ahci May 9 00:06:39.776880 kernel: scsi host2: ahci May 9 00:06:39.777054 kernel: scsi host3: ahci May 9 00:06:39.777989 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 9 00:06:39.783173 kernel: scsi host4: ahci May 9 00:06:39.783353 kernel: scsi host5: ahci May 9 00:06:39.783501 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 May 9 00:06:39.783514 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 May 9 00:06:39.783524 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 May 9 00:06:39.783540 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 May 9 00:06:39.783964 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 May 9 00:06:39.785690 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 May 9 00:06:39.803143 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 9 00:06:39.831348 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 9 00:06:39.838741 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 9 00:06:39.845487 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 9 00:06:39.848836 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 9 00:06:39.855909 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 9 00:06:39.868807 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 9 00:06:39.871321 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 9 00:06:39.878623 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 9 00:06:39.884626 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 9 00:06:39.894663 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 00:06:40.094619 kernel: ata1: SATA link down (SStatus 0 SControl 300) May 9 00:06:40.094675 kernel: ata6: SATA link down (SStatus 0 SControl 300) May 9 00:06:40.095612 kernel: ata2: SATA link down (SStatus 0 SControl 300) May 9 00:06:40.095639 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) May 9 00:06:40.096633 kernel: ata5: SATA link down (SStatus 0 SControl 300) May 9 00:06:40.097626 kernel: ata4: SATA link down (SStatus 0 SControl 300) May 9 00:06:40.098625 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 May 9 00:06:40.098639 kernel: ata3.00: applying bridge limits May 9 00:06:40.099621 kernel: ata3.00: configured for UDMA/100 May 9 00:06:40.101621 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 May 9 00:06:40.143621 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray May 9 00:06:40.143856 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 9 00:06:40.157623 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 May 9 00:06:40.889586 disk-uuid[555]: The operation has completed successfully. May 9 00:06:40.891238 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 9 00:06:40.914929 systemd[1]: disk-uuid.service: Deactivated successfully. May 9 00:06:40.915068 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 9 00:06:40.947756 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 9 00:06:40.950768 sh[591]: Success May 9 00:06:40.962620 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" May 9 00:06:40.993561 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 9 00:06:41.025021 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 9 00:06:41.027821 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 9 00:06:41.041834 kernel: BTRFS info (device dm-0): first mount of filesystem cea98156-267a-4592-a459-5921031522cf May 9 00:06:41.041869 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 9 00:06:41.041884 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 9 00:06:41.042895 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 9 00:06:41.043694 kernel: BTRFS info (device dm-0): using free space tree May 9 00:06:41.048082 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 9 00:06:41.048893 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 9 00:06:41.051995 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 9 00:06:41.053033 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 9 00:06:41.070649 kernel: BTRFS info (device vda6): first mount of filesystem 06eb5ada-09bb-4b72-a741-1d4e677346cf May 9 00:06:41.070684 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 9 00:06:41.072211 kernel: BTRFS info (device vda6): using free space tree May 9 00:06:41.075770 kernel: BTRFS info (device vda6): auto enabling async discard May 9 00:06:41.084733 systemd[1]: mnt-oem.mount: Deactivated successfully. May 9 00:06:41.086741 kernel: BTRFS info (device vda6): last unmount of filesystem 06eb5ada-09bb-4b72-a741-1d4e677346cf May 9 00:06:41.096431 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 9 00:06:41.100750 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 9 00:06:41.159263 ignition[703]: Ignition 2.20.0 May 9 00:06:41.159278 ignition[703]: Stage: fetch-offline May 9 00:06:41.159329 ignition[703]: no configs at "/usr/lib/ignition/base.d" May 9 00:06:41.159340 ignition[703]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 9 00:06:41.159460 ignition[703]: parsed url from cmdline: "" May 9 00:06:41.159465 ignition[703]: no config URL provided May 9 00:06:41.159472 ignition[703]: reading system config file "/usr/lib/ignition/user.ign" May 9 00:06:41.159484 ignition[703]: no config at "/usr/lib/ignition/user.ign" May 9 00:06:41.159517 ignition[703]: op(1): [started] loading QEMU firmware config module May 9 00:06:41.159523 ignition[703]: op(1): executing: "modprobe" "qemu_fw_cfg" May 9 00:06:41.169879 ignition[703]: op(1): [finished] loading QEMU firmware config module May 9 00:06:41.170114 ignition[703]: parsing config with SHA512: e0d65bb5e4679e9739ac358f1312db912936889a8b89a91db7a8865ec5facf978ea61d197c65fe289774f4a0b5ea70f9a27ee9f706e2ee6280168af13539eef7 May 9 00:06:41.175116 unknown[703]: fetched base config from "system" May 9 00:06:41.175129 unknown[703]: fetched user config from "qemu" May 9 00:06:41.175728 ignition[703]: fetch-offline: fetch-offline passed May 9 00:06:41.177256 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 9 00:06:41.175836 ignition[703]: Ignition finished successfully May 9 00:06:41.187783 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 9 00:06:41.188275 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 9 00:06:41.209755 systemd-networkd[779]: lo: Link UP May 9 00:06:41.209764 systemd-networkd[779]: lo: Gained carrier May 9 00:06:41.211294 systemd-networkd[779]: Enumeration completed May 9 00:06:41.211397 systemd[1]: Started systemd-networkd.service - Network Configuration. May 9 00:06:41.211735 systemd-networkd[779]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 00:06:41.211739 systemd-networkd[779]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 9 00:06:41.212066 systemd[1]: Reached target network.target - Network. May 9 00:06:41.212704 systemd-networkd[779]: eth0: Link UP May 9 00:06:41.212709 systemd-networkd[779]: eth0: Gained carrier May 9 00:06:41.212717 systemd-networkd[779]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 00:06:41.213151 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 9 00:06:41.226716 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 9 00:06:41.237671 systemd-networkd[779]: eth0: DHCPv4 address 10.0.0.84/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 9 00:06:41.240680 ignition[782]: Ignition 2.20.0 May 9 00:06:41.240694 ignition[782]: Stage: kargs May 9 00:06:41.240878 ignition[782]: no configs at "/usr/lib/ignition/base.d" May 9 00:06:41.240889 ignition[782]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 9 00:06:41.241441 ignition[782]: kargs: kargs passed May 9 00:06:41.241475 ignition[782]: Ignition finished successfully May 9 00:06:41.245566 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 9 00:06:41.258762 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 9 00:06:41.269509 ignition[792]: Ignition 2.20.0 May 9 00:06:41.269521 ignition[792]: Stage: disks May 9 00:06:41.269704 ignition[792]: no configs at "/usr/lib/ignition/base.d" May 9 00:06:41.269715 ignition[792]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 9 00:06:41.272258 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 9 00:06:41.270227 ignition[792]: disks: disks passed May 9 00:06:41.274244 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 9 00:06:41.270271 ignition[792]: Ignition finished successfully May 9 00:06:41.276140 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 9 00:06:41.278025 systemd[1]: Reached target local-fs.target - Local File Systems. May 9 00:06:41.280141 systemd[1]: Reached target sysinit.target - System Initialization. May 9 00:06:41.281972 systemd[1]: Reached target basic.target - Basic System. May 9 00:06:41.294736 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 9 00:06:41.306373 systemd-fsck[803]: ROOT: clean, 14/553520 files, 52654/553472 blocks May 9 00:06:41.312397 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 9 00:06:41.315255 systemd[1]: Mounting sysroot.mount - /sysroot... May 9 00:06:41.407624 kernel: EXT4-fs (vda9): mounted filesystem 61492938-2ced-4ec2-b593-fc96fa0fefcc r/w with ordered data mode. Quota mode: none. May 9 00:06:41.407975 systemd[1]: Mounted sysroot.mount - /sysroot. May 9 00:06:41.409640 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 9 00:06:41.425667 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 9 00:06:41.427508 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 9 00:06:41.433779 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (811) May 9 00:06:41.433803 kernel: BTRFS info (device vda6): first mount of filesystem 06eb5ada-09bb-4b72-a741-1d4e677346cf May 9 00:06:41.433815 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 9 00:06:41.429500 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 9 00:06:41.437242 kernel: BTRFS info (device vda6): using free space tree May 9 00:06:41.437257 kernel: BTRFS info (device vda6): auto enabling async discard May 9 00:06:41.429536 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 9 00:06:41.429555 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 9 00:06:41.438840 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 9 00:06:41.442010 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 9 00:06:41.444701 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 9 00:06:41.479534 initrd-setup-root[835]: cut: /sysroot/etc/passwd: No such file or directory May 9 00:06:41.483518 initrd-setup-root[842]: cut: /sysroot/etc/group: No such file or directory May 9 00:06:41.488693 initrd-setup-root[849]: cut: /sysroot/etc/shadow: No such file or directory May 9 00:06:41.493652 initrd-setup-root[856]: cut: /sysroot/etc/gshadow: No such file or directory May 9 00:06:41.557718 systemd-resolved[233]: Detected conflict on linux IN A 10.0.0.84 May 9 00:06:41.557736 systemd-resolved[233]: Hostname conflict, changing published hostname from 'linux' to 'linux5'. May 9 00:06:41.579373 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 9 00:06:41.598715 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 9 00:06:41.600845 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 9 00:06:41.608624 kernel: BTRFS info (device vda6): last unmount of filesystem 06eb5ada-09bb-4b72-a741-1d4e677346cf May 9 00:06:41.624894 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 9 00:06:41.629152 ignition[926]: INFO : Ignition 2.20.0 May 9 00:06:41.630219 ignition[926]: INFO : Stage: mount May 9 00:06:41.630219 ignition[926]: INFO : no configs at "/usr/lib/ignition/base.d" May 9 00:06:41.630219 ignition[926]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 9 00:06:41.634491 ignition[926]: INFO : mount: mount passed May 9 00:06:41.634491 ignition[926]: INFO : Ignition finished successfully May 9 00:06:41.632436 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 9 00:06:41.648681 systemd[1]: Starting ignition-files.service - Ignition (files)... May 9 00:06:42.041056 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 9 00:06:42.054791 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 9 00:06:42.062102 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (940) May 9 00:06:42.062137 kernel: BTRFS info (device vda6): first mount of filesystem 06eb5ada-09bb-4b72-a741-1d4e677346cf May 9 00:06:42.062149 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm May 9 00:06:42.063723 kernel: BTRFS info (device vda6): using free space tree May 9 00:06:42.066615 kernel: BTRFS info (device vda6): auto enabling async discard May 9 00:06:42.068221 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 9 00:06:42.089177 ignition[957]: INFO : Ignition 2.20.0 May 9 00:06:42.089177 ignition[957]: INFO : Stage: files May 9 00:06:42.090933 ignition[957]: INFO : no configs at "/usr/lib/ignition/base.d" May 9 00:06:42.090933 ignition[957]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 9 00:06:42.090933 ignition[957]: DEBUG : files: compiled without relabeling support, skipping May 9 00:06:42.094254 ignition[957]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 9 00:06:42.094254 ignition[957]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 9 00:06:42.097109 ignition[957]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 9 00:06:42.098531 ignition[957]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 9 00:06:42.100099 unknown[957]: wrote ssh authorized keys file for user: core May 9 00:06:42.101175 ignition[957]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 9 00:06:42.103358 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 9 00:06:42.105229 ignition[957]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 9 00:06:42.105229 ignition[957]: INFO : files: op(4): [started] processing unit "docker.service" May 9 00:06:42.105229 ignition[957]: INFO : files: op(4): [finished] processing unit "docker.service" May 9 00:06:42.105229 ignition[957]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" May 9 00:06:42.111182 ignition[957]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 9 00:06:42.111182 ignition[957]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 9 00:06:42.111182 ignition[957]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" May 9 00:06:42.111182 ignition[957]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" May 9 00:06:42.137775 ignition[957]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" May 9 00:06:42.143945 ignition[957]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 9 00:06:42.145625 ignition[957]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" May 9 00:06:42.145625 ignition[957]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" May 9 00:06:42.145625 ignition[957]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" May 9 00:06:42.145625 ignition[957]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 9 00:06:42.145625 ignition[957]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 9 00:06:42.145625 ignition[957]: INFO : files: files passed May 9 00:06:42.145625 ignition[957]: INFO : Ignition finished successfully May 9 00:06:42.156187 systemd[1]: Finished ignition-files.service - Ignition (files). May 9 00:06:42.166729 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 9 00:06:42.169773 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 9 00:06:42.170555 systemd[1]: ignition-quench.service: Deactivated successfully. May 9 00:06:42.170696 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 9 00:06:42.184712 initrd-setup-root-after-ignition[985]: grep: /sysroot/oem/oem-release: No such file or directory May 9 00:06:42.188437 initrd-setup-root-after-ignition[987]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 9 00:06:42.188437 initrd-setup-root-after-ignition[987]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 9 00:06:42.191696 initrd-setup-root-after-ignition[991]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 9 00:06:42.195582 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 9 00:06:42.196074 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 9 00:06:42.210740 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 9 00:06:42.234614 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 9 00:06:42.234755 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 9 00:06:42.237246 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 9 00:06:42.237585 systemd[1]: Reached target initrd.target - Initrd Default Target. May 9 00:06:42.238190 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 9 00:06:42.239163 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 9 00:06:42.259144 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 9 00:06:42.265765 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 9 00:06:42.278003 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 9 00:06:42.278408 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 9 00:06:42.281063 systemd[1]: Stopped target timers.target - Timer Units. May 9 00:06:42.283979 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 9 00:06:42.284116 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 9 00:06:42.288128 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 9 00:06:42.288989 systemd[1]: Stopped target basic.target - Basic System. May 9 00:06:42.291963 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 9 00:06:42.294081 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 9 00:06:42.299022 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 9 00:06:42.299538 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 9 00:06:42.301991 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 9 00:06:42.304187 systemd[1]: Stopped target sysinit.target - System Initialization. May 9 00:06:42.306700 systemd[1]: Stopped target local-fs.target - Local File Systems. May 9 00:06:42.307055 systemd[1]: Stopped target swap.target - Swaps. May 9 00:06:42.310525 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 9 00:06:42.310654 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 9 00:06:42.313478 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 9 00:06:42.315423 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 9 00:06:42.317486 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 9 00:06:42.317605 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 9 00:06:42.318032 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 9 00:06:42.318133 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 9 00:06:42.322928 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 9 00:06:42.323039 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 9 00:06:42.323545 systemd[1]: Stopped target paths.target - Path Units. May 9 00:06:42.326175 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 9 00:06:42.329658 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 9 00:06:42.330151 systemd[1]: Stopped target slices.target - Slice Units. May 9 00:06:42.333431 systemd[1]: Stopped target sockets.target - Socket Units. May 9 00:06:42.335078 systemd[1]: iscsid.socket: Deactivated successfully. May 9 00:06:42.335166 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 9 00:06:42.336967 systemd[1]: iscsiuio.socket: Deactivated successfully. May 9 00:06:42.337051 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 9 00:06:42.338494 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 9 00:06:42.338616 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 9 00:06:42.340267 systemd[1]: ignition-files.service: Deactivated successfully. May 9 00:06:42.340374 systemd[1]: Stopped ignition-files.service - Ignition (files). May 9 00:06:42.354732 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 9 00:06:42.356684 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 9 00:06:42.357092 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 9 00:06:42.357197 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 9 00:06:42.359368 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 9 00:06:42.359482 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 9 00:06:42.365910 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 9 00:06:42.366017 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 9 00:06:42.369415 ignition[1011]: INFO : Ignition 2.20.0 May 9 00:06:42.369415 ignition[1011]: INFO : Stage: umount May 9 00:06:42.369415 ignition[1011]: INFO : no configs at "/usr/lib/ignition/base.d" May 9 00:06:42.369415 ignition[1011]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 9 00:06:42.369415 ignition[1011]: INFO : umount: umount passed May 9 00:06:42.369415 ignition[1011]: INFO : Ignition finished successfully May 9 00:06:42.369874 systemd[1]: ignition-mount.service: Deactivated successfully. May 9 00:06:42.369990 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 9 00:06:42.370487 systemd[1]: Stopped target network.target - Network. May 9 00:06:42.372532 systemd[1]: ignition-disks.service: Deactivated successfully. May 9 00:06:42.372581 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 9 00:06:42.373053 systemd[1]: ignition-kargs.service: Deactivated successfully. May 9 00:06:42.373097 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 9 00:06:42.373391 systemd[1]: ignition-setup.service: Deactivated successfully. May 9 00:06:42.373434 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 9 00:06:42.373878 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 9 00:06:42.373920 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 9 00:06:42.374332 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 9 00:06:42.374625 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 9 00:06:42.385814 systemd[1]: systemd-resolved.service: Deactivated successfully. May 9 00:06:42.385928 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 9 00:06:42.387850 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 9 00:06:42.387913 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 9 00:06:42.391725 systemd-networkd[779]: eth0: DHCPv6 lease lost May 9 00:06:42.393427 systemd[1]: systemd-networkd.service: Deactivated successfully. May 9 00:06:42.393552 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 9 00:06:42.394416 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 9 00:06:42.394456 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 9 00:06:42.404703 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 9 00:06:42.405120 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 9 00:06:42.405172 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 9 00:06:42.405825 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 9 00:06:42.405870 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 9 00:06:42.406144 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 9 00:06:42.406186 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 9 00:06:42.406588 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 9 00:06:42.418784 systemd[1]: network-cleanup.service: Deactivated successfully. May 9 00:06:42.418924 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 9 00:06:42.430481 systemd[1]: systemd-udevd.service: Deactivated successfully. May 9 00:06:42.430721 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 9 00:06:42.433301 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 9 00:06:42.433354 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 9 00:06:42.435439 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 9 00:06:42.435478 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 9 00:06:42.437475 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 9 00:06:42.437523 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 9 00:06:42.439898 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 9 00:06:42.439948 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 9 00:06:42.441919 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 9 00:06:42.441972 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 00:06:42.451774 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 9 00:06:42.453933 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 9 00:06:42.454966 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 9 00:06:42.457389 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 9 00:06:42.458485 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 9 00:06:42.461064 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 9 00:06:42.462006 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 9 00:06:42.464342 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 9 00:06:42.465328 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 9 00:06:42.468351 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 9 00:06:42.469734 systemd[1]: sysroot-boot.service: Deactivated successfully. May 9 00:06:42.470687 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 9 00:06:42.472686 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 9 00:06:42.473756 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 9 00:06:42.476837 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 9 00:06:42.478874 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 9 00:06:42.479815 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 9 00:06:42.490750 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 9 00:06:42.497640 systemd[1]: Switching root. May 9 00:06:42.529176 systemd-journald[193]: Journal stopped May 9 00:06:43.336419 systemd-journald[193]: Received SIGTERM from PID 1 (systemd). May 9 00:06:43.336482 kernel: SELinux: policy capability network_peer_controls=1 May 9 00:06:43.336504 kernel: SELinux: policy capability open_perms=1 May 9 00:06:43.336516 kernel: SELinux: policy capability extended_socket_class=1 May 9 00:06:43.336527 kernel: SELinux: policy capability always_check_network=0 May 9 00:06:43.336539 kernel: SELinux: policy capability cgroup_seclabel=1 May 9 00:06:43.336550 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 9 00:06:43.336561 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 9 00:06:43.336579 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 9 00:06:43.336615 kernel: audit: type=1403 audit(1746749202.612:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 9 00:06:43.336633 systemd[1]: Successfully loaded SELinux policy in 40.951ms. May 9 00:06:43.336653 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.697ms. May 9 00:06:43.336666 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) May 9 00:06:43.336678 systemd[1]: Detected virtualization kvm. May 9 00:06:43.336692 systemd[1]: Detected architecture x86-64. May 9 00:06:43.336704 systemd[1]: Detected first boot. May 9 00:06:43.336716 systemd[1]: Initializing machine ID from VM UUID. May 9 00:06:43.336728 zram_generator::config[1056]: No configuration found. May 9 00:06:43.336744 systemd[1]: Populated /etc with preset unit settings. May 9 00:06:43.336756 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 9 00:06:43.336768 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 9 00:06:43.336780 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 9 00:06:43.336792 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 9 00:06:43.336805 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 9 00:06:43.336817 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 9 00:06:43.336831 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 9 00:06:43.336843 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 9 00:06:43.336855 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 9 00:06:43.336867 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 9 00:06:43.336879 systemd[1]: Created slice user.slice - User and Session Slice. May 9 00:06:43.336892 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 9 00:06:43.336904 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 9 00:06:43.336919 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 9 00:06:43.336931 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 9 00:06:43.336943 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 9 00:06:43.336957 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 9 00:06:43.336969 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 9 00:06:43.336981 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 9 00:06:43.336993 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 9 00:06:43.337004 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 9 00:06:43.337019 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 9 00:06:43.337031 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 9 00:06:43.337049 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 9 00:06:43.337061 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 9 00:06:43.337073 systemd[1]: Reached target slices.target - Slice Units. May 9 00:06:43.337085 systemd[1]: Reached target swap.target - Swaps. May 9 00:06:43.337097 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 9 00:06:43.337109 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 9 00:06:43.337123 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 9 00:06:43.337135 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 9 00:06:43.337147 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 9 00:06:43.337159 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 9 00:06:43.337172 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 9 00:06:43.337184 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 9 00:06:43.337197 systemd[1]: Mounting media.mount - External Media Directory... May 9 00:06:43.337209 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:43.337223 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 9 00:06:43.337237 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 9 00:06:43.337258 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 9 00:06:43.337271 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 9 00:06:43.337283 systemd[1]: Reached target machines.target - Containers. May 9 00:06:43.337295 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 9 00:06:43.337307 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 00:06:43.337319 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 9 00:06:43.337331 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 9 00:06:43.337346 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 9 00:06:43.337358 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 9 00:06:43.337370 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 9 00:06:43.337382 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 9 00:06:43.337394 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 9 00:06:43.337406 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 9 00:06:43.337418 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 9 00:06:43.337430 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 9 00:06:43.337442 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 9 00:06:43.337456 systemd[1]: Stopped systemd-fsck-usr.service. May 9 00:06:43.337468 systemd[1]: Starting systemd-journald.service - Journal Service... May 9 00:06:43.337481 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 9 00:06:43.337494 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 9 00:06:43.337506 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 9 00:06:43.337518 kernel: loop: module loaded May 9 00:06:43.337529 kernel: fuse: init (API version 7.39) May 9 00:06:43.337541 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 9 00:06:43.337553 systemd[1]: verity-setup.service: Deactivated successfully. May 9 00:06:43.337568 systemd[1]: Stopped verity-setup.service. May 9 00:06:43.337580 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:43.337604 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 9 00:06:43.337616 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 9 00:06:43.337628 systemd[1]: Mounted media.mount - External Media Directory. May 9 00:06:43.337640 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 9 00:06:43.337671 systemd-journald[1119]: Collecting audit messages is disabled. May 9 00:06:43.337692 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 9 00:06:43.337704 systemd-journald[1119]: Journal started May 9 00:06:43.337726 systemd-journald[1119]: Runtime Journal (/run/log/journal/1c3de6d1bb664e959957b45e34cfd29d) is 6.0M, max 48.4M, 42.3M free. May 9 00:06:43.103314 systemd[1]: Queued start job for default target multi-user.target. May 9 00:06:43.119657 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 9 00:06:43.120089 systemd[1]: systemd-journald.service: Deactivated successfully. May 9 00:06:43.339802 systemd[1]: Started systemd-journald.service - Journal Service. May 9 00:06:43.341107 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 9 00:06:43.342534 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 9 00:06:43.344100 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 9 00:06:43.344341 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 9 00:06:43.345903 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 9 00:06:43.346168 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 9 00:06:43.347667 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 9 00:06:43.347927 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 9 00:06:43.349472 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 9 00:06:43.350008 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 9 00:06:43.351583 systemd[1]: modprobe@loop.service: Deactivated successfully. May 9 00:06:43.351837 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 9 00:06:43.353221 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 9 00:06:43.354732 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 9 00:06:43.356316 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 9 00:06:43.368927 systemd[1]: Reached target network-pre.target - Preparation for Network. May 9 00:06:43.379713 kernel: ACPI: bus type drm_connector registered May 9 00:06:43.389810 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 9 00:06:43.392243 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 9 00:06:43.393422 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 9 00:06:43.393452 systemd[1]: Reached target local-fs.target - Local File Systems. May 9 00:06:43.395405 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). May 9 00:06:43.398769 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 9 00:06:43.400987 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 9 00:06:43.402228 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 00:06:43.404048 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 9 00:06:43.407890 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 9 00:06:43.409207 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 9 00:06:43.410750 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 9 00:06:43.412510 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 9 00:06:43.416006 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 9 00:06:43.422953 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 9 00:06:43.439245 systemd-journald[1119]: Time spent on flushing to /var/log/journal/1c3de6d1bb664e959957b45e34cfd29d is 15.567ms for 920 entries. May 9 00:06:43.439245 systemd-journald[1119]: System Journal (/var/log/journal/1c3de6d1bb664e959957b45e34cfd29d) is 8.0M, max 195.6M, 187.6M free. May 9 00:06:43.531974 systemd-journald[1119]: Received client request to flush runtime journal. May 9 00:06:43.532006 kernel: loop0: detected capacity change from 0 to 138184 May 9 00:06:43.532020 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 9 00:06:43.425192 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 9 00:06:43.444043 systemd[1]: modprobe@drm.service: Deactivated successfully. May 9 00:06:43.444245 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 9 00:06:43.445796 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 9 00:06:43.447190 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 9 00:06:43.448487 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 9 00:06:43.449946 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 9 00:06:43.464771 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 9 00:06:43.473806 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 9 00:06:43.488054 udevadm[1170]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. May 9 00:06:43.491651 systemd-tmpfiles[1162]: ACLs are not supported, ignoring. May 9 00:06:43.491665 systemd-tmpfiles[1162]: ACLs are not supported, ignoring. May 9 00:06:43.497436 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 9 00:06:43.514144 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 9 00:06:43.515690 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 9 00:06:43.527869 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... May 9 00:06:43.532071 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 9 00:06:43.534019 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 9 00:06:43.538688 kernel: loop1: detected capacity change from 0 to 140992 May 9 00:06:43.539584 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 9 00:06:43.553068 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 9 00:06:43.553680 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. May 9 00:06:43.576400 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 9 00:06:43.581655 kernel: loop2: detected capacity change from 0 to 138184 May 9 00:06:43.589555 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 9 00:06:43.599628 kernel: loop3: detected capacity change from 0 to 140992 May 9 00:06:43.604338 systemd-tmpfiles[1195]: ACLs are not supported, ignoring. May 9 00:06:43.604648 systemd-tmpfiles[1195]: ACLs are not supported, ignoring. May 9 00:06:43.605824 (sd-merge)[1196]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 9 00:06:43.606317 (sd-merge)[1196]: Merged extensions into '/usr'. May 9 00:06:43.610900 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 9 00:06:43.612710 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 9 00:06:43.621761 systemd[1]: Starting ensure-sysext.service... May 9 00:06:43.628395 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 9 00:06:43.631782 systemd[1]: Reloading requested from client PID 1200 ('systemctl') (unit ensure-sysext.service)... May 9 00:06:43.631870 systemd[1]: Reloading... May 9 00:06:43.650392 systemd-tmpfiles[1201]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 9 00:06:43.650769 systemd-tmpfiles[1201]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 9 00:06:43.651866 systemd-tmpfiles[1201]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 9 00:06:43.652166 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. May 9 00:06:43.652252 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. May 9 00:06:43.657074 systemd-tmpfiles[1201]: Detected autofs mount point /boot during canonicalization of boot. May 9 00:06:43.657086 systemd-tmpfiles[1201]: Skipping /boot May 9 00:06:43.676258 systemd-tmpfiles[1201]: Detected autofs mount point /boot during canonicalization of boot. May 9 00:06:43.678654 systemd-tmpfiles[1201]: Skipping /boot May 9 00:06:43.690610 zram_generator::config[1225]: No configuration found. May 9 00:06:43.781903 ldconfig[1149]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 9 00:06:43.818640 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 9 00:06:43.867825 systemd[1]: Reloading finished in 235 ms. May 9 00:06:43.905348 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 9 00:06:43.914022 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 9 00:06:43.922532 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 9 00:06:43.925085 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 9 00:06:43.931764 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 9 00:06:43.937079 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 9 00:06:43.946850 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 9 00:06:43.950497 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:43.950676 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 00:06:43.955972 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 9 00:06:43.959023 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 9 00:06:43.962423 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 9 00:06:43.963557 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 00:06:43.968666 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 9 00:06:43.969821 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:43.970869 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 9 00:06:43.972696 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 9 00:06:43.972857 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 9 00:06:43.974650 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 9 00:06:43.974815 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 9 00:06:43.976923 systemd[1]: modprobe@loop.service: Deactivated successfully. May 9 00:06:43.977088 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 9 00:06:43.985670 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 9 00:06:43.990518 augenrules[1300]: No rules May 9 00:06:43.992153 systemd[1]: audit-rules.service: Deactivated successfully. May 9 00:06:43.992615 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 9 00:06:43.995502 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:43.995971 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 00:06:44.001813 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 9 00:06:44.004717 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 9 00:06:44.006981 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 9 00:06:44.008188 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 00:06:44.008297 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:44.009147 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 9 00:06:44.009670 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 9 00:06:44.012530 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 9 00:06:44.012763 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 9 00:06:44.014555 systemd[1]: modprobe@loop.service: Deactivated successfully. May 9 00:06:44.014774 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 9 00:06:44.020074 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:44.032767 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 9 00:06:44.033938 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 00:06:44.035737 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 9 00:06:44.041111 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 9 00:06:44.048537 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 9 00:06:44.051877 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 9 00:06:44.053177 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 00:06:44.053260 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 9 00:06:44.053640 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 9 00:06:44.055509 systemd[1]: Finished ensure-sysext.service. May 9 00:06:44.057066 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 9 00:06:44.059035 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 9 00:06:44.059207 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 9 00:06:44.061843 augenrules[1313]: /sbin/augenrules: No change May 9 00:06:44.064029 systemd[1]: modprobe@drm.service: Deactivated successfully. May 9 00:06:44.064206 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 9 00:06:44.065896 systemd[1]: modprobe@loop.service: Deactivated successfully. May 9 00:06:44.066059 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 9 00:06:44.074185 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 9 00:06:44.074497 augenrules[1342]: No rules May 9 00:06:44.085771 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 9 00:06:44.086928 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 9 00:06:44.087413 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 9 00:06:44.088922 systemd[1]: audit-rules.service: Deactivated successfully. May 9 00:06:44.089125 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 9 00:06:44.090540 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 9 00:06:44.090757 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 9 00:06:44.094960 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 9 00:06:44.099828 systemd-resolved[1271]: Positive Trust Anchors: May 9 00:06:44.099841 systemd-resolved[1271]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 9 00:06:44.099872 systemd-resolved[1271]: 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 9 00:06:44.103524 systemd-resolved[1271]: Defaulting to hostname 'linux'. May 9 00:06:44.105074 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 9 00:06:44.107525 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 9 00:06:44.108883 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 9 00:06:44.110195 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 9 00:06:44.123120 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 9 00:06:44.139445 systemd-udevd[1353]: Using default interface naming scheme 'v255'. May 9 00:06:44.154942 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 9 00:06:44.156401 systemd[1]: Reached target time-set.target - System Time Set. May 9 00:06:44.157446 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 9 00:06:44.169747 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 9 00:06:44.189940 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 9 00:06:44.197640 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1361) May 9 00:06:44.232315 systemd-networkd[1365]: lo: Link UP May 9 00:06:44.232641 systemd-networkd[1365]: lo: Gained carrier May 9 00:06:44.234241 systemd-networkd[1365]: Enumeration completed May 9 00:06:44.234658 systemd[1]: Started systemd-networkd.service - Network Configuration. May 9 00:06:44.236188 systemd-networkd[1365]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 00:06:44.236332 systemd-networkd[1365]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 9 00:06:44.236930 systemd[1]: Reached target network.target - Network. May 9 00:06:44.237727 systemd-networkd[1365]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 00:06:44.237819 systemd-networkd[1365]: eth0: Link UP May 9 00:06:44.237861 systemd-networkd[1365]: eth0: Gained carrier May 9 00:06:44.237910 systemd-networkd[1365]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 00:06:44.245840 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 9 00:06:44.247669 systemd-networkd[1365]: eth0: DHCPv4 address 10.0.0.84/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 9 00:06:44.248528 systemd-timesyncd[1349]: Network configuration changed, trying to establish connection. May 9 00:06:44.249415 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 9 00:06:44.249430 systemd-timesyncd[1349]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 9 00:06:44.249470 systemd-timesyncd[1349]: Initial clock synchronization to Fri 2025-05-09 00:06:44.206654 UTC. May 9 00:06:44.252334 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 9 00:06:44.266627 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 May 9 00:06:44.269637 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt May 9 00:06:44.276948 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) May 9 00:06:44.277123 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 May 9 00:06:44.277141 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD May 9 00:06:44.273017 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 9 00:06:44.280613 kernel: ACPI: button: Power Button [PWRF] May 9 00:06:44.317869 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 9 00:06:44.325610 kernel: mousedev: PS/2 mouse device common for all mice May 9 00:06:44.385261 kernel: kvm_amd: TSC scaling supported May 9 00:06:44.385336 kernel: kvm_amd: Nested Virtualization enabled May 9 00:06:44.385350 kernel: kvm_amd: Nested Paging enabled May 9 00:06:44.385368 kernel: kvm_amd: LBR virtualization supported May 9 00:06:44.385880 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported May 9 00:06:44.387107 kernel: kvm_amd: Virtual GIF supported May 9 00:06:44.406621 kernel: EDAC MC: Ver: 3.0.0 May 9 00:06:44.443155 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 9 00:06:44.449194 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 9 00:06:44.462782 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 9 00:06:44.472210 lvm[1401]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 9 00:06:44.509184 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 9 00:06:44.510792 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 9 00:06:44.511949 systemd[1]: Reached target sysinit.target - System Initialization. May 9 00:06:44.513146 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 9 00:06:44.514475 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 9 00:06:44.515984 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 9 00:06:44.517201 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 9 00:06:44.518621 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 9 00:06:44.519905 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 9 00:06:44.519932 systemd[1]: Reached target paths.target - Path Units. May 9 00:06:44.520879 systemd[1]: Reached target timers.target - Timer Units. May 9 00:06:44.522888 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 9 00:06:44.525826 systemd[1]: Starting docker.socket - Docker Socket for the API... May 9 00:06:44.534990 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 9 00:06:44.537652 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 9 00:06:44.539276 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 9 00:06:44.540516 systemd[1]: Reached target sockets.target - Socket Units. May 9 00:06:44.541509 systemd[1]: Reached target basic.target - Basic System. May 9 00:06:44.542525 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 9 00:06:44.542555 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 9 00:06:44.543521 systemd[1]: Starting containerd.service - containerd container runtime... May 9 00:06:44.545609 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 9 00:06:44.550273 lvm[1405]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 9 00:06:44.550706 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 9 00:06:44.552852 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 9 00:06:44.554185 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 9 00:06:44.557746 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 9 00:06:44.560892 jq[1408]: false May 9 00:06:44.562837 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 9 00:06:44.567743 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 9 00:06:44.571873 systemd[1]: Starting systemd-logind.service - User Login Management... May 9 00:06:44.574138 extend-filesystems[1409]: Found loop2 May 9 00:06:44.574138 extend-filesystems[1409]: Found loop3 May 9 00:06:44.574138 extend-filesystems[1409]: Found sr0 May 9 00:06:44.574138 extend-filesystems[1409]: Found vda May 9 00:06:44.574138 extend-filesystems[1409]: Found vda1 May 9 00:06:44.574138 extend-filesystems[1409]: Found vda2 May 9 00:06:44.574138 extend-filesystems[1409]: Found vda3 May 9 00:06:44.574138 extend-filesystems[1409]: Found usr May 9 00:06:44.574138 extend-filesystems[1409]: Found vda4 May 9 00:06:44.574138 extend-filesystems[1409]: Found vda6 May 9 00:06:44.574138 extend-filesystems[1409]: Found vda7 May 9 00:06:44.574138 extend-filesystems[1409]: Found vda9 May 9 00:06:44.574138 extend-filesystems[1409]: Checking size of /dev/vda9 May 9 00:06:44.573293 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 9 00:06:44.601817 dbus-daemon[1407]: [system] SELinux support is enabled May 9 00:06:44.573700 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 9 00:06:44.619464 extend-filesystems[1409]: Old size kept for /dev/vda9 May 9 00:06:44.575837 systemd[1]: Starting update-engine.service - Update Engine... May 9 00:06:44.624390 update_engine[1418]: I20250509 00:06:44.612458 1418 main.cc:92] Flatcar Update Engine starting May 9 00:06:44.624390 update_engine[1418]: I20250509 00:06:44.615092 1418 update_check_scheduler.cc:74] Next update check in 6m38s May 9 00:06:44.578412 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 9 00:06:44.626827 jq[1420]: true May 9 00:06:44.581174 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 9 00:06:44.584583 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 9 00:06:44.627178 jq[1425]: true May 9 00:06:44.585082 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 9 00:06:44.585422 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 9 00:06:44.585624 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 9 00:06:44.607064 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 9 00:06:44.618204 (ntainerd)[1435]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 9 00:06:44.618401 systemd[1]: extend-filesystems.service: Deactivated successfully. May 9 00:06:44.618641 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 9 00:06:44.621290 systemd[1]: motdgen.service: Deactivated successfully. May 9 00:06:44.621526 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 9 00:06:44.642630 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1373) May 9 00:06:44.645390 systemd[1]: Started update-engine.service - Update Engine. May 9 00:06:44.649325 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 9 00:06:44.651649 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 9 00:06:44.652393 systemd-logind[1414]: Watching system buttons on /dev/input/event1 (Power Button) May 9 00:06:44.652425 systemd-logind[1414]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) May 9 00:06:44.653552 systemd-logind[1414]: New seat seat0. May 9 00:06:44.653587 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 9 00:06:44.653631 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 9 00:06:44.660785 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 9 00:06:44.663962 systemd[1]: Started systemd-logind.service - User Login Management. May 9 00:06:44.696918 bash[1457]: Updated "/home/core/.ssh/authorized_keys" May 9 00:06:44.697617 locksmithd[1447]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 9 00:06:44.698243 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 9 00:06:44.701351 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 9 00:06:44.799741 sshd_keygen[1422]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 9 00:06:44.818060 containerd[1435]: time="2025-05-09T00:06:44.817957643Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 May 9 00:06:44.824882 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 9 00:06:44.838942 systemd[1]: Starting issuegen.service - Generate /run/issue... May 9 00:06:44.842328 containerd[1435]: time="2025-05-09T00:06:44.842288070Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.843982 containerd[1435]: time="2025-05-09T00:06:44.843935270Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 9 00:06:44.843982 containerd[1435]: time="2025-05-09T00:06:44.843969023Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 9 00:06:44.844034 containerd[1435]: time="2025-05-09T00:06:44.843986686Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 9 00:06:44.844183 containerd[1435]: time="2025-05-09T00:06:44.844165461Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844243077Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844317256Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844328908Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844525617Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844538732Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844550934Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844559971Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844698872Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.845035 containerd[1435]: time="2025-05-09T00:06:44.844929645Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 9 00:06:44.845221 containerd[1435]: time="2025-05-09T00:06:44.845076881Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:06:44.845221 containerd[1435]: time="2025-05-09T00:06:44.845089364Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 9 00:06:44.845221 containerd[1435]: time="2025-05-09T00:06:44.845179874Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 9 00:06:44.845272 containerd[1435]: time="2025-05-09T00:06:44.845242772Z" level=info msg="metadata content store policy set" policy=shared May 9 00:06:44.846631 systemd[1]: issuegen.service: Deactivated successfully. May 9 00:06:44.846884 systemd[1]: Finished issuegen.service - Generate /run/issue. May 9 00:06:44.850685 containerd[1435]: time="2025-05-09T00:06:44.850651838Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 9 00:06:44.850737 containerd[1435]: time="2025-05-09T00:06:44.850715918Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 9 00:06:44.850756 containerd[1435]: time="2025-05-09T00:06:44.850741847Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 9 00:06:44.850775 containerd[1435]: time="2025-05-09T00:06:44.850765451Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 9 00:06:44.850799 containerd[1435]: time="2025-05-09T00:06:44.850786591Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 9 00:06:44.850963 containerd[1435]: time="2025-05-09T00:06:44.850939548Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 9 00:06:44.851285 containerd[1435]: time="2025-05-09T00:06:44.851244359Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 9 00:06:44.851417 containerd[1435]: time="2025-05-09T00:06:44.851395252Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 9 00:06:44.851437 containerd[1435]: time="2025-05-09T00:06:44.851420740Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 9 00:06:44.851455 containerd[1435]: time="2025-05-09T00:06:44.851438453Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 9 00:06:44.851473 containerd[1435]: time="2025-05-09T00:06:44.851456858Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851498 containerd[1435]: time="2025-05-09T00:06:44.851473489Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851498 containerd[1435]: time="2025-05-09T00:06:44.851489489Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851532 containerd[1435]: time="2025-05-09T00:06:44.851506271Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851532 containerd[1435]: time="2025-05-09T00:06:44.851524355Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851565 containerd[1435]: time="2025-05-09T00:06:44.851540515Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851565 containerd[1435]: time="2025-05-09T00:06:44.851556264Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851617 containerd[1435]: time="2025-05-09T00:06:44.851571172Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 9 00:06:44.851647 containerd[1435]: time="2025-05-09T00:06:44.851628019Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851678 containerd[1435]: time="2025-05-09T00:06:44.851664287Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851707 containerd[1435]: time="2025-05-09T00:06:44.851686649Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851707 containerd[1435]: time="2025-05-09T00:06:44.851702188Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851747 containerd[1435]: time="2025-05-09T00:06:44.851718930Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851747 containerd[1435]: time="2025-05-09T00:06:44.851737564Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851842 containerd[1435]: time="2025-05-09T00:06:44.851753995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851842 containerd[1435]: time="2025-05-09T00:06:44.851770256Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851842 containerd[1435]: time="2025-05-09T00:06:44.851786466Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851842 containerd[1435]: time="2025-05-09T00:06:44.851805141Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851842 containerd[1435]: time="2025-05-09T00:06:44.851820370Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851842 containerd[1435]: time="2025-05-09T00:06:44.851837502Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851940 containerd[1435]: time="2025-05-09T00:06:44.851853051Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851940 containerd[1435]: time="2025-05-09T00:06:44.851871866Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 9 00:06:44.851940 containerd[1435]: time="2025-05-09T00:06:44.851897655Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851940 containerd[1435]: time="2025-05-09T00:06:44.851914777Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 9 00:06:44.851940 containerd[1435]: time="2025-05-09T00:06:44.851929324Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 9 00:06:44.852026 containerd[1435]: time="2025-05-09T00:06:44.851992212Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 9 00:06:44.852026 containerd[1435]: time="2025-05-09T00:06:44.852014584Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 May 9 00:06:44.852067 containerd[1435]: time="2025-05-09T00:06:44.852027578Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 9 00:06:44.852067 containerd[1435]: time="2025-05-09T00:06:44.852043578Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 9 00:06:44.852067 containerd[1435]: time="2025-05-09T00:06:44.852058436Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 9 00:06:44.852118 containerd[1435]: time="2025-05-09T00:06:44.852088493Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 9 00:06:44.852118 containerd[1435]: time="2025-05-09T00:06:44.852102509Z" level=info msg="NRI interface is disabled by configuration." May 9 00:06:44.852152 containerd[1435]: time="2025-05-09T00:06:44.852117637Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 9 00:06:44.852606 containerd[1435]: time="2025-05-09T00:06:44.852477542Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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 9 00:06:44.853667 containerd[1435]: time="2025-05-09T00:06:44.853630114Z" level=info msg="Connect containerd service" May 9 00:06:44.853753 containerd[1435]: time="2025-05-09T00:06:44.853736835Z" level=info msg="using legacy CRI server" May 9 00:06:44.853753 containerd[1435]: time="2025-05-09T00:06:44.853750891Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 9 00:06:44.853878 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 9 00:06:44.854029 containerd[1435]: time="2025-05-09T00:06:44.853886185Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 9 00:06:44.854616 containerd[1435]: time="2025-05-09T00:06:44.854568605Z" 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 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.854842508Z" level=info msg="Start subscribing containerd event" May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.854897361Z" level=info msg="Start recovering state" May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.854924031Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.854976239Z" level=info msg=serving... address=/run/containerd/containerd.sock May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.854980988Z" level=info msg="Start event monitor" May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.855032314Z" level=info msg="Start snapshots syncer" May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.855041892Z" level=info msg="Start cni network conf syncer for default" May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.855054606Z" level=info msg="Start streaming server" May 9 00:06:44.855281 containerd[1435]: time="2025-05-09T00:06:44.855135047Z" level=info msg="containerd successfully booted in 0.038322s" May 9 00:06:44.855282 systemd[1]: Started containerd.service - containerd container runtime. May 9 00:06:44.880762 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 9 00:06:44.896889 systemd[1]: Started getty@tty1.service - Getty on tty1. May 9 00:06:44.899209 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 9 00:06:44.900627 systemd[1]: Reached target getty.target - Login Prompts. May 9 00:06:45.271778 systemd-networkd[1365]: eth0: Gained IPv6LL May 9 00:06:45.275340 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 9 00:06:45.277416 systemd[1]: Reached target network-online.target - Network is Online. May 9 00:06:45.292945 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 9 00:06:45.295425 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 9 00:06:45.318474 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 9 00:06:45.320126 systemd[1]: coreos-metadata.service: Deactivated successfully. May 9 00:06:45.320337 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 9 00:06:45.322573 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 9 00:06:45.322820 systemd[1]: Reached target multi-user.target - Multi-User System. May 9 00:06:45.324286 systemd[1]: Startup finished in 739ms (kernel) + 3.913s (initrd) + 2.750s (userspace) = 7.403s. May 9 00:06:51.612740 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 9 00:06:51.614027 systemd[1]: Started sshd@0-10.0.0.84:22-10.0.0.1:45162.service - OpenSSH per-connection server daemon (10.0.0.1:45162). May 9 00:06:51.662978 sshd[1508]: Accepted publickey for core from 10.0.0.1 port 45162 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:51.664875 sshd-session[1508]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:51.674216 systemd-logind[1414]: New session 1 of user core. May 9 00:06:51.675792 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 9 00:06:51.687869 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 9 00:06:51.700889 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 9 00:06:51.716816 systemd[1]: Starting user@500.service - User Manager for UID 500... May 9 00:06:51.719818 (systemd)[1512]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 9 00:06:51.835860 systemd[1512]: Queued start job for default target default.target. May 9 00:06:51.848120 systemd[1512]: Created slice app.slice - User Application Slice. May 9 00:06:51.848155 systemd[1512]: Reached target paths.target - Paths. May 9 00:06:51.848172 systemd[1512]: Reached target timers.target - Timers. May 9 00:06:51.850012 systemd[1512]: Starting dbus.socket - D-Bus User Message Bus Socket... May 9 00:06:51.862790 systemd[1512]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 9 00:06:51.862958 systemd[1512]: Reached target sockets.target - Sockets. May 9 00:06:51.862979 systemd[1512]: Reached target basic.target - Basic System. May 9 00:06:51.863034 systemd[1512]: Reached target default.target - Main User Target. May 9 00:06:51.863072 systemd[1512]: Startup finished in 136ms. May 9 00:06:51.863265 systemd[1]: Started user@500.service - User Manager for UID 500. May 9 00:06:51.865307 systemd[1]: Started session-1.scope - Session 1 of User core. May 9 00:06:51.932337 systemd[1]: Started sshd@1-10.0.0.84:22-10.0.0.1:45176.service - OpenSSH per-connection server daemon (10.0.0.1:45176). May 9 00:06:51.981800 sshd[1523]: Accepted publickey for core from 10.0.0.1 port 45176 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:51.983411 sshd-session[1523]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:51.987810 systemd-logind[1414]: New session 2 of user core. May 9 00:06:51.997771 systemd[1]: Started session-2.scope - Session 2 of User core. May 9 00:06:52.053663 sshd[1525]: Connection closed by 10.0.0.1 port 45176 May 9 00:06:52.054049 sshd-session[1523]: pam_unix(sshd:session): session closed for user core May 9 00:06:52.065639 systemd[1]: sshd@1-10.0.0.84:22-10.0.0.1:45176.service: Deactivated successfully. May 9 00:06:52.067378 systemd[1]: session-2.scope: Deactivated successfully. May 9 00:06:52.068834 systemd-logind[1414]: Session 2 logged out. Waiting for processes to exit. May 9 00:06:52.078048 systemd[1]: Started sshd@2-10.0.0.84:22-10.0.0.1:45188.service - OpenSSH per-connection server daemon (10.0.0.1:45188). May 9 00:06:52.079244 systemd-logind[1414]: Removed session 2. May 9 00:06:52.125288 sshd[1530]: Accepted publickey for core from 10.0.0.1 port 45188 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:52.126976 sshd-session[1530]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:52.131168 systemd-logind[1414]: New session 3 of user core. May 9 00:06:52.141810 systemd[1]: Started session-3.scope - Session 3 of User core. May 9 00:06:52.192281 sshd[1532]: Connection closed by 10.0.0.1 port 45188 May 9 00:06:52.192797 sshd-session[1530]: pam_unix(sshd:session): session closed for user core May 9 00:06:52.204615 systemd[1]: sshd@2-10.0.0.84:22-10.0.0.1:45188.service: Deactivated successfully. May 9 00:06:52.206086 systemd[1]: session-3.scope: Deactivated successfully. May 9 00:06:52.207484 systemd-logind[1414]: Session 3 logged out. Waiting for processes to exit. May 9 00:06:52.208697 systemd[1]: Started sshd@3-10.0.0.84:22-10.0.0.1:45194.service - OpenSSH per-connection server daemon (10.0.0.1:45194). May 9 00:06:52.209519 systemd-logind[1414]: Removed session 3. May 9 00:06:52.250830 sshd[1537]: Accepted publickey for core from 10.0.0.1 port 45194 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:52.252279 sshd-session[1537]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:52.256281 systemd-logind[1414]: New session 4 of user core. May 9 00:06:52.272710 systemd[1]: Started session-4.scope - Session 4 of User core. May 9 00:06:52.327157 sshd[1539]: Connection closed by 10.0.0.1 port 45194 May 9 00:06:52.327560 sshd-session[1537]: pam_unix(sshd:session): session closed for user core May 9 00:06:52.334158 systemd[1]: sshd@3-10.0.0.84:22-10.0.0.1:45194.service: Deactivated successfully. May 9 00:06:52.335835 systemd[1]: session-4.scope: Deactivated successfully. May 9 00:06:52.337018 systemd-logind[1414]: Session 4 logged out. Waiting for processes to exit. May 9 00:06:52.350824 systemd[1]: Started sshd@4-10.0.0.84:22-10.0.0.1:45198.service - OpenSSH per-connection server daemon (10.0.0.1:45198). May 9 00:06:52.351730 systemd-logind[1414]: Removed session 4. May 9 00:06:52.389710 sshd[1544]: Accepted publickey for core from 10.0.0.1 port 45198 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:52.391212 sshd-session[1544]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:52.395398 systemd-logind[1414]: New session 5 of user core. May 9 00:06:52.405866 systemd[1]: Started session-5.scope - Session 5 of User core. May 9 00:06:52.466466 sudo[1547]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 9 00:06:52.466894 sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 00:06:52.487971 sudo[1547]: pam_unix(sudo:session): session closed for user root May 9 00:06:52.489832 sshd[1546]: Connection closed by 10.0.0.1 port 45198 May 9 00:06:52.490337 sshd-session[1544]: pam_unix(sshd:session): session closed for user core May 9 00:06:52.498540 systemd[1]: sshd@4-10.0.0.84:22-10.0.0.1:45198.service: Deactivated successfully. May 9 00:06:52.500282 systemd[1]: session-5.scope: Deactivated successfully. May 9 00:06:52.501969 systemd-logind[1414]: Session 5 logged out. Waiting for processes to exit. May 9 00:06:52.519058 systemd[1]: Started sshd@5-10.0.0.84:22-10.0.0.1:45208.service - OpenSSH per-connection server daemon (10.0.0.1:45208). May 9 00:06:52.520260 systemd-logind[1414]: Removed session 5. May 9 00:06:52.559165 sshd[1552]: Accepted publickey for core from 10.0.0.1 port 45208 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:52.560932 sshd-session[1552]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:52.564758 systemd-logind[1414]: New session 6 of user core. May 9 00:06:52.574731 systemd[1]: Started session-6.scope - Session 6 of User core. May 9 00:06:52.627360 sudo[1556]: 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 9 00:06:52.627715 sudo[1556]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 00:06:52.631084 sudo[1556]: pam_unix(sudo:session): session closed for user root May 9 00:06:52.636609 sudo[1555]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 9 00:06:52.636939 sudo[1555]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 00:06:52.656912 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 9 00:06:52.690726 augenrules[1578]: No rules May 9 00:06:52.692501 systemd[1]: audit-rules.service: Deactivated successfully. May 9 00:06:52.692742 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 9 00:06:52.693964 sudo[1555]: pam_unix(sudo:session): session closed for user root May 9 00:06:52.695698 sshd[1554]: Connection closed by 10.0.0.1 port 45208 May 9 00:06:52.696053 sshd-session[1552]: pam_unix(sshd:session): session closed for user core May 9 00:06:52.703375 systemd[1]: sshd@5-10.0.0.84:22-10.0.0.1:45208.service: Deactivated successfully. May 9 00:06:52.705153 systemd[1]: session-6.scope: Deactivated successfully. May 9 00:06:52.706479 systemd-logind[1414]: Session 6 logged out. Waiting for processes to exit. May 9 00:06:52.717928 systemd[1]: Started sshd@6-10.0.0.84:22-10.0.0.1:45214.service - OpenSSH per-connection server daemon (10.0.0.1:45214). May 9 00:06:52.718954 systemd-logind[1414]: Removed session 6. May 9 00:06:52.756349 sshd[1586]: Accepted publickey for core from 10.0.0.1 port 45214 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:52.757935 sshd-session[1586]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:52.762112 systemd-logind[1414]: New session 7 of user core. May 9 00:06:52.770724 systemd[1]: Started session-7.scope - Session 7 of User core. May 9 00:06:52.836858 systemd[1]: Starting docker.service - Docker Application Container Engine... May 9 00:06:52.836996 (dockerd)[1590]: 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 9 00:06:53.352758 dockerd[1590]: time="2025-05-09T00:06:53.352661168Z" level=info msg="Starting up" May 9 00:06:54.183519 dockerd[1590]: time="2025-05-09T00:06:54.183468479Z" level=info msg="Loading containers: start." May 9 00:06:54.556625 kernel: Initializing XFRM netlink socket May 9 00:06:54.642748 systemd-networkd[1365]: docker0: Link UP May 9 00:06:54.684135 dockerd[1590]: time="2025-05-09T00:06:54.684076809Z" level=info msg="Loading containers: done." May 9 00:06:54.703793 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2636843321-merged.mount: Deactivated successfully. May 9 00:06:54.704887 dockerd[1590]: time="2025-05-09T00:06:54.704849813Z" 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 9 00:06:54.704970 dockerd[1590]: time="2025-05-09T00:06:54.704950491Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 May 9 00:06:54.705090 dockerd[1590]: time="2025-05-09T00:06:54.705072448Z" level=info msg="Daemon has completed initialization" May 9 00:06:54.740436 dockerd[1590]: time="2025-05-09T00:06:54.740374630Z" level=info msg="API listen on /run/docker.sock" May 9 00:06:54.740576 systemd[1]: Started docker.service - Docker Application Container Engine. May 9 00:06:54.752775 sshd[1588]: Connection closed by 10.0.0.1 port 45214 May 9 00:06:54.753114 sshd-session[1586]: pam_unix(sshd:session): session closed for user core May 9 00:06:54.764274 systemd[1]: sshd@6-10.0.0.84:22-10.0.0.1:45214.service: Deactivated successfully. May 9 00:06:54.765987 systemd[1]: session-7.scope: Deactivated successfully. May 9 00:06:54.767202 systemd-logind[1414]: Session 7 logged out. Waiting for processes to exit. May 9 00:06:54.779874 systemd[1]: Started sshd@7-10.0.0.84:22-10.0.0.1:45226.service - OpenSSH per-connection server daemon (10.0.0.1:45226). May 9 00:06:54.780816 systemd-logind[1414]: Removed session 7. May 9 00:06:54.818573 sshd[1782]: Accepted publickey for core from 10.0.0.1 port 45226 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:54.820073 sshd-session[1782]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:54.823869 systemd-logind[1414]: New session 8 of user core. May 9 00:06:54.833706 systemd[1]: Started session-8.scope - Session 8 of User core. May 9 00:06:56.644974 systemd[1]: var-lib-docker-overlay2-f287952547d8f63cc36db3e196c144a7bee20e7d10234f6ac50d85e8dde20069\x2dinit-merged.mount: Deactivated successfully. May 9 00:06:56.690677 kernel: docker0: port 1(vethb47da95) entered blocking state May 9 00:06:56.690832 kernel: docker0: port 1(vethb47da95) entered disabled state May 9 00:06:56.690855 kernel: vethb47da95: entered allmulticast mode May 9 00:06:56.692217 kernel: vethb47da95: entered promiscuous mode May 9 00:06:56.692510 systemd-networkd[1365]: vethb47da95: Link UP May 9 00:06:57.021852 containerd[1435]: time="2025-05-09T00:06:57.021580726Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 9 00:06:57.021852 containerd[1435]: time="2025-05-09T00:06:57.021748767Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 9 00:06:57.021852 containerd[1435]: time="2025-05-09T00:06:57.021767716Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 9 00:06:57.022342 containerd[1435]: time="2025-05-09T00:06:57.021943545Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 9 00:06:57.056746 systemd[1]: Started docker-cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c.scope - libcontainer container cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c. May 9 00:06:57.211628 kernel: eth0: renamed from vetheed355d May 9 00:06:57.225028 kernel: docker0: port 1(vethb47da95) entered blocking state May 9 00:06:57.225127 kernel: docker0: port 1(vethb47da95) entered forwarding state May 9 00:06:57.225115 systemd-networkd[1365]: vethb47da95: Gained carrier May 9 00:06:57.225397 systemd-networkd[1365]: docker0: Gained carrier May 9 00:06:57.266208 systemd-resolved[1271]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 9 00:06:57.406645 sshd[1784]: Connection closed by 10.0.0.1 port 45226 May 9 00:06:57.407243 sshd-session[1782]: pam_unix(sshd:session): session closed for user core May 9 00:06:57.420367 systemd[1]: sshd@7-10.0.0.84:22-10.0.0.1:45226.service: Deactivated successfully. May 9 00:06:57.422150 systemd[1]: session-8.scope: Deactivated successfully. May 9 00:06:57.422822 systemd-logind[1414]: Session 8 logged out. Waiting for processes to exit. May 9 00:06:57.439035 systemd[1]: Started sshd@8-10.0.0.84:22-10.0.0.1:57090.service - OpenSSH per-connection server daemon (10.0.0.1:57090). May 9 00:06:57.439953 systemd-logind[1414]: Removed session 8. May 9 00:06:57.484133 sshd[1861]: Accepted publickey for core from 10.0.0.1 port 57090 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:57.485939 sshd-session[1861]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:57.490233 systemd-logind[1414]: New session 9 of user core. May 9 00:06:57.506834 systemd[1]: Started session-9.scope - Session 9 of User core. May 9 00:06:57.565042 sshd[1863]: Connection closed by 10.0.0.1 port 57090 May 9 00:06:57.565398 sshd-session[1861]: pam_unix(sshd:session): session closed for user core May 9 00:06:57.579743 systemd[1]: sshd@8-10.0.0.84:22-10.0.0.1:57090.service: Deactivated successfully. May 9 00:06:57.581619 systemd[1]: session-9.scope: Deactivated successfully. May 9 00:06:57.582370 systemd-logind[1414]: Session 9 logged out. Waiting for processes to exit. May 9 00:06:57.595066 systemd[1]: Started sshd@9-10.0.0.84:22-10.0.0.1:57102.service - OpenSSH per-connection server daemon (10.0.0.1:57102). May 9 00:06:57.595731 systemd-logind[1414]: Removed session 9. May 9 00:06:57.634362 sshd[1868]: Accepted publickey for core from 10.0.0.1 port 57102 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:57.636361 sshd-session[1868]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:57.640985 systemd-logind[1414]: New session 10 of user core. May 9 00:06:57.651765 systemd[1]: Started session-10.scope - Session 10 of User core. May 9 00:06:57.705677 sudo[1871]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1435 May 9 00:06:57.706049 sudo[1871]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 00:06:57.710513 sudo[1871]: pam_unix(sudo:session): session closed for user root May 9 00:06:57.710785 containerd[1435]: time="2025-05-09T00:06:57.710644325Z" level=info msg="Stop CRI service" May 9 00:06:57.711035 dockerd[1590]: time="2025-05-09T00:06:57.710970850Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 9 00:06:57.711035 dockerd[1590]: time="2025-05-09T00:06:57.711022300Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 9 00:06:57.711401 dockerd[1590]: time="2025-05-09T00:06:57.711003152Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 9 00:06:57.711401 dockerd[1590]: time="2025-05-09T00:06:57.711200212Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 9 00:06:57.711589 containerd[1435]: time="2025-05-09T00:06:57.711501892Z" level=info msg="Stop CRI service" May 9 00:06:57.711589 containerd[1435]: time="2025-05-09T00:06:57.711550419Z" level=info msg="Event monitor stopped" May 9 00:06:57.711589 containerd[1435]: time="2025-05-09T00:06:57.711567826Z" level=info msg="Stream server stopped" May 9 00:06:57.712064 sshd[1870]: Connection closed by 10.0.0.1 port 57102 May 9 00:06:57.712740 sshd-session[1868]: pam_unix(sshd:session): session closed for user core May 9 00:06:57.725460 systemd[1]: containerd.service: Deactivated successfully. May 9 00:06:57.725528 systemd[1]: containerd.service: Unit process 1815 (containerd-shim) remains running after unit stopped. May 9 00:06:57.726207 systemd[1]: sshd@9-10.0.0.84:22-10.0.0.1:57102.service: Deactivated successfully. May 9 00:06:57.727843 systemd[1]: session-10.scope: Deactivated successfully. May 9 00:06:57.728460 systemd-logind[1414]: Session 10 logged out. Waiting for processes to exit. May 9 00:06:57.731161 systemd[1]: Started sshd@10-10.0.0.84:22-10.0.0.1:57114.service - OpenSSH per-connection server daemon (10.0.0.1:57114). May 9 00:06:57.731623 systemd-logind[1414]: Removed session 10. May 9 00:06:57.772775 sshd[1877]: Accepted publickey for core from 10.0.0.1 port 57114 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:06:57.774331 sshd-session[1877]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:06:57.781250 systemd-logind[1414]: New session 11 of user core. May 9 00:06:57.787959 systemd[1]: Started session-11.scope - Session 11 of User core. May 9 00:06:57.846174 sshd[1879]: Connection closed by 10.0.0.1 port 57114 May 9 00:06:57.846587 sshd-session[1877]: pam_unix(sshd:session): session closed for user core May 9 00:06:57.850637 systemd[1]: sshd@10-10.0.0.84:22-10.0.0.1:57114.service: Deactivated successfully. May 9 00:06:57.852376 systemd[1]: session-11.scope: Deactivated successfully. May 9 00:06:57.853044 systemd-logind[1414]: Session 11 logged out. Waiting for processes to exit. May 9 00:06:57.853963 systemd-logind[1414]: Removed session 11. May 9 00:06:58.775820 systemd-networkd[1365]: docker0: Gained IPv6LL May 9 00:06:59.159982 systemd-networkd[1365]: vethb47da95: Gained IPv6LL May 9 00:07:02.779173 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. May 9 00:07:02.779707 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 9 00:07:02.779980 dockerd[1590]: time="2025-05-09T00:07:02.779808772Z" level=info msg="Processing signal 'terminated'" May 9 00:07:03.853276 systemd[1]: Started sshd@11-10.0.0.84:22-10.0.0.1:57124.service - OpenSSH per-connection server daemon (10.0.0.1:57124). May 9 00:07:03.896821 sshd[1884]: Accepted publickey for core from 10.0.0.1 port 57124 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:03.898421 sshd-session[1884]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:03.902444 systemd-logind[1414]: New session 12 of user core. May 9 00:07:03.911716 systemd[1]: Started session-12.scope - Session 12 of User core. May 9 00:07:03.965269 sshd[1886]: Connection closed by 10.0.0.1 port 57124 May 9 00:07:03.965576 sshd-session[1884]: pam_unix(sshd:session): session closed for user core May 9 00:07:03.968566 systemd[1]: sshd@11-10.0.0.84:22-10.0.0.1:57124.service: Deactivated successfully. May 9 00:07:03.970414 systemd[1]: session-12.scope: Deactivated successfully. May 9 00:07:03.971095 systemd-logind[1414]: Session 12 logged out. Waiting for processes to exit. May 9 00:07:03.971834 systemd-logind[1414]: Removed session 12. May 9 00:07:04.782415 dockerd[1590]: time="2025-05-09T00:07:04.782350406Z" level=error msg="Error sending stop (signal 15) to container" container=cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c error="Cannot kill container cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" May 9 00:07:04.782415 dockerd[1590]: time="2025-05-09T00:07:04.782406931Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c May 9 00:07:09.973317 systemd[1]: Started sshd@12-10.0.0.84:22-10.0.0.1:47060.service - OpenSSH per-connection server daemon (10.0.0.1:47060). May 9 00:07:10.015682 sshd[1891]: Accepted publickey for core from 10.0.0.1 port 47060 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:10.017447 sshd-session[1891]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:10.021395 systemd-logind[1414]: New session 13 of user core. May 9 00:07:10.030768 systemd[1]: Started session-13.scope - Session 13 of User core. May 9 00:07:10.086193 sshd[1893]: Connection closed by 10.0.0.1 port 47060 May 9 00:07:10.086541 sshd-session[1891]: pam_unix(sshd:session): session closed for user core May 9 00:07:10.090714 systemd[1]: sshd@12-10.0.0.84:22-10.0.0.1:47060.service: Deactivated successfully. May 9 00:07:10.092536 systemd[1]: session-13.scope: Deactivated successfully. May 9 00:07:10.093095 systemd-logind[1414]: Session 13 logged out. Waiting for processes to exit. May 9 00:07:10.094052 systemd-logind[1414]: Removed session 13. May 9 00:07:14.783209 dockerd[1590]: time="2025-05-09T00:07:14.783122304Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c error="context deadline exceeded" May 9 00:07:14.784019 systemd[1]: docker-cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c.scope: Deactivated successfully. May 9 00:07:16.095667 systemd[1]: Started sshd@13-10.0.0.84:22-10.0.0.1:47072.service - OpenSSH per-connection server daemon (10.0.0.1:47072). May 9 00:07:16.142961 sshd[1898]: Accepted publickey for core from 10.0.0.1 port 47072 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:16.144709 sshd-session[1898]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:16.149111 systemd-logind[1414]: New session 14 of user core. May 9 00:07:16.158811 systemd[1]: Started session-14.scope - Session 14 of User core. May 9 00:07:16.215557 sshd[1900]: Connection closed by 10.0.0.1 port 47072 May 9 00:07:16.215947 sshd-session[1898]: pam_unix(sshd:session): session closed for user core May 9 00:07:16.220842 systemd[1]: sshd@13-10.0.0.84:22-10.0.0.1:47072.service: Deactivated successfully. May 9 00:07:16.222831 systemd[1]: session-14.scope: Deactivated successfully. May 9 00:07:16.223547 systemd-logind[1414]: Session 14 logged out. Waiting for processes to exit. May 9 00:07:16.224434 systemd-logind[1414]: Removed session 14. May 9 00:07:17.781161 dockerd[1590]: time="2025-05-09T00:07:17.781093648Z" level=error msg="Force shutdown daemon" May 9 00:07:17.781583 dockerd[1590]: time="2025-05-09T00:07:17.781320123Z" level=info msg="Daemon shutdown complete" May 9 00:07:17.788685 systemd[1]: docker.service: Deactivated successfully. May 9 00:07:17.789018 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 9 00:07:17.789075 systemd[1]: docker.service: Consumed 1.443s CPU time. May 9 00:07:17.789618 systemd[1]: docker.socket: Deactivated successfully. May 9 00:07:17.789930 systemd[1]: Closed docker.socket - Docker Socket for the API. May 9 00:07:17.789974 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 9 00:07:17.791935 systemd[1]: Starting docker.socket - Docker Socket for the API... May 9 00:07:17.792124 systemd[1]: containerd.service: Found left-over process 1815 (containerd-shim) in control group while starting unit. Ignoring. May 9 00:07:17.792132 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 9 00:07:17.801926 systemd[1]: Starting containerd.service - containerd container runtime... May 9 00:07:17.803014 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 9 00:07:17.814357 systemd[1]: containerd.service: Found left-over process 1815 (containerd-shim) in control group while starting unit. Ignoring. May 9 00:07:17.814369 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 9 00:07:17.820744 (ntainerd)[1910]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 9 00:07:17.840332 containerd[1910]: time="2025-05-09T00:07:17.840251513Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 May 9 00:07:17.862391 containerd[1910]: time="2025-05-09T00:07:17.862321984Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864263 containerd[1910]: time="2025-05-09T00:07:17.864212748Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:17.864263 containerd[1910]: time="2025-05-09T00:07:17.864252003Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 9 00:07:17.864335 containerd[1910]: time="2025-05-09T00:07:17.864272121Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 9 00:07:17.864335 containerd[1910]: time="2025-05-09T00:07:17.864305026Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 9 00:07:17.864335 containerd[1910]: time="2025-05-09T00:07:17.864319177Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864390 containerd[1910]: time="2025-05-09T00:07:17.864342089Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:17.864390 containerd[1910]: time="2025-05-09T00:07:17.864357861Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864574 containerd[1910]: time="2025-05-09T00:07:17.864544080Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 May 9 00:07:17.864574 containerd[1910]: time="2025-05-09T00:07:17.864561814Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864632 containerd[1910]: time="2025-05-09T00:07:17.864574652Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:17.864632 containerd[1910]: time="2025-05-09T00:07:17.864585227Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864632 containerd[1910]: time="2025-05-09T00:07:17.864623371Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864773 containerd[1910]: time="2025-05-09T00:07:17.864743968Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:17.864940 containerd[1910]: time="2025-05-09T00:07:17.864905323Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:17.864940 containerd[1910]: time="2025-05-09T00:07:17.864930408Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 9 00:07:17.864985 containerd[1910]: time="2025-05-09T00:07:17.864957115Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 9 00:07:17.864985 containerd[1910]: time="2025-05-09T00:07:17.864977794Z" level=info msg="metadata content store policy set" policy=shared May 9 00:07:17.865146 containerd[1910]: time="2025-05-09T00:07:17.865129045Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 9 00:07:17.865185 containerd[1910]: time="2025-05-09T00:07:17.865159477Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 9 00:07:17.865185 containerd[1910]: time="2025-05-09T00:07:17.865176721Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 9 00:07:17.865233 containerd[1910]: time="2025-05-09T00:07:17.865193344Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 9 00:07:17.865233 containerd[1910]: time="2025-05-09T00:07:17.865208275Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 9 00:07:17.865296 containerd[1910]: time="2025-05-09T00:07:17.865277491Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 9 00:07:17.865531 containerd[1910]: time="2025-05-09T00:07:17.865503386Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 9 00:07:17.873982 containerd[1910]: time="2025-05-09T00:07:17.873939340Z" level=info msg="cleaning leaked shim process" id=cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c namespace=moby May 9 00:07:17.885898 containerd[1910]: time="2025-05-09T00:07:17.885806195Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 9 00:07:17.886299 containerd[1910]: time="2025-05-09T00:07:17.886166566Z" level=info msg="shim disconnected" id=cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c namespace=moby May 9 00:07:17.886299 containerd[1910]: time="2025-05-09T00:07:17.886240249Z" level=warning msg="cleaning up after shim disconnected" id=cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c namespace=moby May 9 00:07:17.886299 containerd[1910]: time="2025-05-09T00:07:17.886250794Z" level=info msg="cleaning up dead shim" namespace=moby May 9 00:07:17.902182 containerd[1910]: time="2025-05-09T00:07:17.902131300Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 9 00:07:17.902182 containerd[1910]: time="2025-05-09T00:07:17.902176684Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902198654Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902215027Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902229748Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902242906Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902258668Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902273709Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902290212Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902302239Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902314185Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 9 00:07:17.902339 containerd[1910]: time="2025-05-09T00:07:17.902336817Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902356324Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902370324Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902384142Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902402228Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902418341Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902429826Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902442043Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902456223Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902470973Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902483902Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902496058Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902513844Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902527 containerd[1910]: time="2025-05-09T00:07:17.902528804Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902551726Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902564594Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902578674Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902658945Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902679435Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902691391Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902703398Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902712900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902725197Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902735812Z" level=info msg="NRI interface is disabled by configuration." May 9 00:07:17.902785 containerd[1910]: time="2025-05-09T00:07:17.902746397Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 9 00:07:17.903091 containerd[1910]: time="2025-05-09T00:07:17.903035921Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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 9 00:07:17.903091 containerd[1910]: time="2025-05-09T00:07:17.903087482Z" level=info msg="Connect containerd service" May 9 00:07:17.903229 containerd[1910]: time="2025-05-09T00:07:17.903119648Z" level=info msg="using legacy CRI server" May 9 00:07:17.903229 containerd[1910]: time="2025-05-09T00:07:17.903127058Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 9 00:07:17.903270 containerd[1910]: time="2025-05-09T00:07:17.903232045Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 9 00:07:17.903770 containerd[1910]: time="2025-05-09T00:07:17.903742145Z" 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 9 00:07:17.903959 containerd[1910]: time="2025-05-09T00:07:17.903906834Z" level=info msg="Start subscribing containerd event" May 9 00:07:17.903999 containerd[1910]: time="2025-05-09T00:07:17.903988128Z" level=info msg="Start recovering state" May 9 00:07:17.904032 containerd[1910]: time="2025-05-09T00:07:17.904013924Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 9 00:07:17.904082 containerd[1910]: time="2025-05-09T00:07:17.904065255Z" level=info msg=serving... address=/run/containerd/containerd.sock May 9 00:07:17.904165 containerd[1910]: time="2025-05-09T00:07:17.904069682Z" level=info msg="Start event monitor" May 9 00:07:17.904204 containerd[1910]: time="2025-05-09T00:07:17.904177081Z" level=info msg="Start snapshots syncer" May 9 00:07:17.904204 containerd[1910]: time="2025-05-09T00:07:17.904196558Z" level=info msg="Start cni network conf syncer for default" May 9 00:07:17.904257 containerd[1910]: time="2025-05-09T00:07:17.904216686Z" level=info msg="Start streaming server" May 9 00:07:17.904427 containerd[1910]: time="2025-05-09T00:07:17.904325558Z" level=info msg="containerd successfully booted in 0.064798s" May 9 00:07:17.904425 systemd[1]: Started containerd.service - containerd container runtime. May 9 00:07:17.911828 systemd[1]: Starting docker.service - Docker Application Container Engine... May 9 00:07:17.911941 (dockerd)[1944]: 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 9 00:07:17.944727 dockerd[1944]: time="2025-05-09T00:07:17.944233372Z" level=info msg="Starting up" May 9 00:07:17.978574 dockerd[1944]: time="2025-05-09T00:07:17.978529005Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 9 00:07:17.999910 dockerd[1944]: time="2025-05-09T00:07:17.999859355Z" level=info msg="Loading containers: start." May 9 00:07:18.016152 systemd[1]: var-lib-docker-overlay2-f287952547d8f63cc36db3e196c144a7bee20e7d10234f6ac50d85e8dde20069-merged.mount: Deactivated successfully. May 9 00:07:18.351726 dockerd[1944]: time="2025-05-09T00:07:18.351676149Z" level=info msg="Removing stale sandbox 76b078e3b3227c2080bb01a955585d49cb739bbfa1fb9d4b98abf5812e2f12c7 (cb2ed4c98d4088cac857c1fb3f701518788d7a92fb70a4805e1b9fdf19d72a9c)" May 9 00:07:18.356892 systemd-networkd[1365]: vethb47da95: Link DOWN May 9 00:07:18.357280 dockerd[1944]: time="2025-05-09T00:07:18.356944560Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 0cec0c8a9768de57121bcafa83f5e4fa6686d4b37cc00fc71328cdc4358e6652 1ef4118fa7f33a96190e442a80cb91964da2f56a7d82066466799250f1feea4c], retrying...." May 9 00:07:18.356903 systemd-networkd[1365]: vethb47da95: Lost carrier May 9 00:07:18.359174 kernel: docker0: port 1(vethb47da95) entered disabled state May 9 00:07:18.359229 kernel: vethb47da95 (unregistering): left allmulticast mode May 9 00:07:18.359305 kernel: vethb47da95 (unregistering): left promiscuous mode May 9 00:07:18.360760 kernel: docker0: port 1(vethb47da95) entered disabled state May 9 00:07:18.369266 systemd-networkd[1365]: docker0: Lost carrier May 9 00:07:18.624388 dockerd[1944]: time="2025-05-09T00:07:18.624246235Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" May 9 00:07:18.721632 dockerd[1944]: time="2025-05-09T00:07:18.721557006Z" level=warning msg="error locating sandbox id 76b078e3b3227c2080bb01a955585d49cb739bbfa1fb9d4b98abf5812e2f12c7: sandbox 76b078e3b3227c2080bb01a955585d49cb739bbfa1fb9d4b98abf5812e2f12c7 not found" May 9 00:07:18.721762 dockerd[1944]: time="2025-05-09T00:07:18.721717101Z" level=info msg="Loading containers: done." May 9 00:07:18.736846 dockerd[1944]: time="2025-05-09T00:07:18.736782399Z" 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 9 00:07:18.737081 dockerd[1944]: time="2025-05-09T00:07:18.736884283Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 May 9 00:07:18.737081 dockerd[1944]: time="2025-05-09T00:07:18.736933782Z" level=info msg="Daemon has completed initialization" May 9 00:07:18.759467 dockerd[1944]: time="2025-05-09T00:07:18.759397350Z" level=info msg="API listen on /run/docker.sock" May 9 00:07:18.759558 systemd[1]: Started docker.service - Docker Application Container Engine. May 9 00:07:18.964612 systemd[1]: run-docker-netns-76b078e3b322.mount: Deactivated successfully. May 9 00:07:22.230451 systemd[1]: Started sshd@14-10.0.0.84:22-10.0.0.1:38054.service - OpenSSH per-connection server daemon (10.0.0.1:38054). May 9 00:07:22.275503 sshd[2143]: Accepted publickey for core from 10.0.0.1 port 38054 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:22.277063 sshd-session[2143]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:22.280969 systemd-logind[1414]: New session 15 of user core. May 9 00:07:22.296735 systemd[1]: Started session-15.scope - Session 15 of User core. May 9 00:07:22.353392 sshd[2145]: Connection closed by 10.0.0.1 port 38054 May 9 00:07:22.353884 sshd-session[2143]: pam_unix(sshd:session): session closed for user core May 9 00:07:22.376435 systemd[1]: sshd@14-10.0.0.84:22-10.0.0.1:38054.service: Deactivated successfully. May 9 00:07:22.378225 systemd[1]: session-15.scope: Deactivated successfully. May 9 00:07:22.379957 systemd-logind[1414]: Session 15 logged out. Waiting for processes to exit. May 9 00:07:22.389881 systemd[1]: Started sshd@15-10.0.0.84:22-10.0.0.1:38060.service - OpenSSH per-connection server daemon (10.0.0.1:38060). May 9 00:07:22.391054 systemd-logind[1414]: Removed session 15. May 9 00:07:22.427867 sshd[2150]: Accepted publickey for core from 10.0.0.1 port 38060 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:22.429370 sshd-session[2150]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:22.433095 systemd-logind[1414]: New session 16 of user core. May 9 00:07:22.442893 systemd[1]: Started session-16.scope - Session 16 of User core. May 9 00:07:22.498461 sshd[2152]: Connection closed by 10.0.0.1 port 38060 May 9 00:07:22.499227 sshd-session[2150]: pam_unix(sshd:session): session closed for user core May 9 00:07:22.506425 systemd[1]: sshd@15-10.0.0.84:22-10.0.0.1:38060.service: Deactivated successfully. May 9 00:07:22.508147 systemd[1]: session-16.scope: Deactivated successfully. May 9 00:07:22.509529 systemd-logind[1414]: Session 16 logged out. Waiting for processes to exit. May 9 00:07:22.519899 systemd[1]: Started sshd@16-10.0.0.84:22-10.0.0.1:38064.service - OpenSSH per-connection server daemon (10.0.0.1:38064). May 9 00:07:22.520960 systemd-logind[1414]: Removed session 16. May 9 00:07:22.561340 sshd[2157]: Accepted publickey for core from 10.0.0.1 port 38064 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:22.563131 sshd-session[2157]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:22.567525 systemd-logind[1414]: New session 17 of user core. May 9 00:07:22.576822 systemd[1]: Started session-17.scope - Session 17 of User core. May 9 00:07:22.638515 sshd[2159]: Connection closed by 10.0.0.1 port 38064 May 9 00:07:22.638918 sshd-session[2157]: pam_unix(sshd:session): session closed for user core May 9 00:07:22.651184 systemd[1]: sshd@16-10.0.0.84:22-10.0.0.1:38064.service: Deactivated successfully. May 9 00:07:22.653004 systemd[1]: session-17.scope: Deactivated successfully. May 9 00:07:22.654679 systemd-logind[1414]: Session 17 logged out. Waiting for processes to exit. May 9 00:07:22.655929 systemd[1]: Started sshd@17-10.0.0.84:22-10.0.0.1:38070.service - OpenSSH per-connection server daemon (10.0.0.1:38070). May 9 00:07:22.656693 systemd-logind[1414]: Removed session 17. May 9 00:07:22.698806 sshd[2171]: Accepted publickey for core from 10.0.0.1 port 38070 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:22.700659 sshd-session[2171]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:22.704984 systemd-logind[1414]: New session 18 of user core. May 9 00:07:22.714733 systemd[1]: Started session-18.scope - Session 18 of User core. May 9 00:07:22.794557 systemd[1]: var-lib-docker-overlay2-b2dd2031b6c323d7ba05baaf0066e93de480008dce98f766b3be2213cc8fdd94\x2dinit-merged.mount: Deactivated successfully. May 9 00:07:22.825276 kernel: docker0: port 1(vethf271b55) entered blocking state May 9 00:07:22.825416 kernel: docker0: port 1(vethf271b55) entered disabled state May 9 00:07:22.825449 kernel: vethf271b55: entered allmulticast mode May 9 00:07:22.826168 kernel: vethf271b55: entered promiscuous mode May 9 00:07:22.826529 systemd-networkd[1365]: vethf271b55: Link UP May 9 00:07:22.866480 containerd[1910]: time="2025-05-09T00:07:22.866381083Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 9 00:07:22.866480 containerd[1910]: time="2025-05-09T00:07:22.866441642Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 9 00:07:22.866480 containerd[1910]: time="2025-05-09T00:07:22.866461471Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 9 00:07:22.867227 containerd[1910]: time="2025-05-09T00:07:22.867157060Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 9 00:07:22.889724 systemd[1]: Started docker-867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3.scope - libcontainer container 867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3. May 9 00:07:22.947627 kernel: eth0: renamed from vethc250419 May 9 00:07:22.964712 kernel: docker0: port 1(vethf271b55) entered blocking state May 9 00:07:22.964752 kernel: docker0: port 1(vethf271b55) entered forwarding state May 9 00:07:22.964836 systemd-networkd[1365]: vethf271b55: Gained carrier May 9 00:07:22.965070 systemd-networkd[1365]: docker0: Gained carrier May 9 00:07:22.969611 systemd-resolved[1271]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 9 00:07:23.005455 sshd[2173]: Connection closed by 10.0.0.1 port 38070 May 9 00:07:23.005886 sshd-session[2171]: pam_unix(sshd:session): session closed for user core May 9 00:07:23.013461 systemd[1]: sshd@17-10.0.0.84:22-10.0.0.1:38070.service: Deactivated successfully. May 9 00:07:23.014970 systemd[1]: session-18.scope: Deactivated successfully. May 9 00:07:23.015690 systemd-logind[1414]: Session 18 logged out. Waiting for processes to exit. May 9 00:07:23.027837 systemd[1]: Started sshd@18-10.0.0.84:22-10.0.0.1:38076.service - OpenSSH per-connection server daemon (10.0.0.1:38076). May 9 00:07:23.028356 systemd-logind[1414]: Removed session 18. May 9 00:07:23.065181 sshd[2248]: Accepted publickey for core from 10.0.0.1 port 38076 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:23.066531 sshd-session[2248]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:23.070357 systemd-logind[1414]: New session 19 of user core. May 9 00:07:23.079716 systemd[1]: Started session-19.scope - Session 19 of User core. May 9 00:07:23.137297 sshd[2250]: Connection closed by 10.0.0.1 port 38076 May 9 00:07:23.137670 sshd-session[2248]: pam_unix(sshd:session): session closed for user core May 9 00:07:23.153406 systemd[1]: sshd@18-10.0.0.84:22-10.0.0.1:38076.service: Deactivated successfully. May 9 00:07:23.155089 systemd[1]: session-19.scope: Deactivated successfully. May 9 00:07:23.155773 systemd-logind[1414]: Session 19 logged out. Waiting for processes to exit. May 9 00:07:23.166844 systemd[1]: Started sshd@19-10.0.0.84:22-10.0.0.1:38088.service - OpenSSH per-connection server daemon (10.0.0.1:38088). May 9 00:07:23.167359 systemd-logind[1414]: Removed session 19. May 9 00:07:23.205159 sshd[2255]: Accepted publickey for core from 10.0.0.1 port 38088 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:23.206568 sshd-session[2255]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:23.210527 systemd-logind[1414]: New session 20 of user core. May 9 00:07:23.225714 systemd[1]: Started session-20.scope - Session 20 of User core. May 9 00:07:23.279001 sudo[2258]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1910 May 9 00:07:23.279370 sudo[2258]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 00:07:23.282910 sudo[2258]: pam_unix(sudo:session): session closed for user root May 9 00:07:23.284214 sshd[2257]: Connection closed by 10.0.0.1 port 38088 May 9 00:07:23.284651 sshd-session[2255]: pam_unix(sshd:session): session closed for user core May 9 00:07:23.287330 dockerd[1944]: time="2025-05-09T00:07:23.287261703Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby May 9 00:07:23.287330 dockerd[1944]: time="2025-05-09T00:07:23.287316273Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby May 9 00:07:23.296916 dockerd[1944]: time="2025-05-09T00:07:23.287759247Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby May 9 00:07:23.296916 dockerd[1944]: time="2025-05-09T00:07:23.287792887Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby May 9 00:07:23.299335 systemd[1]: containerd.service: Deactivated successfully. May 9 00:07:23.299408 systemd[1]: containerd.service: Unit process 2201 (containerd-shim) remains running after unit stopped. May 9 00:07:23.300100 systemd[1]: sshd@19-10.0.0.84:22-10.0.0.1:38088.service: Deactivated successfully. May 9 00:07:23.301845 systemd[1]: session-20.scope: Deactivated successfully. May 9 00:07:23.304110 systemd-logind[1414]: Session 20 logged out. Waiting for processes to exit. May 9 00:07:23.313843 systemd[1]: Started sshd@20-10.0.0.84:22-10.0.0.1:38098.service - OpenSSH per-connection server daemon (10.0.0.1:38098). May 9 00:07:23.314832 systemd-logind[1414]: Removed session 20. May 9 00:07:23.352972 sshd[2264]: Accepted publickey for core from 10.0.0.1 port 38098 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:23.354284 sshd-session[2264]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:23.358819 systemd-logind[1414]: New session 21 of user core. May 9 00:07:23.370726 systemd[1]: Started session-21.scope - Session 21 of User core. May 9 00:07:23.426358 sshd[2266]: Connection closed by 10.0.0.1 port 38098 May 9 00:07:23.426761 sshd-session[2264]: pam_unix(sshd:session): session closed for user core May 9 00:07:23.431192 systemd[1]: sshd@20-10.0.0.84:22-10.0.0.1:38098.service: Deactivated successfully. May 9 00:07:23.432955 systemd[1]: session-21.scope: Deactivated successfully. May 9 00:07:23.433734 systemd-logind[1414]: Session 21 logged out. Waiting for processes to exit. May 9 00:07:23.434639 systemd-logind[1414]: Removed session 21. May 9 00:07:24.247799 systemd-networkd[1365]: vethf271b55: Gained IPv6LL May 9 00:07:28.529249 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. May 9 00:07:28.529796 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 9 00:07:28.529963 dockerd[1944]: time="2025-05-09T00:07:28.529878248Z" level=info msg="Processing signal 'terminated'" May 9 00:07:29.439774 systemd[1]: Started sshd@21-10.0.0.84:22-10.0.0.1:43768.service - OpenSSH per-connection server daemon (10.0.0.1:43768). May 9 00:07:29.481838 sshd[2271]: Accepted publickey for core from 10.0.0.1 port 43768 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:29.483522 sshd-session[2271]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:29.487989 systemd-logind[1414]: New session 22 of user core. May 9 00:07:29.501775 systemd[1]: Started session-22.scope - Session 22 of User core. May 9 00:07:29.557775 sshd[2273]: Connection closed by 10.0.0.1 port 43768 May 9 00:07:29.558132 sshd-session[2271]: pam_unix(sshd:session): session closed for user core May 9 00:07:29.561852 systemd[1]: sshd@21-10.0.0.84:22-10.0.0.1:43768.service: Deactivated successfully. May 9 00:07:29.563731 systemd[1]: session-22.scope: Deactivated successfully. May 9 00:07:29.564458 systemd-logind[1414]: Session 22 logged out. Waiting for processes to exit. May 9 00:07:29.565393 systemd-logind[1414]: Removed session 22. May 9 00:07:29.921644 update_engine[1418]: I20250509 00:07:29.921478 1418 update_attempter.cc:509] Updating boot flags... May 9 00:07:29.950687 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2283) May 9 00:07:29.983619 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2281) May 9 00:07:30.011632 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2281) May 9 00:07:30.531672 dockerd[1944]: time="2025-05-09T00:07:30.531541501Z" level=error msg="Error sending stop (signal 15) to container" container=867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3 error="Cannot kill container 867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" May 9 00:07:30.531672 dockerd[1944]: time="2025-05-09T00:07:30.531662329Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3 May 9 00:07:35.568090 systemd[1]: Started sshd@22-10.0.0.84:22-10.0.0.1:43780.service - OpenSSH per-connection server daemon (10.0.0.1:43780). May 9 00:07:35.613395 sshd[2293]: Accepted publickey for core from 10.0.0.1 port 43780 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:35.615005 sshd-session[2293]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:35.619804 systemd-logind[1414]: New session 23 of user core. May 9 00:07:35.629760 systemd[1]: Started session-23.scope - Session 23 of User core. May 9 00:07:35.686465 sshd[2295]: Connection closed by 10.0.0.1 port 43780 May 9 00:07:35.686837 sshd-session[2293]: pam_unix(sshd:session): session closed for user core May 9 00:07:35.690547 systemd[1]: sshd@22-10.0.0.84:22-10.0.0.1:43780.service: Deactivated successfully. May 9 00:07:35.692501 systemd[1]: session-23.scope: Deactivated successfully. May 9 00:07:35.693173 systemd-logind[1414]: Session 23 logged out. Waiting for processes to exit. May 9 00:07:35.694054 systemd-logind[1414]: Removed session 23. May 9 00:07:40.532052 dockerd[1944]: time="2025-05-09T00:07:40.531972976Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3 error="context deadline exceeded" May 9 00:07:40.532919 systemd[1]: docker-867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3.scope: Deactivated successfully. May 9 00:07:41.697339 systemd[1]: Started sshd@23-10.0.0.84:22-10.0.0.1:47608.service - OpenSSH per-connection server daemon (10.0.0.1:47608). May 9 00:07:41.743438 sshd[2300]: Accepted publickey for core from 10.0.0.1 port 47608 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:41.745251 sshd-session[2300]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:41.749376 systemd-logind[1414]: New session 24 of user core. May 9 00:07:41.755778 systemd[1]: Started session-24.scope - Session 24 of User core. May 9 00:07:41.812418 sshd[2302]: Connection closed by 10.0.0.1 port 47608 May 9 00:07:41.812842 sshd-session[2300]: pam_unix(sshd:session): session closed for user core May 9 00:07:41.817316 systemd[1]: sshd@23-10.0.0.84:22-10.0.0.1:47608.service: Deactivated successfully. May 9 00:07:41.819036 systemd[1]: session-24.scope: Deactivated successfully. May 9 00:07:41.819683 systemd-logind[1414]: Session 24 logged out. Waiting for processes to exit. May 9 00:07:41.820531 systemd-logind[1414]: Removed session 24. May 9 00:07:43.531115 dockerd[1944]: time="2025-05-09T00:07:43.531029624Z" level=error msg="Force shutdown daemon" May 9 00:07:43.531634 dockerd[1944]: time="2025-05-09T00:07:43.531279060Z" level=info msg="Daemon shutdown complete" May 9 00:07:43.537356 systemd[1]: docker.service: Deactivated successfully. May 9 00:07:43.537692 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 9 00:07:43.538241 systemd[1]: docker.socket: Deactivated successfully. May 9 00:07:43.538523 systemd[1]: Closed docker.socket - Docker Socket for the API. May 9 00:07:43.538558 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 9 00:07:43.540337 systemd[1]: Starting docker.socket - Docker Socket for the API... May 9 00:07:43.540511 systemd[1]: containerd.service: Found left-over process 2201 (containerd-shim) in control group while starting unit. Ignoring. May 9 00:07:43.540519 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 9 00:07:43.546876 systemd[1]: Starting containerd.service - containerd container runtime... May 9 00:07:43.548145 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 9 00:07:43.558058 systemd[1]: containerd.service: Found left-over process 2201 (containerd-shim) in control group while starting unit. Ignoring. May 9 00:07:43.558067 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. May 9 00:07:43.563273 (ntainerd)[2312]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 9 00:07:43.584735 containerd[2312]: time="2025-05-09T00:07:43.584645035Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 May 9 00:07:43.610370 containerd[2312]: time="2025-05-09T00:07:43.610290671Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.612190 containerd[2312]: time="2025-05-09T00:07:43.612135582Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:43.612190 containerd[2312]: time="2025-05-09T00:07:43.612175168Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 9 00:07:43.612245 containerd[2312]: time="2025-05-09T00:07:43.612195442Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 9 00:07:43.612245 containerd[2312]: time="2025-05-09T00:07:43.612233746Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 9 00:07:43.612314 containerd[2312]: time="2025-05-09T00:07:43.612251325Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.612314 containerd[2312]: time="2025-05-09T00:07:43.612295058Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:43.612351 containerd[2312]: time="2025-05-09T00:07:43.612316293Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.612606 containerd[2312]: time="2025-05-09T00:07:43.612551034Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 May 9 00:07:43.612606 containerd[2312]: time="2025-05-09T00:07:43.612577267Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.612660 containerd[2312]: time="2025-05-09T00:07:43.612609791Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:43.612660 containerd[2312]: time="2025-05-09T00:07:43.612623534Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.612660 containerd[2312]: time="2025-05-09T00:07:43.612651791Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.612830 containerd[2312]: time="2025-05-09T00:07:43.612796412Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 9 00:07:43.613013 containerd[2312]: time="2025-05-09T00:07:43.612977643Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 May 9 00:07:43.613013 containerd[2312]: time="2025-05-09T00:07:43.613003998Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 9 00:07:43.613053 containerd[2312]: time="2025-05-09T00:07:43.613028188Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 9 00:07:43.613053 containerd[2312]: time="2025-05-09T00:07:43.613049433Z" level=info msg="metadata content store policy set" policy=shared May 9 00:07:43.613263 containerd[2312]: time="2025-05-09T00:07:43.613231687Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 9 00:07:43.613294 containerd[2312]: time="2025-05-09T00:07:43.613275259Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 9 00:07:43.613315 containerd[2312]: time="2025-05-09T00:07:43.613296955Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 9 00:07:43.613338 containerd[2312]: time="2025-05-09T00:07:43.613319112Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 9 00:07:43.613359 containerd[2312]: time="2025-05-09T00:07:43.613338053Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 9 00:07:43.613447 containerd[2312]: time="2025-05-09T00:07:43.613421712Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 9 00:07:43.613765 containerd[2312]: time="2025-05-09T00:07:43.613738610Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 9 00:07:43.622963 containerd[2312]: time="2025-05-09T00:07:43.622921094Z" level=info msg="cleaning leaked shim process" id=867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3 namespace=moby May 9 00:07:43.632858 containerd[2312]: time="2025-05-09T00:07:43.632621751Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" May 9 00:07:43.633018 containerd[2312]: time="2025-05-09T00:07:43.632944798Z" level=info msg="shim disconnected" id=867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3 namespace=moby May 9 00:07:43.633018 containerd[2312]: time="2025-05-09T00:07:43.633016748Z" level=warning msg="cleaning up after shim disconnected" id=867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3 namespace=moby May 9 00:07:43.633147 containerd[2312]: time="2025-05-09T00:07:43.633025612Z" level=info msg="cleaning up dead shim" namespace=moby May 9 00:07:43.647992 containerd[2312]: time="2025-05-09T00:07:43.647937813Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 9 00:07:43.647992 containerd[2312]: time="2025-05-09T00:07:43.647981176Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648006308Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648022324Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648038351Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648050902Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648097289Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648118494Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648137246Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648153653Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648166855Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648189583Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648209386Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648222167Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648242621Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648284 containerd[2312]: time="2025-05-09T00:07:43.648254230Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648266912Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648278030Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648291151Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648303853Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648316895Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648328204Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648339522Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648351042Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648364564Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648387402Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648401355Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648423181Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648477983Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 9 00:07:43.648736 containerd[2312]: time="2025-05-09T00:07:43.648495472Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 May 9 00:07:43.649117 containerd[2312]: time="2025-05-09T00:07:43.648506270Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 9 00:07:43.649117 containerd[2312]: time="2025-05-09T00:07:43.648518810Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 9 00:07:43.649117 containerd[2312]: time="2025-05-09T00:07:43.648527875Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 9 00:07:43.649117 containerd[2312]: time="2025-05-09T00:07:43.648547468Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 9 00:07:43.649117 containerd[2312]: time="2025-05-09T00:07:43.648561802Z" level=info msg="NRI interface is disabled by configuration." May 9 00:07:43.649117 containerd[2312]: time="2025-05-09T00:07:43.648576196Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 9 00:07:43.649292 containerd[2312]: time="2025-05-09T00:07:43.648861241Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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 9 00:07:43.649292 containerd[2312]: time="2025-05-09T00:07:43.648903461Z" level=info msg="Connect containerd service" May 9 00:07:43.649292 containerd[2312]: time="2025-05-09T00:07:43.648934683Z" level=info msg="using legacy CRI server" May 9 00:07:43.649292 containerd[2312]: time="2025-05-09T00:07:43.648942767Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 9 00:07:43.649292 containerd[2312]: time="2025-05-09T00:07:43.649041631Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 9 00:07:43.649502 containerd[2312]: time="2025-05-09T00:07:43.649426912Z" 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 9 00:07:43.649643 containerd[2312]: time="2025-05-09T00:07:43.649574979Z" level=info msg="Start subscribing containerd event" May 9 00:07:43.649682 containerd[2312]: time="2025-05-09T00:07:43.649666280Z" level=info msg="Start recovering state" May 9 00:07:43.649772 containerd[2312]: time="2025-05-09T00:07:43.649741706Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 9 00:07:43.649772 containerd[2312]: time="2025-05-09T00:07:43.649757252Z" level=info msg="Start event monitor" May 9 00:07:43.649832 containerd[2312]: time="2025-05-09T00:07:43.649797830Z" level=info msg="Start snapshots syncer" May 9 00:07:43.649832 containerd[2312]: time="2025-05-09T00:07:43.649809509Z" level=info msg="Start cni network conf syncer for default" May 9 00:07:43.649832 containerd[2312]: time="2025-05-09T00:07:43.649816381Z" level=info msg=serving... address=/run/containerd/containerd.sock May 9 00:07:43.649832 containerd[2312]: time="2025-05-09T00:07:43.649817652Z" level=info msg="Start streaming server" May 9 00:07:43.649946 containerd[2312]: time="2025-05-09T00:07:43.649891696Z" level=info msg="containerd successfully booted in 0.065846s" May 9 00:07:43.650006 systemd[1]: Started containerd.service - containerd container runtime. May 9 00:07:43.660881 systemd[1]: Starting docker.service - Docker Application Container Engine... May 9 00:07:43.661001 (dockerd)[2346]: 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 9 00:07:43.696206 dockerd[2346]: time="2025-05-09T00:07:43.696132051Z" level=info msg="Starting up" May 9 00:07:43.911779 dockerd[2346]: time="2025-05-09T00:07:43.911569748Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 9 00:07:43.932453 dockerd[2346]: time="2025-05-09T00:07:43.932398056Z" level=info msg="Loading containers: start." May 9 00:07:44.252272 systemd[1]: var-lib-docker-overlay2-b2dd2031b6c323d7ba05baaf0066e93de480008dce98f766b3be2213cc8fdd94-merged.mount: Deactivated successfully. May 9 00:07:44.574691 dockerd[2346]: time="2025-05-09T00:07:44.574640224Z" level=info msg="Removing stale sandbox 7b30da1bd0bb769a8aad0be74bc0b9da7442a881900973c9e0784ce3e4b211b3 (867644451ccd00e4b729cd2b8527ee6756ea989d5effe60d72f9ad8ceb9d2cb3)" May 9 00:07:44.584894 systemd-networkd[1365]: vethf271b55: Link DOWN May 9 00:07:44.584903 systemd-networkd[1365]: vethf271b55: Lost carrier May 9 00:07:44.586962 kernel: docker0: port 1(vethf271b55) entered disabled state May 9 00:07:44.587013 kernel: vethf271b55 (unregistering): left allmulticast mode May 9 00:07:44.587032 kernel: vethf271b55 (unregistering): left promiscuous mode May 9 00:07:44.588658 kernel: docker0: port 1(vethf271b55) entered disabled state May 9 00:07:44.594138 systemd-networkd[1365]: docker0: Lost carrier May 9 00:07:44.662907 dockerd[2346]: time="2025-05-09T00:07:44.662813176Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint e7ae4c499dc4c90d783beec6970978b7042924e9b4079a8f82565afe1dc4c67e 2baf26f0cde354235a94d8fdcd5adf8a9e9c49d0e43686b73f58895172ad24e9], retrying...." May 9 00:07:44.758404 systemd[1]: run-docker-netns-7b30da1bd0bb.mount: Deactivated successfully. May 9 00:07:44.812075 dockerd[2346]: time="2025-05-09T00:07:44.812015274Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" May 9 00:07:44.897247 dockerd[2346]: time="2025-05-09T00:07:44.897120540Z" level=warning msg="error locating sandbox id 76b078e3b3227c2080bb01a955585d49cb739bbfa1fb9d4b98abf5812e2f12c7: sandbox 76b078e3b3227c2080bb01a955585d49cb739bbfa1fb9d4b98abf5812e2f12c7 not found" May 9 00:07:44.897247 dockerd[2346]: time="2025-05-09T00:07:44.897165646Z" level=warning msg="error locating sandbox id 7b30da1bd0bb769a8aad0be74bc0b9da7442a881900973c9e0784ce3e4b211b3: sandbox 7b30da1bd0bb769a8aad0be74bc0b9da7442a881900973c9e0784ce3e4b211b3 not found" May 9 00:07:44.897399 dockerd[2346]: time="2025-05-09T00:07:44.897257930Z" level=info msg="Loading containers: done." May 9 00:07:44.908222 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3207077052-merged.mount: Deactivated successfully. May 9 00:07:45.043352 dockerd[2346]: time="2025-05-09T00:07:45.043290269Z" 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 9 00:07:45.043527 dockerd[2346]: time="2025-05-09T00:07:45.043409719Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 May 9 00:07:45.043527 dockerd[2346]: time="2025-05-09T00:07:45.043467826Z" level=info msg="Daemon has completed initialization" May 9 00:07:45.114698 dockerd[2346]: time="2025-05-09T00:07:45.114587437Z" level=info msg="API listen on /run/docker.sock" May 9 00:07:45.114831 systemd[1]: Started docker.service - Docker Application Container Engine. May 9 00:07:47.824567 systemd[1]: Started sshd@24-10.0.0.84:22-10.0.0.1:45378.service - OpenSSH per-connection server daemon (10.0.0.1:45378). May 9 00:07:47.866893 sshd[2545]: Accepted publickey for core from 10.0.0.1 port 45378 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:47.868664 sshd-session[2545]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:47.872691 systemd-logind[1414]: New session 25 of user core. May 9 00:07:47.886917 systemd[1]: Started session-25.scope - Session 25 of User core. May 9 00:07:47.943953 sshd[2547]: Connection closed by 10.0.0.1 port 45378 May 9 00:07:47.944299 sshd-session[2545]: pam_unix(sshd:session): session closed for user core May 9 00:07:47.951464 systemd[1]: sshd@24-10.0.0.84:22-10.0.0.1:45378.service: Deactivated successfully. May 9 00:07:47.953385 systemd[1]: session-25.scope: Deactivated successfully. May 9 00:07:47.954845 systemd-logind[1414]: Session 25 logged out. Waiting for processes to exit. May 9 00:07:47.965013 systemd[1]: Started sshd@25-10.0.0.84:22-10.0.0.1:45390.service - OpenSSH per-connection server daemon (10.0.0.1:45390). May 9 00:07:47.966111 systemd-logind[1414]: Removed session 25. May 9 00:07:48.002966 sshd[2552]: Accepted publickey for core from 10.0.0.1 port 45390 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:48.004776 sshd-session[2552]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:48.008724 systemd-logind[1414]: New session 26 of user core. May 9 00:07:48.018830 systemd[1]: Started session-26.scope - Session 26 of User core. May 9 00:07:48.075365 sshd[2554]: Connection closed by 10.0.0.1 port 45390 May 9 00:07:48.075710 sshd-session[2552]: pam_unix(sshd:session): session closed for user core May 9 00:07:48.086442 systemd[1]: sshd@25-10.0.0.84:22-10.0.0.1:45390.service: Deactivated successfully. May 9 00:07:48.088229 systemd[1]: session-26.scope: Deactivated successfully. May 9 00:07:48.089863 systemd-logind[1414]: Session 26 logged out. Waiting for processes to exit. May 9 00:07:48.099981 systemd[1]: Started sshd@26-10.0.0.84:22-10.0.0.1:45404.service - OpenSSH per-connection server daemon (10.0.0.1:45404). May 9 00:07:48.101028 systemd-logind[1414]: Removed session 26. May 9 00:07:48.138721 sshd[2559]: Accepted publickey for core from 10.0.0.1 port 45404 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:48.140241 sshd-session[2559]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:48.144277 systemd-logind[1414]: New session 27 of user core. May 9 00:07:48.159750 systemd[1]: Started session-27.scope - Session 27 of User core. May 9 00:07:48.225187 sshd[2561]: Connection closed by 10.0.0.1 port 45404 May 9 00:07:48.225654 sshd-session[2559]: pam_unix(sshd:session): session closed for user core May 9 00:07:48.240373 systemd[1]: sshd@26-10.0.0.84:22-10.0.0.1:45404.service: Deactivated successfully. May 9 00:07:48.241966 systemd[1]: session-27.scope: Deactivated successfully. May 9 00:07:48.243247 systemd-logind[1414]: Session 27 logged out. Waiting for processes to exit. May 9 00:07:48.252856 systemd[1]: Started sshd@27-10.0.0.84:22-10.0.0.1:45416.service - OpenSSH per-connection server daemon (10.0.0.1:45416). May 9 00:07:48.253946 systemd-logind[1414]: Removed session 27. May 9 00:07:48.291386 sshd[2574]: Accepted publickey for core from 10.0.0.1 port 45416 ssh2: RSA SHA256:doUyGgY8YG5ofi5KGScuvVFjx/czw1BwYwiMRYMhavo May 9 00:07:48.292833 sshd-session[2574]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 00:07:48.296702 systemd-logind[1414]: New session 28 of user core. May 9 00:07:48.306704 systemd[1]: Started session-28.scope - Session 28 of User core. May 9 00:07:48.704892 systemd[1]: var-lib-docker-overlay2-6404ff90539b5698898f1e6ecb41fe1108a0cf475aec04af4ee25dfcb095481e\x2dinit-merged.mount: Deactivated successfully. May 9 00:07:48.954240 kernel: docker0: port 1(veth444e4cf) entered blocking state May 9 00:07:48.954368 kernel: docker0: port 1(veth444e4cf) entered disabled state May 9 00:07:48.954393 kernel: veth444e4cf: entered allmulticast mode May 9 00:07:48.955734 kernel: veth444e4cf: entered promiscuous mode May 9 00:07:48.956294 systemd-networkd[1365]: veth444e4cf: Link UP May 9 00:07:49.228730 containerd[2312]: time="2025-05-09T00:07:49.228503921Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 9 00:07:49.228730 containerd[2312]: time="2025-05-09T00:07:49.228562501Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 9 00:07:49.229272 containerd[2312]: time="2025-05-09T00:07:49.228576985Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 9 00:07:49.229420 containerd[2312]: time="2025-05-09T00:07:49.229340413Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 9 00:07:49.258738 systemd[1]: Started docker-c737fbb43045f235b047049b3891d22f2cd6bb521054a87268b6e04851fc758e.scope - libcontainer container c737fbb43045f235b047049b3891d22f2cd6bb521054a87268b6e04851fc758e. May 9 00:07:49.309633 kernel: eth0: renamed from vethc6301ef May 9 00:07:49.325628 kernel: docker0: port 1(veth444e4cf) entered blocking state May 9 00:07:49.325667 kernel: docker0: port 1(veth444e4cf) entered forwarding state May 9 00:07:49.325755 systemd-networkd[1365]: veth444e4cf: Gained carrier May 9 00:07:49.326013 systemd-networkd[1365]: docker0: Gained carrier May 9 00:07:49.352015 systemd-resolved[1271]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 9 00:07:49.434479 sshd[2576]: Connection closed by 10.0.0.1 port 45416 May 9 00:07:49.435065 sshd-session[2574]: pam_unix(sshd:session): session closed for user core May 9 00:07:49.439423 systemd[1]: sshd@27-10.0.0.84:22-10.0.0.1:45416.service: Deactivated successfully. May 9 00:07:49.441189 systemd[1]: session-28.scope: Deactivated successfully. May 9 00:07:49.441768 systemd-logind[1414]: Session 28 logged out. Waiting for processes to exit. May 9 00:07:49.442725 systemd-logind[1414]: Removed session 28.