[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-10.fc44 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 416613384 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002371] x2apic enabled [ 0.003008] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.007030] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.008011] pid_max: default: 32768 minimum: 301 [ 0.009135] LSM: Security Framework initializing [ 0.011014] Yama: becoming mindful. [ 0.012034] SELinux: Initializing. [ 0.013062] *** VALIDATE selinux *** [ 0.021119] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026140] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027174] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028097] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029112] *** VALIDATE tmpfs *** [ 0.031257] *** VALIDATE proc *** [ 0.032236] *** VALIDATE cgroup *** [ 0.033008] *** VALIDATE cgroup2 *** [ 0.034266] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035148] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037030] Spectre V2 : User space: Vulnerable [ 0.038009] Speculative Store Bypass: Vulnerable [ 0.041261] debug: unmapping init [mem 0xffffffffae859000-0xffffffffae860fff] [ 0.043174] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044706] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045023] ... version: 2 [ 0.046013] ... bit width: 48 [ 0.047012] ... generic registers: 4 [ 0.048011] ... value mask: 0000ffffffffffff [ 0.049016] ... max period: 00007fffffffffff [ 0.050015] ... fixed-purpose events: 3 [ 0.051013] ... event mask: 000000070000000f [ 0.052307] rcu: Hierarchical SRCU implementation. [ 0.054398] smp: Bringing up secondary CPUs ... [ 0.055596] x86: Booting SMP configuration: [ 0.056027] .... node #0, CPUs: #1 #2 #3 [ 0.059664] smp: Brought up 1 node, 4 CPUs [ 0.061013] smpboot: Max logical packages: 1 [ 0.062015] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.141353] node 0 deferred pages initialised in 76ms [ 0.144129] devtmpfs: initialized [ 0.145240] x86/mm: Memory block size: 128MB [ 0.147634] gcov: version magic: 0x41383552 [ 0.149122] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.151097] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.152339] pinctrl core: initialized pinctrl subsystem [ 0.154139] [ 0.154419] ************************************************************* [ 0.156012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.157007] ** ** [ 0.158049] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.160009] ** ** [ 0.161006] ** This means that this kernel is built to expose internal ** [ 0.162007] ** IOMMU data structures, which may compromise security on ** [ 0.164007] ** your system. ** [ 0.165007] ** ** [ 0.166008] ** If you see this message and you are not debugging the ** [ 0.168010] ** kernel, report this immediately to your vendor! ** [ 0.169006] ** ** [ 0.170007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.171010] ************************************************************* [ 0.173536] NET: Registered protocol family 16 [ 0.174332] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.176063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.178054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.181382] cpuidle: using governor menu [ 0.182567] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.183299] PCI: Using configuration type 1 for base access [ 0.185287] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.191109] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.193049] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.196137] cryptd: max_cpu_qlen set to 1000 [ 0.198194] ACPI: Added _OSI(Module Device) [ 0.199008] ACPI: Added _OSI(Processor Device) [ 0.199935] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.201007] ACPI: Added _OSI(Processor Aggregator Device) [ 0.204522] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.209527] ACPI: Interpreter enabled [ 0.211062] ACPI: PM: (supports S0 S3 S4 S5) [ 0.212011] ACPI: Using IOAPIC for interrupt routing [ 0.213104] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.216311] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.227061] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.229036] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.231018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.235088] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.239284] acpiphp: Slot [2] registered [ 0.239944] acpiphp: Slot [5] registered [ 0.240073] acpiphp: Slot [6] registered [ 0.240800] acpiphp: Slot [3] registered [ 0.241063] acpiphp: Slot [4] registered [ 0.241801] acpiphp: Slot [7] registered [ 0.243075] acpiphp: Slot [8] registered [ 0.243782] acpiphp: Slot [9] registered [ 0.244060] acpiphp: Slot [10] registered [ 0.244755] acpiphp: Slot [11] registered [ 0.245060] acpiphp: Slot [12] registered [ 0.245879] acpiphp: Slot [13] registered [ 0.247058] acpiphp: Slot [14] registered [ 0.247789] acpiphp: Slot [15] registered [ 0.248050] acpiphp: Slot [16] registered [ 0.248962] acpiphp: Slot [17] registered [ 0.250052] acpiphp: Slot [18] registered [ 0.250696] acpiphp: Slot [19] registered [ 0.252044] acpiphp: Slot [20] registered [ 0.253066] acpiphp: Slot [21] registered [ 0.253893] acpiphp: Slot [22] registered [ 0.254057] acpiphp: Slot [23] registered [ 0.254736] acpiphp: Slot [24] registered [ 0.255058] acpiphp: Slot [25] registered [ 0.255891] acpiphp: Slot [26] registered [ 0.257066] acpiphp: Slot [27] registered [ 0.257850] acpiphp: Slot [28] registered [ 0.258087] acpiphp: Slot [29] registered [ 0.258852] acpiphp: Slot [30] registered [ 0.260078] acpiphp: Slot [31] registered [ 0.261073] PCI host bridge to bus 0000:00 [ 0.262026] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.264016] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.265011] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.267012] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.268015] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.271026] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.272133] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.274688] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.277042] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.282447] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.285435] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.287012] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.289011] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.291017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.292401] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.295834] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.297026] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.298601] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.301966] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.311014] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.316014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.320818] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.326022] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.331017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.343019] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.351428] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.362015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.368016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.383014] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.392775] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.395408] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.396309] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.398272] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.400218] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.406139] iommu: Default domain type: Passthrough [ 0.408383] SCSI subsystem initialized [ 0.409131] ACPI: bus type USB registered [ 0.411107] usbcore: registered new interface driver usbfs [ 0.413074] usbcore: registered new interface driver hub [ 0.415075] usbcore: registered new device driver usb [ 0.416165] pps_core: LinuxPPS API ver. 1 registered [ 0.418012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.421061] PTP clock support registered [ 0.423067] EDAC MC: Ver: 3.0.0 [ 0.425157] PCI: Using ACPI for IRQ routing [ 0.426795] NetLabel: Initializing [ 0.428009] NetLabel: domain hash size = 128 [ 0.430011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.432097] NetLabel: unlabeled traffic allowed by default [ 0.433111] vgaarb: loaded [ 0.435070] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.436014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.442203] clocksource: Switched to clocksource kvm-clock [ 0.551584] VFS: Disk quotas dquot_6.6.0 [ 0.552905] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.554679] *** VALIDATE ramfs *** [ 0.555573] *** VALIDATE hugetlbfs *** [ 0.556710] pnp: PnP ACPI init [ 0.558731] pnp: PnP ACPI: found 6 devices [ 0.578177] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.580563] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.581980] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.583496] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.585267] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.587150] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.589219] NET: Registered protocol family 2 [ 0.591087] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.595246] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.598076] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.602036] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.606119] TCP: Hash tables configured (established 65536 bind 65536) [ 0.609180] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.612453] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.615203] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.618226] NET: Registered protocol family 1 [ 0.620623] RPC: Registered named UNIX socket transport module. [ 0.622980] RPC: Registered udp transport module. [ 0.624641] RPC: Registered tcp transport module. [ 0.626263] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.628633] NET: Registered protocol family 44 [ 0.630247] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.632511] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.634613] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.636855] PCI: CLS 0 bytes, default 64 [ 0.638441] Unpacking initramfs... [ 2.031883] debug: unmapping init [mem 0xffff9132bcc64000-0xffff9132bffcffff] [ 2.035365] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.037438] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.039942] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 2.517200] Initialise system trusted keyrings [ 2.518898] Key type blacklist registered [ 2.520432] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.528985] zbud: loaded [ 2.531772] *** VALIDATE nfs *** [ 2.532956] *** VALIDATE nfs4 *** [ 2.536906] pstore: using deflate compression [ 2.540643] Platform Keyring initialized [ 2.643840] NET: Registered protocol family 38 [ 2.645100] Key type asymmetric registered [ 2.646134] Asymmetric key parser 'x509' registered [ 2.647599] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.650147] io scheduler mq-deadline registered [ 2.651429] io scheduler kyber registered [ 2.652899] io scheduler bfq registered [ 2.654340] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.656852] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.659407] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.661631] ACPI: Power Button [PWRF] [ 2.666608] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.673426] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.693775] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.722133] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.749306] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.753458] Non-volatile memory driver v1.3 [ 2.754950] Linux agpgart interface v0.103 [ 2.790268] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 2.793586] vda: detected capacity change from 0 to 73097216 [ 2.830609] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.832787] vdb: detected capacity change from 0 to 1073741824 [ 2.848451] libphy: Fixed MDIO Bus: probed [ 2.856620] usbcore: registered new interface driver usbserial_generic [ 2.859050] usbserial: USB Serial support registered for generic [ 2.861454] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.865753] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.868046] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.870361] mousedev: PS/2 mouse device common for all mice [ 2.873261] rtc_cmos 00:05: RTC can wake from S4 [ 2.875917] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.879932] rtc_cmos 00:05: registered as rtc0 [ 2.882240] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.884340] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.885066] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.890898] intel_pstate: CPU model not supported [ 2.893603] hid: raw HID events driver (C) Jiri Kosina [ 2.895581] usbcore: registered new interface driver usbhid [ 2.897543] usbhid: USB HID core driver [ 2.898854] drop_monitor: Initializing network drop monitor service [ 2.901054] Initializing XFRM netlink socket [ 2.902884] NET: Registered protocol family 10 [ 2.905938] Segment Routing with IPv6 [ 2.907220] NET: Registered protocol family 17 [ 2.908979] mpls_gso: MPLS GSO support [ 2.914216] RAS: Correctable Errors collector initialized. [ 2.916595] AVX version of gcm_enc/dec engaged. [ 2.918044] AES CTR mode by8 optimization enabled [ 3.000273] sched_clock: Marking stable (3000237305, 0)->(3824544695, -824307390) [ 3.004230] registered taskstats version 1 [ 3.007154] Loading compiled-in X.509 certificates [ 3.008885] zswap: loaded using pool lzo/zbud [ 3.030858] Key type big_key registered [ 3.041804] Key type encrypted registered [ 3.043365] ima: No TPM chip found, activating TPM-bypass! [ 3.045422] ima: Allocated hash algorithm: sha1 [ 3.046882] ima: No architecture policies found [ 3.048675] evm: Initialising EVM extended attributes: [ 3.050719] evm: security.selinux [ 3.052110] evm: security.ima [ 3.053169] evm: security.capability [ 3.054244] evm: HMAC attrs: 0x1 [ 3.056586] rtc_cmos 00:05: setting system clock to 2026-09-10 16:36:49 UTC (1789058209) [ 3.061825] debug: unmapping init [mem 0xffffffffaf803000-0xffffffffaf9fffff] [ 3.064478] debug: unmapping init [mem 0xffffffffae582000-0xffffffffae858fff] [ 3.074205] Write protecting the kernel read-only data: 28672k [ 3.077730] debug: unmapping init [mem 0xffffffffacc03000-0xffffffffacdfffff] [ 3.080756] debug: unmapping init [mem 0xffffffffad514000-0xffffffffad5fffff] [ 3.122548] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.131206] systemd[1]: Detected virtualization kvm. [ 3.132960] systemd[1]: Detected architecture x86-64. [ 3.134484] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.158139] systemd[1]: No hostname configured. [ 3.159322] systemd[1]: Set hostname to . [ 3.160870] random: systemd: uninitialized urandom read (16 bytes read) [ 3.163215] systemd[1]: Initializing machine ID from random generator. [ 3.290989] random: systemd: uninitialized urandom read (16 bytes read) [ 3.293490] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.297636] random: systemd: uninitialized urandom read (16 bytes read) [ 3.299948] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.305112] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.864179] device-mapper: uevent: version 1.0.3 [ 3.865833] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK [ 4.532327] random: fast init done ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.621201] virtio_net virtio0 ens2: renamed from eth0 [ 4.730919] scsi host0: ata_piix [ 4.755247] scsi host1: ata_piix [ 4.757720] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.760138] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.317669] dracut-initqueue[592]: RTNETLINK answers: File exists [ 9.560958] random: crng init done [ 9.562445] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 9.919518] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 10.919080] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.124785] SELinux: Disabled at runtime. [ 11.182702] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.189703] systemd[1]: Detected virtualization kvm. [ 11.190809] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.603322] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.605557] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.608553] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.611134] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.614158] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.621090] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.624492] systemd[1]: Reached target rpc_pipefs.target. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-getty.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target RPC Port Mapper. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... Mounting Huge Pages File System... [ OK ] Listening on initctl Compatibility Named Pipe. Mounting POSIX Message Queue File System... [ OK [0[ 11.715212] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS m] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Starting Remount Root and Kernel File Systems... [ OK ] Listening on Process Core Dump Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Apply Kernel Variables... [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 12.112397] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.364458] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.408466] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.555897] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.564323] EDAC sbridge: Ver: 1.1.2 [ 13.535915] Key type dns_resolver registered [ 13.843098] NFS: Registering the id_resolver key type [ 13.845363] Key type id_resolver registered [ 13.847304] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Reached target sshd-keygen.target. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. Starting Login Service... Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg133-client login: [ 89.751182] libcfs: loading out-of-tree module taints kernel. [ 89.884270] Key type ._llcrypt registered [ 89.890109] Key type .llcrypt registered [ 90.296253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 90.311581] alg: No test for adler32 (adler32-zlib) [ 91.836831] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 92.663033] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 94.376097] Key type lgssc registered [ 96.074648] Lustre: Echo OBD driver; http://www.lustre.org/ [ 102.987376] alg: No test for zstdfast (zstdfast-lustre-generic) [ 103.016605] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 127.118393] hrtimer: interrupt took 7553441 ns [ 294.672370] Lustre: Mounted lustre-client [ 300.397643] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 316.672715] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing check_logdir /tmp/testlogs/ [ 320.481485] Lustre: lustre-OST0000-osc-ffff91330812e800: disconnect after 23s idle [ 322.417804] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing yml_node [ 327.070570] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 329.936890] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 332.776337] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 334.462733] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:42:19 EDT 2026 [ 351.638945] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 353.186703] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 355.003263] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a [ 356.532546] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51c 51e 834 [ 358.489907] Lustre: DEBUG MARKER: === sanity: start setup 12:42:43 (1789058563) === [ 362.201268] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing check_config_client /mnt/lustre [ 385.082133] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 403.060554] Lustre: DEBUG MARKER: === sanity: finish setup 12:43:26 (1789058606) === [ 415.672300] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:43:39 (1789058619) [ 417.133315] lustre_kcompr_1906: ***** [ 417.135449] lustre_kcompr_1906: (de)compression test on random binary data [ 417.138566] lustre_kcompr_1906: ***** [ 417.159654] lustre_kcompr_1906: compr lz4(1) in 64kB chunks took 2057 us (1944 MB/s), compress ratio: 96.75 [ 417.167829] lustre_kcompr_1906: compr lz4(1) in 128kB chunks took 2264 us (1766 MB/s), compress ratio: 101.42 [ 417.176411] lustre_kcompr_1906: compr lz4(1) in 256kB chunks took 1504 us (2659 MB/s), compress ratio: 104.06 [ 417.184932] lustre_kcompr_1906: compr lz4(1) in 512kB chunks took 2315 us (1727 MB/s), compress ratio: 105.47 [ 417.193594] lustre_kcompr_1906: compr lz4(1) in 1024kB chunks took 2770 us (1444 MB/s), compress ratio: 106.50 [ 417.215981] lustre_kcompr_1906: compr lz4(1) in 2048kB chunks took 3890 us (1028 MB/s), compress ratio: 107.05 [ 417.227508] lustre_kcompr_1906: compr lz4(1) in 4096kB chunks took 2570 us (1556 MB/s), compress ratio: 106.95 [ 417.247104] lustre_kcompr_1906: decompr lz4(1) took 2162 us (17 MB/s) [ 417.253533] lustre_kcompr_1906: test_comp_compress_decompress(lz4,1) ret 0 [ 417.261613] lustre_kcompr_1906: acompr lz4(1) of 128kB chunks took 290 us (431 MB/s), compress ratio: 108.23 [ 417.271843] lustre_kcompr_1906: adecompr lz4(1) took 102 us (11 MB/s) [ 417.291067] lustre_kcompr_1906: test_acomp_compress_decompress(lz4,1) ret 0 [ 417.334663] lustre_kcompr_1906: compr lz4(4) in 64kB chunks took 4000 us (1000 MB/s), compress ratio: 82.28 [ 417.349207] lustre_kcompr_1906: compr lz4(4) in 128kB chunks took 2762 us (1448 MB/s), compress ratio: 92.63 [ 417.364669] lustre_kcompr_1906: compr lz4(4) in 256kB chunks took 7965 us (502 MB/s), compress ratio: 98.74 [ 417.378947] lustre_kcompr_1906: compr lz4(4) in 512kB chunks took 1987 us (2013 MB/s), compress ratio: 102.70 [ 417.386286] lustre_kcompr_1906: compr lz4(4) in 1024kB chunks took 1917 us (2086 MB/s), compress ratio: 104.53 [ 417.393248] lustre_kcompr_1906: compr lz4(4) in 2048kB chunks took 1643 us (2434 MB/s), compress ratio: 104.72 [ 417.402412] lustre_kcompr_1906: compr lz4(4) in 4096kB chunks took 1978 us (2022 MB/s), compress ratio: 105.15 [ 417.416975] lustre_kcompr_1906: decompr lz4(4) took 1855 us (20 MB/s) [ 417.421082] lustre_kcompr_1906: test_comp_compress_decompress(lz4,4) ret 0 [ 417.425969] lustre_kcompr_1906: acompr lz4(4) of 128kB chunks took 315 us (396 MB/s), compress ratio: 94.63 [ 417.430522] lustre_kcompr_1906: adecompr lz4(4) took 102 us (12 MB/s) [ 417.439646] lustre_kcompr_1906: test_acomp_compress_decompress(lz4,4) ret 0 [ 417.450263] lustre_kcompr_1906: compr lz4(9) in 64kB chunks took 1889 us (2117 MB/s), compress ratio: 60.70 [ 417.463368] lustre_kcompr_1906: compr lz4(9) in 128kB chunks took 3302 us (1211 MB/s), compress ratio: 74.89 [ 417.480340] lustre_kcompr_1906: compr lz4(9) in 256kB chunks took 2048 us (1953 MB/s), compress ratio: 86.09 [ 417.487344] lustre_kcompr_1906: compr lz4(9) in 512kB chunks took 2101 us (1903 MB/s), compress ratio: 92.49 [ 417.493984] lustre_kcompr_1906: compr lz4(9) in 1024kB chunks took 1484 us (2695 MB/s), compress ratio: 96.31 [ 417.508417] lustre_kcompr_1906: compr lz4(9) in 2048kB chunks took 3682 us (1086 MB/s), compress ratio: 97.63 [ 417.517692] lustre_kcompr_1906: compr lz4(9) in 4096kB chunks took 1296 us (3086 MB/s), compress ratio: 100.22 [ 417.532168] lustre_kcompr_1906: decompr lz4(9) took 2097 us (19 MB/s) [ 417.537539] lustre_kcompr_1906: test_comp_compress_decompress(lz4,9) ret 0 [ 417.543356] lustre_kcompr_1906: acompr lz4(9) of 128kB chunks took 404 us (309 MB/s), compress ratio: 74.81 [ 417.548828] lustre_kcompr_1906: adecompr lz4(9) took 129 us (12 MB/s) [ 417.555843] lustre_kcompr_1906: test_acomp_compress_decompress(lz4,9) ret 0 [ 417.575581] lustre_kcompr_1906: compr lz4(15) in 64kB chunks took 2766 us (1446 MB/s), compress ratio: 29.39 [ 417.584756] lustre_kcompr_1906: compr lz4(15) in 128kB chunks took 1947 us (2054 MB/s), compress ratio: 43.62 [ 417.595968] lustre_kcompr_1906: compr lz4(15) in 256kB chunks took 3961 us (1009 MB/s), compress ratio: 58.70 [ 417.608572] lustre_kcompr_1906: compr lz4(15) in 512kB chunks took 1916 us (2087 MB/s), compress ratio: 70.65 [ 417.619263] lustre_kcompr_1906: compr lz4(15) in 1024kB chunks took 3503 us (1141 MB/s), compress ratio: 78.94 [ 417.629687] lustre_kcompr_1906: compr lz4(15) in 2048kB chunks took 2225 us (1797 MB/s), compress ratio: 82.61 [ 417.639631] lustre_kcompr_1906: compr lz4(15) in 4096kB chunks took 4076 us (981 MB/s), compress ratio: 86.30 [ 417.662550] lustre_kcompr_1906: decompr lz4(15) took 3093 us (14 MB/s) [ 417.670141] lustre_kcompr_1906: test_comp_compress_decompress(lz4,15) ret 0 [ 417.685689] lustre_kcompr_1906: acompr lz4(15) of 128kB chunks took 102 us (1225 MB/s), compress ratio: 45.27 [ 417.692524] lustre_kcompr_1906: adecompr lz4(15) took 515 us (5 MB/s) [ 417.711976] lustre_kcompr_1906: test_acomp_compress_decompress(lz4,15) ret 0 [ 417.785117] lustre_kcompr_1906: compr lz4hc(1) in 64kB chunks took 48892 us (81 MB/s), compress ratio: 97.48 [ 417.866324] lustre_kcompr_1906: compr lz4hc(1) in 128kB chunks took 68973 us (57 MB/s), compress ratio: 103.40 [ 418.041563] lustre_kcompr_1906: compr lz4hc(1) in 256kB chunks took 157330 us (25 MB/s), compress ratio: 106.63 [ 418.210108] lustre_kcompr_1906: compr lz4hc(1) in 512kB chunks took 144584 us (27 MB/s), compress ratio: 108.33 [ 418.340694] lustre_kcompr_1906: compr lz4hc(1) in 1024kB chunks took 105618 us (37 MB/s), compress ratio: 109.20 [ 418.412253] lustre_kcompr_1906: compr lz4hc(1) in 2048kB chunks took 55726 us (71 MB/s), compress ratio: 109.65 [ 418.462063] lustre_kcompr_1906: compr lz4hc(1) in 4096kB chunks took 44867 us (89 MB/s), compress ratio: 109.87 [ 418.500404] lustre_kcompr_1906: decompr lz4hc(1) took 4642 us (7 MB/s) [ 418.508735] lustre_kcompr_1906: test_comp_compress_decompress(lz4hc,1) ret 0 [ 418.517186] lustre_kcompr_1906: acompr lz4hc(1) of 128kB chunks took 592 us (211 MB/s), compress ratio: 111.93 [ 418.525811] lustre_kcompr_1906: adecompr lz4hc(1) took 90 us (12 MB/s) [ 418.576971] lustre_kcompr_1906: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 418.812843] lustre_kcompr_1906: compr lz4hc(3) in 64kB chunks took 182107 us (21 MB/s), compress ratio: 97.96 [ 418.968758] lustre_kcompr_1906: compr lz4hc(3) in 128kB chunks took 136184 us (29 MB/s), compress ratio: 103.89 [ 419.121554] lustre_kcompr_1906: compr lz4hc(3) in 256kB chunks took 134370 us (29 MB/s), compress ratio: 107.13 [ 419.218823] lustre_kcompr_1906: compr lz4hc(3) in 512kB chunks took 89150 us (44 MB/s), compress ratio: 108.83 [ 419.352797] lustre_kcompr_1906: compr lz4hc(3) in 1024kB chunks took 115726 us (34 MB/s), compress ratio: 109.70 [ 419.496764] lustre_kcompr_1906: compr lz4hc(3) in 2048kB chunks took 133031 us (30 MB/s), compress ratio: 110.16 [ 419.651239] lustre_kcompr_1906: compr lz4hc(3) in 4096kB chunks took 138758 us (28 MB/s), compress ratio: 110.38 [ 419.701097] lustre_kcompr_1906: decompr lz4hc(3) took 7532 us (4 MB/s) [ 419.706819] lustre_kcompr_1906: test_comp_compress_decompress(lz4hc,3) ret 0 [ 419.716436] lustre_kcompr_1906: acompr lz4hc(3) of 128kB chunks took 3953 us (31 MB/s), compress ratio: 112.31 [ 419.722114] lustre_kcompr_1906: adecompr lz4hc(3) took 147 us (7 MB/s) [ 419.729245] lustre_kcompr_1906: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 420.795679] lustre_kcompr_1906: compr lz4hc(8) in 64kB chunks took 1055056 us (3 MB/s), compress ratio: 104.47 [ 422.167818] lustre_kcompr_1906: compr lz4hc(8) in 128kB chunks took 1365438 us (2 MB/s), compress ratio: 111.62 [ 423.447343] lustre_kcompr_1906: compr lz4hc(8) in 256kB chunks took 1270425 us (3 MB/s), compress ratio: 115.49 [ 424.347708] lustre_kcompr_1906: compr lz4hc(8) in 512kB chunks took 863755 us (4 MB/s), compress ratio: 117.57 [ 424.809633] lustre_kcompr_1906: compr lz4hc(8) in 1024kB chunks took 457610 us (8 MB/s), compress ratio: 118.64 [ 426.725243] lustre_kcompr_1906: compr lz4hc(8) in 2048kB chunks took 1880599 us (2 MB/s), compress ratio: 119.19 [ 427.999993] Lustre: lustre-OST0000-osc-ffff91330812e800: disconnect after 24s idle [ 428.017364] Lustre: Skipped 1 previous similar message [ 428.082407] lustre_kcompr_1906: compr lz4hc(8) in 4096kB chunks took 1352652 us (2 MB/s), compress ratio: 119.45 [ 428.120547] lustre_kcompr_1906: decompr lz4hc(8) took 9676 us (3 MB/s) [ 428.134545] lustre_kcompr_1906: test_comp_compress_decompress(lz4hc,8) ret 0 [ 428.210727] lustre_kcompr_1906: acompr lz4hc(8) of 128kB chunks took 46143 us (2 MB/s), compress ratio: 118.61 [ 428.226060] lustre_kcompr_1906: adecompr lz4hc(8) took 94 us (11 MB/s) [ 428.246569] lustre_kcompr_1906: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 429.587801] lustre_kcompr_1906: compr lz4hc(15) in 64kB chunks took 1312401 us (3 MB/s), compress ratio: 104.95 [ 431.396424] lustre_kcompr_1906: compr lz4hc(15) in 128kB chunks took 1794049 us (2 MB/s), compress ratio: 112.57 [ 432.963582] lustre_kcompr_1906: compr lz4hc(15) in 256kB chunks took 1542905 us (2 MB/s), compress ratio: 116.73 [ 434.664381] lustre_kcompr_1906: compr lz4hc(15) in 512kB chunks took 1693610 us (2 MB/s), compress ratio: 118.94 [ 436.688144] lustre_kcompr_1906: compr lz4hc(15) in 1024kB chunks took 2000893 us (1 MB/s), compress ratio: 120.10 [ 437.545087] lustre_kcompr_1906: compr lz4hc(15) in 2048kB chunks took 848332 us (4 MB/s), compress ratio: 120.65 [ 438.506822] lustre_kcompr_1906: compr lz4hc(15) in 4096kB chunks took 956875 us (4 MB/s), compress ratio: 120.93 [ 438.517253] lustre_kcompr_1906: decompr lz4hc(15) took 1622 us (20 MB/s) [ 438.520955] lustre_kcompr_1906: test_comp_compress_decompress(lz4hc,15) ret 0 [ 438.605106] lustre_kcompr_1906: acompr lz4hc(15) of 128kB chunks took 78188 us (1 MB/s), compress ratio: 120.02 [ 438.611461] lustre_kcompr_1906: adecompr lz4hc(15) took 471 us (2 MB/s) [ 438.617860] lustre_kcompr_1906: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 438.632142] lustre_kcompr_1906: compr lzo(-1) in 64kB chunks took 10222 us (391 MB/s), compress ratio: 81.70 [ 438.640896] lustre_kcompr_1906: compr lzo(-1) in 128kB chunks took 3240 us (1234 MB/s), compress ratio: 86.35 [ 438.658058] lustre_kcompr_1906: compr lzo(-1) in 256kB chunks took 8897 us (449 MB/s), compress ratio: 86.93 [ 438.672695] lustre_kcompr_1906: compr lzo(-1) in 512kB chunks took 3713 us (1077 MB/s), compress ratio: 88.48 [ 438.682107] lustre_kcompr_1906: compr lzo(-1) in 1024kB chunks took 3818 us (1047 MB/s), compress ratio: 88.12 [ 438.697068] lustre_kcompr_1906: compr lzo(-1) in 2048kB chunks took 3927 us (1018 MB/s), compress ratio: 89.16 [ 438.704098] lustre_kcompr_1906: compr lzo(-1) in 4096kB chunks took 3278 us (1220 MB/s), compress ratio: 89.08 [ 438.721063] lustre_kcompr_1906: decompr lzo(-1) took 2209 us (20 MB/s) [ 438.735926] lustre_kcompr_1906: test_comp_compress_decompress(lzo,-1) ret 0 [ 438.751703] lustre_kcompr_1906: acompr lzo(-1) of 128kB chunks took 239 us (523 MB/s), compress ratio: 93.55 [ 438.758389] lustre_kcompr_1906: adecompr lzo(-1) took 541 us (2 MB/s) [ 438.774259] lustre_kcompr_1906: test_acomp_compress_decompress(lzo,-1) ret 0 [ 439.290649] lustre_kcompr_1906: compr deflate(1) in 64kB chunks took 489232 us (8 MB/s), compress ratio: 97.91 [ 439.785295] lustre_kcompr_1906: compr deflate(1) in 128kB chunks took 458153 us (8 MB/s), compress ratio: 108.13 [ 440.162423] lustre_kcompr_1906: compr deflate(1) in 256kB chunks took 371805 us (10 MB/s), compress ratio: 114.57 [ 440.445980] lustre_kcompr_1906: compr deflate(1) in 512kB chunks took 277399 us (14 MB/s), compress ratio: 118.40 [ 440.699047] lustre_kcompr_1906: compr deflate(1) in 1024kB chunks took 248018 us (16 MB/s), compress ratio: 120.23 [ 441.026029] lustre_kcompr_1906: compr deflate(1) in 2048kB chunks took 322843 us (12 MB/s), compress ratio: 121.18 [ 441.250450] lustre_kcompr_1906: compr deflate(1) in 4096kB chunks took 220394 us (18 MB/s), compress ratio: 121.46 [ 441.262723] lustre_kcompr_1906: decompr deflate(1) took 4002 us (8 MB/s) [ 441.269272] lustre_kcompr_1906: test_comp_compress_decompress(deflate,1) ret 0 [ 441.291988] lustre_kcompr_1906: acompr deflate(1) of 128kB chunks took 16886 us (7 MB/s), compress ratio: 116.61 [ 441.300326] lustre_kcompr_1906: adecompr deflate(1) took 196 us (5 MB/s) [ 441.315603] lustre_kcompr_1906: test_acomp_compress_decompress(deflate,1) ret 0 [ 441.700415] lustre_kcompr_1906: compr deflate(6) in 64kB chunks took 366652 us (10 MB/s), compress ratio: 97.91 [ 442.089861] lustre_kcompr_1906: compr deflate(6) in 128kB chunks took 383876 us (10 MB/s), compress ratio: 108.13 [ 442.367156] lustre_kcompr_1906: compr deflate(6) in 256kB chunks took 271515 us (14 MB/s), compress ratio: 114.57 [ 442.728071] lustre_kcompr_1906: compr deflate(6) in 512kB chunks took 356922 us (11 MB/s), compress ratio: 118.40 [ 443.148545] lustre_kcompr_1906: compr deflate(6) in 1024kB chunks took 414974 us (9 MB/s), compress ratio: 120.23 [ 443.480968] lustre_kcompr_1906: compr deflate(6) in 2048kB chunks took 326981 us (12 MB/s), compress ratio: 121.18 [ 444.186096] lustre_kcompr_1906: compr deflate(6) in 4096kB chunks took 695108 us (5 MB/s), compress ratio: 121.46 [ 444.231725] lustre_kcompr_1906: decompr deflate(6) took 13502 us (2 MB/s) [ 444.257967] lustre_kcompr_1906: test_comp_compress_decompress(deflate,6) ret 0 [ 444.292657] lustre_kcompr_1906: acompr deflate(6) of 128kB chunks took 24678 us (5 MB/s), compress ratio: 116.61 [ 444.300586] lustre_kcompr_1906: adecompr deflate(6) took 354 us (3 MB/s) [ 444.320974] lustre_kcompr_1906: test_acomp_compress_decompress(deflate,6) ret 0 [ 444.912665] lustre_kcompr_1906: compr deflate(9) in 64kB chunks took 559721 us (7 MB/s), compress ratio: 97.91 [ 445.441155] lustre_kcompr_1906: compr deflate(9) in 128kB chunks took 517625 us (7 MB/s), compress ratio: 108.13 [ 446.008443] lustre_kcompr_1906: compr deflate(9) in 256kB chunks took 554286 us (7 MB/s), compress ratio: 114.57 [ 446.331570] lustre_kcompr_1906: compr deflate(9) in 512kB chunks took 315973 us (12 MB/s), compress ratio: 118.40 [ 446.616576] lustre_kcompr_1906: compr deflate(9) in 1024kB chunks took 272340 us (14 MB/s), compress ratio: 120.23 [ 446.915667] lustre_kcompr_1906: compr deflate(9) in 2048kB chunks took 294325 us (13 MB/s), compress ratio: 121.18 [ 447.152746] lustre_kcompr_1906: compr deflate(9) in 4096kB chunks took 233242 us (17 MB/s), compress ratio: 121.46 [ 447.169961] lustre_kcompr_1906: decompr deflate(9) took 5888 us (5 MB/s) [ 447.175041] lustre_kcompr_1906: test_comp_compress_decompress(deflate,9) ret 0 [ 447.192893] lustre_kcompr_1906: acompr deflate(9) of 128kB chunks took 12938 us (9 MB/s), compress ratio: 116.61 [ 447.198812] lustre_kcompr_1906: adecompr deflate(9) took 181 us (5 MB/s) [ 447.205956] lustre_kcompr_1906: test_acomp_compress_decompress(deflate,9) ret 0 [ 447.221656] lustre_kcompr_1906: compr zstd(0) in 64kB chunks took 5801 us (689 MB/s), compress ratio: 158.95 [ 447.237409] lustre_kcompr_1906: compr zstd(0) in 128kB chunks took 12217 us (327 MB/s), compress ratio: 192.26 [ 447.256569] lustre_kcompr_1906: compr zstd(0) in 256kB chunks took 13635 us (293 MB/s), compress ratio: 204.42 [ 447.274576] lustre_kcompr_1906: compr zstd(0) in 512kB chunks took 13470 us (296 MB/s), compress ratio: 211.50 [ 447.285647] lustre_kcompr_1906: compr zstd(0) in 1024kB chunks took 5063 us (790 MB/s), compress ratio: 213.37 [ 447.299167] lustre_kcompr_1906: compr zstd(0) in 2048kB chunks took 5446 us (734 MB/s), compress ratio: 214.85 [ 447.311587] lustre_kcompr_1906: compr zstd(0) in 4096kB chunks took 5449 us (734 MB/s), compress ratio: 215.26 [ 447.334353] lustre_kcompr_1906: decompr zstd(0) took 3824 us (4 MB/s) [ 447.339928] lustre_kcompr_1906: test_comp_compress_decompress(zstd,0) ret 0 [ 447.346937] lustre_kcompr_1906: acompr zstd(0) of 128kB chunks took 292 us (428 MB/s), compress ratio: 215.22 [ 447.355662] lustre_kcompr_1906: adecompr zstd(0) took 245 us (2 MB/s) [ 447.365151] lustre_kcompr_1906: test_acomp_compress_decompress(zstd,0) ret 0 [ 447.389162] lustre_kcompr_1906: compr zstd(1) in 64kB chunks took 11214 us (356 MB/s), compress ratio: 158.00 [ 447.407262] lustre_kcompr_1906: compr zstd(1) in 128kB chunks took 2830 us (1413 MB/s), compress ratio: 190.50 [ 447.426572] lustre_kcompr_1906: compr zstd(1) in 256kB chunks took 3525 us (1134 MB/s), compress ratio: 202.63 [ 447.435903] lustre_kcompr_1906: compr zstd(1) in 512kB chunks took 4133 us (967 MB/s), compress ratio: 209.36 [ 447.443239] lustre_kcompr_1906: compr zstd(1) in 1024kB chunks took 1639 us (2440 MB/s), compress ratio: 212.74 [ 447.451232] lustre_kcompr_1906: compr zstd(1) in 2048kB chunks took 2735 us (1462 MB/s), compress ratio: 212.33 [ 447.459057] lustre_kcompr_1906: compr zstd(1) in 4096kB chunks took 1679 us (2382 MB/s), compress ratio: 212.36 [ 447.468787] lustre_kcompr_1906: decompr zstd(1) took 1922 us (9 MB/s) [ 447.472239] lustre_kcompr_1906: test_comp_compress_decompress(zstd,1) ret 0 [ 447.476694] lustre_kcompr_1906: acompr zstd(1) of 128kB chunks took 151 us (827 MB/s), compress ratio: 215.22 [ 447.480818] lustre_kcompr_1906: adecompr zstd(1) took 121 us (4 MB/s) [ 447.485065] lustre_kcompr_1906: test_acomp_compress_decompress(zstd,1) ret 0 [ 447.580208] lustre_kcompr_1906: compr zstd(10) in 64kB chunks took 88078 us (45 MB/s), compress ratio: 161.02 [ 447.668691] lustre_kcompr_1906: compr zstd(10) in 128kB chunks took 82191 us (48 MB/s), compress ratio: 183.60 [ 447.867389] lustre_kcompr_1906: compr zstd(10) in 256kB chunks took 193622 us (20 MB/s), compress ratio: 195.29 [ 447.960324] lustre_kcompr_1906: compr zstd(10) in 512kB chunks took 88782 us (45 MB/s), compress ratio: 216.60 [ 448.141680] lustre_kcompr_1906: compr zstd(10) in 1024kB chunks took 178874 us (22 MB/s), compress ratio: 220.76 [ 448.506397] lustre_kcompr_1906: compr zstd(10) in 2048kB chunks took 358893 us (11 MB/s), compress ratio: 222.67 [ 448.583926] lustre_kcompr_1906: compr zstd(10) in 4096kB chunks took 50489 us (79 MB/s), compress ratio: 223.94 [ 448.595784] lustre_kcompr_1906: decompr zstd(10) took 2116 us (8 MB/s) [ 448.601253] lustre_kcompr_1906: test_comp_compress_decompress(zstd,10) ret 0 [ 448.610504] lustre_kcompr_1906: acompr zstd(10) of 128kB chunks took 4110 us (30 MB/s), compress ratio: 205.76 [ 448.636129] lustre_kcompr_1906: adecompr zstd(10) took 10885 us (0 MB/s) [ 448.651662] lustre_kcompr_1906: test_acomp_compress_decompress(zstd,10) ret 0 [ 449.321446] lustre_kcompr_1906: compr zstd(15) in 64kB chunks took 649813 us (6 MB/s), compress ratio: 169.72 [ 449.825271] lustre_kcompr_1906: compr zstd(15) in 128kB chunks took 500098 us (7 MB/s), compress ratio: 195.07 [ 451.043593] lustre_kcompr_1906: compr zstd(15) in 256kB chunks took 1215079 us (3 MB/s), compress ratio: 208.38 [ 452.038711] lustre_kcompr_1906: compr zstd(15) in 512kB chunks took 976166 us (4 MB/s), compress ratio: 216.13 [ 452.760322] lustre_kcompr_1906: compr zstd(15) in 1024kB chunks took 710078 us (5 MB/s), compress ratio: 219.57 [ 454.364258] lustre_kcompr_1906: compr zstd(15) in 2048kB chunks took 1595169 us (2 MB/s), compress ratio: 220.39 [ 455.765743] lustre_kcompr_1906: compr zstd(15) in 4096kB chunks took 1378085 us (2 MB/s), compress ratio: 221.09 [ 455.814713] lustre_kcompr_1906: decompr zstd(15) took 19580 us (0 MB/s) [ 455.826723] lustre_kcompr_1906: test_comp_compress_decompress(zstd,15) ret 0 [ 455.849438] lustre_kcompr_1906: acompr zstd(15) of 128kB chunks took 18941 us (6 MB/s), compress ratio: 216.29 [ 455.855184] lustre_kcompr_1906: adecompr zstd(15) took 145 us (3 MB/s) [ 455.861110] lustre_kcompr_1906: test_acomp_compress_decompress(zstd,15) ret 0 [ 455.891651] lustre_kcompr_1906: compr zstdfast(1) in 64kB chunks took 9443 us (423 MB/s), compress ratio: 158.00 [ 455.905637] lustre_kcompr_1906: compr zstdfast(1) in 128kB chunks took 5303 us (754 MB/s), compress ratio: 190.46 [ 455.923337] lustre_kcompr_1906: compr zstdfast(1) in 256kB chunks took 14900 us (268 MB/s), compress ratio: 202.55 [ 455.942756] lustre_kcompr_1906: compr zstdfast(1) in 512kB chunks took 4481 us (892 MB/s), compress ratio: 209.36 [ 455.950160] lustre_kcompr_1906: compr zstdfast(1) in 1024kB chunks took 4074 us (981 MB/s), compress ratio: 212.68 [ 455.967590] lustre_kcompr_1906: compr zstdfast(1) in 2048kB chunks took 10077 us (396 MB/s), compress ratio: 212.06 [ 455.986832] lustre_kcompr_1906: compr zstdfast(1) in 4096kB chunks took 3890 us (1028 MB/s), compress ratio: 211.31 [ 456.016835] lustre_kcompr_1906: decompr zstdfast(1) took 8940 us (2 MB/s) [ 456.027917] lustre_kcompr_1906: test_comp_compress_decompress(zstdfast,1) ret 0 [ 456.040343] lustre_kcompr_1906: acompr zstdfast(1) of 128kB chunks took 392 us (318 MB/s), compress ratio: 215.22 [ 456.052603] lustre_kcompr_1906: adecompr zstdfast(1) took 118 us (4 MB/s) [ 456.090207] lustre_kcompr_1906: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 456.124734] lustre_kcompr_1906: compr zstdfast(5) in 64kB chunks took 4354 us (918 MB/s), compress ratio: 139.98 [ 456.131301] lustre_kcompr_1906: compr zstdfast(5) in 128kB chunks took 2929 us (1365 MB/s), compress ratio: 165.96 [ 456.137548] lustre_kcompr_1906: compr zstdfast(5) in 256kB chunks took 2434 us (1643 MB/s), compress ratio: 174.78 [ 456.144354] lustre_kcompr_1906: compr zstdfast(5) in 512kB chunks took 2747 us (1456 MB/s), compress ratio: 180.09 [ 456.150892] lustre_kcompr_1906: compr zstdfast(5) in 1024kB chunks took 2950 us (1355 MB/s), compress ratio: 182.88 [ 456.162743] lustre_kcompr_1906: compr zstdfast(5) in 2048kB chunks took 6246 us (640 MB/s), compress ratio: 182.08 [ 456.169410] lustre_kcompr_1906: compr zstdfast(5) in 4096kB chunks took 2953 us (1354 MB/s), compress ratio: 181.74 [ 456.185943] lustre_kcompr_1906: decompr zstdfast(5) took 1913 us (11 MB/s) [ 456.190664] lustre_kcompr_1906: test_comp_compress_decompress(zstdfast,5) ret 0 [ 456.195074] lustre_kcompr_1906: acompr zstdfast(5) of 128kB chunks took 219 us (570 MB/s), compress ratio: 189.95 [ 456.201030] lustre_kcompr_1906: adecompr zstdfast(5) took 94 us (7 MB/s) [ 456.209288] lustre_kcompr_1906: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 456.219738] lustre_kcompr_1906: compr zstdfast(12) in 64kB chunks took 2747 us (1456 MB/s), compress ratio: 38.14 [ 456.225712] lustre_kcompr_1906: compr zstdfast(12) in 128kB chunks took 2206 us (1813 MB/s), compress ratio: 43.38 [ 456.231500] lustre_kcompr_1906: compr zstdfast(12) in 256kB chunks took 1927 us (2075 MB/s), compress ratio: 47.21 [ 456.237520] lustre_kcompr_1906: compr zstdfast(12) in 512kB chunks took 1806 us (2214 MB/s), compress ratio: 51.76 [ 456.245209] lustre_kcompr_1906: compr zstdfast(12) in 1024kB chunks took 2580 us (1550 MB/s), compress ratio: 60.24 [ 456.251501] lustre_kcompr_1906: compr zstdfast(12) in 2048kB chunks took 1848 us (2164 MB/s), compress ratio: 84.37 [ 456.259044] lustre_kcompr_1906: compr zstdfast(12) in 4096kB chunks took 4712 us (848 MB/s), compress ratio: 85.05 [ 456.291450] lustre_kcompr_1906: decompr zstdfast(12) took 7208 us (6 MB/s) [ 456.308265] lustre_kcompr_1906: test_comp_compress_decompress(zstdfast,12) ret 0 [ 456.314623] lustre_kcompr_1906: acompr zstdfast(12) of 128kB chunks took 129 us (968 MB/s), compress ratio: 50.86 [ 456.327640] lustre_kcompr_1906: adecompr zstdfast(12) took 121 us (20 MB/s) [ 456.335189] lustre_kcompr_1906: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 456.348046] lustre_kcompr_1906: compr zstdfast(15) in 64kB chunks took 2574 us (1554 MB/s), compress ratio: 19.05 [ 456.368475] lustre_kcompr_1906: compr zstdfast(15) in 128kB chunks took 2493 us (1604 MB/s), compress ratio: 19.71 [ 456.374700] lustre_kcompr_1906: compr zstdfast(15) in 256kB chunks took 2147 us (1863 MB/s), compress ratio: 19.93 [ 456.381232] lustre_kcompr_1906: compr zstdfast(15) in 512kB chunks took 2328 us (1718 MB/s), compress ratio: 20.57 [ 456.402422] lustre_kcompr_1906: compr zstdfast(15) in 1024kB chunks took 2240 us (1785 MB/s), compress ratio: 23.45 [ 456.419182] lustre_kcompr_1906: compr zstdfast(15) in 2048kB chunks took 7657 us (522 MB/s), compress ratio: 25.83 [ 456.445826] lustre_kcompr_1906: compr zstdfast(15) in 4096kB chunks took 2248 us (1779 MB/s), compress ratio: 27.56 [ 456.457792] lustre_kcompr_1906: decompr zstdfast(15) took 2004 us (72 MB/s) [ 456.471501] lustre_kcompr_1906: test_comp_compress_decompress(zstdfast,15) ret 0 [ 456.483937] lustre_kcompr_1906: acompr zstdfast(15) of 128kB chunks took 416 us (300 MB/s), compress ratio: 21.30 [ 456.505171] lustre_kcompr_1906: adecompr zstdfast(15) took 2625 us (2 MB/s) [ 456.540375] lustre_kcompr_1906: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 456.550119] lustre_kcompr_1906: SUCCESS [ 462.750161] lustre_kcompr_30805: ***** [ 462.754513] lustre_kcompr_30805: (de)compression test on provided file /tmp/f84.sanity [ 462.767261] lustre_kcompr_30805: ***** [ 462.832448] lustre_kcompr_30805: compr lz4(1) in 64kB chunks took 45770 us (87 MB/s), compress ratio: 2.93 [ 462.889263] lustre_kcompr_30805: compr lz4(1) in 128kB chunks took 49454 us (80 MB/s), compress ratio: 3.04 [ 462.948446] lustre_kcompr_30805: compr lz4(1) in 256kB chunks took 46007 us (86 MB/s), compress ratio: 3.08 [ 463.005935] lustre_kcompr_30805: compr lz4(1) in 512kB chunks took 46517 us (85 MB/s), compress ratio: 3.10 [ 463.038752] lustre_kcompr_30805: compr lz4(1) in 1024kB chunks took 25829 us (154 MB/s), compress ratio: 3.11 [ 463.098976] lustre_kcompr_30805: compr lz4(1) in 2048kB chunks took 55229 us (72 MB/s), compress ratio: 3.11 [ 463.192474] lustre_kcompr_30805: compr lz4(1) in 4096kB chunks took 70846 us (56 MB/s), compress ratio: 3.12 [ 463.227689] lustre_kcompr_30805: decompr lz4(1) took 10933 us (117 MB/s) [ 463.235933] lustre_kcompr_30805: test_comp_compress_decompress(lz4,1) ret 0 [ 463.243279] lustre_kcompr_30805: acompr lz4(1) of 128kB chunks took 1330 us (93 MB/s), compress ratio: 2.68 [ 463.254517] lustre_kcompr_30805: adecompr lz4(1) took 272 us (171 MB/s) [ 463.269517] lustre_kcompr_30805: test_acomp_compress_decompress(lz4,1) ret 0 [ 463.310396] lustre_kcompr_30805: compr lz4(4) in 64kB chunks took 27503 us (145 MB/s), compress ratio: 2.67 [ 463.341703] lustre_kcompr_30805: compr lz4(4) in 128kB chunks took 24952 us (160 MB/s), compress ratio: 2.63 [ 463.370872] lustre_kcompr_30805: compr lz4(4) in 256kB chunks took 23317 us (171 MB/s), compress ratio: 2.68 [ 463.400944] lustre_kcompr_30805: compr lz4(4) in 512kB chunks took 24388 us (164 MB/s), compress ratio: 2.71 [ 463.427713] lustre_kcompr_30805: compr lz4(4) in 1024kB chunks took 21401 us (186 MB/s), compress ratio: 2.72 [ 463.457832] lustre_kcompr_30805: compr lz4(4) in 2048kB chunks took 24367 us (164 MB/s), compress ratio: 2.72 [ 463.485367] lustre_kcompr_30805: compr lz4(4) in 4096kB chunks took 20525 us (194 MB/s), compress ratio: 2.73 [ 463.499696] lustre_kcompr_30805: decompr lz4(4) took 5254 us (278 MB/s) [ 463.503481] lustre_kcompr_30805: test_comp_compress_decompress(lz4,4) ret 0 [ 463.508375] lustre_kcompr_30805: acompr lz4(4) of 128kB chunks took 695 us (179 MB/s), compress ratio: 2.30 [ 463.512364] lustre_kcompr_30805: adecompr lz4(4) took 601 us (90 MB/s) [ 463.516823] lustre_kcompr_30805: test_acomp_compress_decompress(lz4,4) ret 0 [ 463.547863] lustre_kcompr_30805: compr lz4(9) in 64kB chunks took 13994 us (285 MB/s), compress ratio: 2.30 [ 463.568286] lustre_kcompr_30805: compr lz4(9) in 128kB chunks took 15551 us (257 MB/s), compress ratio: 2.15 [ 463.587503] lustre_kcompr_30805: compr lz4(9) in 256kB chunks took 15319 us (261 MB/s), compress ratio: 2.20 [ 463.605831] lustre_kcompr_30805: compr lz4(9) in 512kB chunks took 14276 us (280 MB/s), compress ratio: 2.23 [ 463.631585] lustre_kcompr_30805: compr lz4(9) in 1024kB chunks took 21664 us (184 MB/s), compress ratio: 2.25 [ 463.650798] lustre_kcompr_30805: compr lz4(9) in 2048kB chunks took 15271 us (261 MB/s), compress ratio: 2.25 [ 463.673678] lustre_kcompr_30805: compr lz4(9) in 4096kB chunks took 18038 us (221 MB/s), compress ratio: 2.26 [ 463.692705] lustre_kcompr_30805: decompr lz4(9) took 7496 us (236 MB/s) [ 463.696745] lustre_kcompr_30805: test_comp_compress_decompress(lz4,9) ret 0 [ 463.701248] lustre_kcompr_30805: acompr lz4(9) of 128kB chunks took 671 us (186 MB/s), compress ratio: 1.87 [ 463.704570] lustre_kcompr_30805: adecompr lz4(9) took 170 us (392 MB/s) [ 463.708964] lustre_kcompr_30805: test_acomp_compress_decompress(lz4,9) ret 0 [ 463.723625] lustre_kcompr_30805: compr lz4(15) in 64kB chunks took 7523 us (531 MB/s), compress ratio: 1.63 [ 463.734443] lustre_kcompr_30805: compr lz4(15) in 128kB chunks took 7895 us (506 MB/s), compress ratio: 1.52 [ 463.745086] lustre_kcompr_30805: compr lz4(15) in 256kB chunks took 8316 us (481 MB/s), compress ratio: 1.56 [ 463.758605] lustre_kcompr_30805: compr lz4(15) in 512kB chunks took 10795 us (370 MB/s), compress ratio: 1.58 [ 463.774640] lustre_kcompr_30805: compr lz4(15) in 1024kB chunks took 13268 us (301 MB/s), compress ratio: 1.60 [ 463.793849] lustre_kcompr_30805: compr lz4(15) in 2048kB chunks took 14515 us (275 MB/s), compress ratio: 1.60 [ 463.814625] lustre_kcompr_30805: compr lz4(15) in 4096kB chunks took 16373 us (244 MB/s), compress ratio: 1.60 [ 463.835845] lustre_kcompr_30805: decompr lz4(15) took 8755 us (284 MB/s) [ 463.839808] lustre_kcompr_30805: test_comp_compress_decompress(lz4,15) ret 0 [ 463.842624] lustre_kcompr_30805: acompr lz4(15) of 128kB chunks took 333 us (375 MB/s), compress ratio: 1.33 [ 463.850847] lustre_kcompr_30805: adecompr lz4(15) took 138 us (680 MB/s) [ 463.854572] lustre_kcompr_30805: test_acomp_compress_decompress(lz4,15) ret 0 [ 464.078583] lustre_kcompr_30805: compr lz4hc(1) in 64kB chunks took 215432 us (18 MB/s), compress ratio: 3.58 [ 464.396438] lustre_kcompr_30805: compr lz4hc(1) in 128kB chunks took 307087 us (13 MB/s), compress ratio: 3.77 [ 464.740916] lustre_kcompr_30805: compr lz4hc(1) in 256kB chunks took 338061 us (11 MB/s), compress ratio: 3.88 [ 465.258467] lustre_kcompr_30805: compr lz4hc(1) in 512kB chunks took 500059 us (7 MB/s), compress ratio: 3.93 [ 465.744253] lustre_kcompr_30805: compr lz4hc(1) in 1024kB chunks took 460444 us (8 MB/s), compress ratio: 3.96 [ 466.073919] lustre_kcompr_30805: compr lz4hc(1) in 2048kB chunks took 315410 us (12 MB/s), compress ratio: 3.97 [ 466.438197] lustre_kcompr_30805: compr lz4hc(1) in 4096kB chunks took 358220 us (11 MB/s), compress ratio: 3.98 [ 466.478185] lustre_kcompr_30805: decompr lz4hc(1) took 16707 us (60 MB/s) [ 466.485202] lustre_kcompr_30805: test_comp_compress_decompress(lz4hc,1) ret 0 [ 466.511859] lustre_kcompr_30805: acompr lz4hc(1) of 128kB chunks took 9031 us (13 MB/s), compress ratio: 3.27 [ 466.535436] lustre_kcompr_30805: adecompr lz4hc(1) took 211 us (181 MB/s) [ 466.546660] lustre_kcompr_30805: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 466.828791] lustre_kcompr_30805: compr lz4hc(3) in 64kB chunks took 269971 us (14 MB/s), compress ratio: 3.68 [ 467.144597] lustre_kcompr_30805: compr lz4hc(3) in 128kB chunks took 307520 us (13 MB/s), compress ratio: 3.91 [ 467.379869] lustre_kcompr_30805: compr lz4hc(3) in 256kB chunks took 226340 us (17 MB/s), compress ratio: 4.04 [ 467.656439] lustre_kcompr_30805: compr lz4hc(3) in 512kB chunks took 269591 us (14 MB/s), compress ratio: 4.10 [ 468.172812] lustre_kcompr_30805: compr lz4hc(3) in 1024kB chunks took 507588 us (7 MB/s), compress ratio: 4.13 [ 468.750883] lustre_kcompr_30805: compr lz4hc(3) in 2048kB chunks took 560018 us (7 MB/s), compress ratio: 4.15 [ 469.086517] lustre_kcompr_30805: compr lz4hc(3) in 4096kB chunks took 327038 us (12 MB/s), compress ratio: 4.16 [ 469.109868] lustre_kcompr_30805: decompr lz4hc(3) took 7925 us (121 MB/s) [ 469.118247] lustre_kcompr_30805: test_comp_compress_decompress(lz4hc,3) ret 0 [ 469.144555] lustre_kcompr_30805: acompr lz4hc(3) of 128kB chunks took 23400 us (5 MB/s), compress ratio: 3.38 [ 469.157515] lustre_kcompr_30805: adecompr lz4hc(3) took 755 us (48 MB/s) [ 469.178510] lustre_kcompr_30805: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 470.075669] lustre_kcompr_30805: compr lz4hc(8) in 64kB chunks took 857158 us (4 MB/s), compress ratio: 3.72 [ 471.205252] lustre_kcompr_30805: compr lz4hc(8) in 128kB chunks took 1117978 us (3 MB/s), compress ratio: 3.96 [ 471.643882] lustre_kcompr_30805: compr lz4hc(8) in 256kB chunks took 434355 us (9 MB/s), compress ratio: 4.10 [ 472.056529] lustre_kcompr_30805: compr lz4hc(8) in 512kB chunks took 408782 us (9 MB/s), compress ratio: 4.17 [ 472.622770] lustre_kcompr_30805: compr lz4hc(8) in 1024kB chunks took 560265 us (7 MB/s), compress ratio: 4.21 [ 473.684001] lustre_kcompr_30805: compr lz4hc(8) in 2048kB chunks took 1056286 us (3 MB/s), compress ratio: 4.22 [ 474.261656] lustre_kcompr_30805: compr lz4hc(8) in 4096kB chunks took 569971 us (7 MB/s), compress ratio: 4.23 [ 474.281069] lustre_kcompr_30805: decompr lz4hc(8) took 5441 us (173 MB/s) [ 474.284974] lustre_kcompr_30805: test_comp_compress_decompress(lz4hc,8) ret 0 [ 474.303624] lustre_kcompr_30805: acompr lz4hc(8) of 128kB chunks took 11987 us (10 MB/s), compress ratio: 3.42 [ 474.333632] lustre_kcompr_30805: adecompr lz4hc(8) took 582 us (62 MB/s) [ 474.403105] lustre_kcompr_30805: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 475.007224] lustre_kcompr_30805: compr lz4hc(15) in 64kB chunks took 559884 us (7 MB/s), compress ratio: 3.72 [ 475.221453] lustre_kcompr_30805: compr lz4hc(15) in 128kB chunks took 204635 us (19 MB/s), compress ratio: 3.96 [ 475.597367] lustre_kcompr_30805: compr lz4hc(15) in 256kB chunks took 371686 us (10 MB/s), compress ratio: 4.10 [ 476.964206] lustre_kcompr_30805: compr lz4hc(15) in 512kB chunks took 1359809 us (2 MB/s), compress ratio: 4.17 [ 477.540131] lustre_kcompr_30805: compr lz4hc(15) in 1024kB chunks took 567039 us (7 MB/s), compress ratio: 4.21 [ 478.101769] lustre_kcompr_30805: compr lz4hc(15) in 2048kB chunks took 535906 us (7 MB/s), compress ratio: 4.22 [ 478.785413] lustre_kcompr_30805: compr lz4hc(15) in 4096kB chunks took 679604 us (5 MB/s), compress ratio: 4.23 [ 478.816467] lustre_kcompr_30805: decompr lz4hc(15) took 9013 us (104 MB/s) [ 478.824348] lustre_kcompr_30805: test_comp_compress_decompress(lz4hc,15) ret 0 [ 478.878098] lustre_kcompr_30805: acompr lz4hc(15) of 128kB chunks took 48374 us (2 MB/s), compress ratio: 3.42 [ 478.914625] lustre_kcompr_30805: adecompr lz4hc(15) took 2826 us (12 MB/s) [ 478.935887] lustre_kcompr_30805: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 479.000889] lustre_kcompr_30805: compr lzo(-1) in 64kB chunks took 41893 us (95 MB/s), compress ratio: 2.90 [ 479.036796] lustre_kcompr_30805: compr lzo(-1) in 128kB chunks took 28080 us (142 MB/s), compress ratio: 2.95 [ 479.089740] lustre_kcompr_30805: compr lzo(-1) in 256kB chunks took 46285 us (86 MB/s), compress ratio: 2.96 [ 479.161963] lustre_kcompr_30805: compr lzo(-1) in 512kB chunks took 55046 us (72 MB/s), compress ratio: 2.98 [ 479.298059] lustre_kcompr_30805: compr lzo(-1) in 1024kB chunks took 82915 us (48 MB/s), compress ratio: 2.97 [ 479.331785] lustre_kcompr_30805: compr lzo(-1) in 2048kB chunks took 28621 us (139 MB/s), compress ratio: 2.97 [ 479.445599] lustre_kcompr_30805: compr lzo(-1) in 4096kB chunks took 104972 us (38 MB/s), compress ratio: 2.96 [ 479.501036] lustre_kcompr_30805: decompr lzo(-1) took 27346 us (49 MB/s) [ 479.513680] lustre_kcompr_30805: test_comp_compress_decompress(lzo,-1) ret 0 [ 479.522238] lustre_kcompr_30805: acompr lzo(-1) of 128kB chunks took 569 us (219 MB/s), compress ratio: 2.62 [ 479.528110] lustre_kcompr_30805: adecompr lzo(-1) took 278 us (171 MB/s) [ 479.544492] lustre_kcompr_30805: test_acomp_compress_decompress(lzo,-1) ret 0 [ 480.682768] lustre_kcompr_30805: compr deflate(1) in 64kB chunks took 1110667 us (3 MB/s), compress ratio: 3.51 [ 481.902057] lustre_kcompr_30805: compr deflate(1) in 128kB chunks took 1204324 us (3 MB/s), compress ratio: 3.53 [ 482.735977] lustre_kcompr_30805: compr deflate(1) in 256kB chunks took 827491 us (4 MB/s), compress ratio: 3.53 [ 483.242163] lustre_kcompr_30805: compr deflate(1) in 512kB chunks took 502949 us (7 MB/s), compress ratio: 3.54 [ 483.703891] lustre_kcompr_30805: compr deflate(1) in 1024kB chunks took 456702 us (8 MB/s), compress ratio: 3.54 [ 484.372268] lustre_kcompr_30805: compr deflate(1) in 2048kB chunks took 662172 us (6 MB/s), compress ratio: 3.54 [ 484.884836] lustre_kcompr_30805: compr deflate(1) in 4096kB chunks took 505458 us (7 MB/s), compress ratio: 3.54 [ 484.938731] lustre_kcompr_30805: decompr deflate(1) took 40511 us (27 MB/s) [ 484.959233] lustre_kcompr_30805: test_comp_compress_decompress(deflate,1) ret 0 [ 484.987299] lustre_kcompr_30805: acompr deflate(1) of 128kB chunks took 21901 us (5 MB/s), compress ratio: 3.09 [ 484.997052] lustre_kcompr_30805: adecompr deflate(1) took 1045 us (38 MB/s) [ 485.010517] lustre_kcompr_30805: test_acomp_compress_decompress(deflate,1) ret 0 [ 485.441453] lustre_kcompr_30805: compr deflate(6) in 64kB chunks took 413303 us (9 MB/s), compress ratio: 3.51 [ 485.890212] lustre_kcompr_30805: compr deflate(6) in 128kB chunks took 445449 us (8 MB/s), compress ratio: 3.53 [ 486.973072] lustre_kcompr_30805: compr deflate(6) in 256kB chunks took 1078184 us (3 MB/s), compress ratio: 3.53 [ 487.789426] lustre_kcompr_30805: compr deflate(6) in 512kB chunks took 807331 us (4 MB/s), compress ratio: 3.54 [ 488.760423] lustre_kcompr_30805: compr deflate(6) in 1024kB chunks took 953645 us (4 MB/s), compress ratio: 3.54 [ 489.535202] lustre_kcompr_30805: compr deflate(6) in 2048kB chunks took 761747 us (5 MB/s), compress ratio: 3.54 [ 490.129705] lustre_kcompr_30805: compr deflate(6) in 4096kB chunks took 583150 us (6 MB/s), compress ratio: 3.54 [ 490.173161] lustre_kcompr_30805: decompr deflate(6) took 32173 us (35 MB/s) [ 490.177633] lustre_kcompr_30805: test_comp_compress_decompress(deflate,6) ret 0 [ 490.200143] lustre_kcompr_30805: acompr deflate(6) of 128kB chunks took 17526 us (7 MB/s), compress ratio: 3.09 [ 490.207040] lustre_kcompr_30805: adecompr deflate(6) took 1854 us (21 MB/s) [ 490.215671] lustre_kcompr_30805: test_acomp_compress_decompress(deflate,6) ret 0 [ 490.629971] lustre_kcompr_30805: compr deflate(9) in 64kB chunks took 402372 us (9 MB/s), compress ratio: 3.51 [ 491.139560] lustre_kcompr_30805: compr deflate(9) in 128kB chunks took 503131 us (7 MB/s), compress ratio: 3.53 [ 492.134129] lustre_kcompr_30805: compr deflate(9) in 256kB chunks took 984024 us (4 MB/s), compress ratio: 3.53 [ 492.689335] lustre_kcompr_30805: compr deflate(9) in 512kB chunks took 549567 us (7 MB/s), compress ratio: 3.54 [ 493.146955] lustre_kcompr_30805: compr deflate(9) in 1024kB chunks took 453286 us (8 MB/s), compress ratio: 3.54 [ 493.585954] lustre_kcompr_30805: compr deflate(9) in 2048kB chunks took 434678 us (9 MB/s), compress ratio: 3.54 [ 494.138503] lustre_kcompr_30805: compr deflate(9) in 4096kB chunks took 546857 us (7 MB/s), compress ratio: 3.54 [ 494.184631] lustre_kcompr_30805: decompr deflate(9) took 34067 us (33 MB/s) [ 494.188477] lustre_kcompr_30805: test_comp_compress_decompress(deflate,9) ret 0 [ 494.204583] lustre_kcompr_30805: acompr deflate(9) of 128kB chunks took 12717 us (9 MB/s), compress ratio: 3.09 [ 494.209701] lustre_kcompr_30805: adecompr deflate(9) took 1182 us (34 MB/s) [ 494.216927] lustre_kcompr_30805: test_acomp_compress_decompress(deflate,9) ret 0 [ 494.287719] lustre_kcompr_30805: compr zstd(0) in 64kB chunks took 61454 us (65 MB/s), compress ratio: 4.28 [ 494.360680] lustre_kcompr_30805: compr zstd(0) in 128kB chunks took 68194 us (58 MB/s), compress ratio: 4.46 [ 494.440141] lustre_kcompr_30805: compr zstd(0) in 256kB chunks took 74552 us (53 MB/s), compress ratio: 4.61 [ 494.581333] lustre_kcompr_30805: compr zstd(0) in 512kB chunks took 137429 us (29 MB/s), compress ratio: 4.72 [ 494.988958] lustre_kcompr_30805: compr zstd(0) in 1024kB chunks took 391721 us (10 MB/s), compress ratio: 4.80 [ 495.111166] lustre_kcompr_30805: compr zstd(0) in 2048kB chunks took 114053 us (35 MB/s), compress ratio: 4.85 [ 495.277749] lustre_kcompr_30805: compr zstd(0) in 4096kB chunks took 161694 us (24 MB/s), compress ratio: 4.88 [ 495.299829] lustre_kcompr_30805: decompr zstd(0) took 15189 us (53 MB/s) [ 495.302514] lustre_kcompr_30805: test_comp_compress_decompress(zstd,0) ret 0 [ 495.306825] lustre_kcompr_30805: acompr zstd(0) of 128kB chunks took 1492 us (83 MB/s), compress ratio: 3.98 [ 495.309768] lustre_kcompr_30805: adecompr zstd(0) took 354 us (88 MB/s) [ 495.313302] lustre_kcompr_30805: test_acomp_compress_decompress(zstd,0) ret 0 [ 495.399716] lustre_kcompr_30805: compr zstd(1) in 64kB chunks took 66085 us (60 MB/s), compress ratio: 4.06 [ 495.441577] lustre_kcompr_30805: compr zstd(1) in 128kB chunks took 36309 us (110 MB/s), compress ratio: 4.20 [ 495.480042] lustre_kcompr_30805: compr zstd(1) in 256kB chunks took 35675 us (112 MB/s), compress ratio: 4.34 [ 495.521397] lustre_kcompr_30805: compr zstd(1) in 512kB chunks took 37962 us (105 MB/s), compress ratio: 4.34 [ 495.563600] lustre_kcompr_30805: compr zstd(1) in 1024kB chunks took 37969 us (105 MB/s), compress ratio: 4.37 [ 495.595967] lustre_kcompr_30805: compr zstd(1) in 2048kB chunks took 29937 us (133 MB/s), compress ratio: 4.39 [ 495.638710] lustre_kcompr_30805: compr zstd(1) in 4096kB chunks took 38309 us (104 MB/s), compress ratio: 4.40 [ 495.658192] lustre_kcompr_30805: decompr zstd(1) took 10461 us (86 MB/s) [ 495.660980] lustre_kcompr_30805: test_comp_compress_decompress(zstd,1) ret 0 [ 495.664652] lustre_kcompr_30805: acompr zstd(1) of 128kB chunks took 1032 us (121 MB/s), compress ratio: 3.73 [ 495.667913] lustre_kcompr_30805: adecompr zstd(1) took 460 us (72 MB/s) [ 495.671354] lustre_kcompr_30805: test_acomp_compress_decompress(zstd,1) ret 0 [ 496.533765] lustre_kcompr_30805: compr zstd(10) in 64kB chunks took 855919 us (4 MB/s), compress ratio: 4.80 [ 498.495423] lustre_kcompr_30805: compr zstd(10) in 128kB chunks took 1954613 us (2 MB/s), compress ratio: 5.09 [ 500.437273] lustre_kcompr_30805: compr zstd(10) in 256kB chunks took 1934222 us (2 MB/s), compress ratio: 5.34 [ 501.846583] lustre_kcompr_30805: compr zstd(10) in 512kB chunks took 1404679 us (2 MB/s), compress ratio: 5.45 [ 502.831219] lustre_kcompr_30805: compr zstd(10) in 1024kB chunks took 975555 us (4 MB/s), compress ratio: 5.62 [ 504.472824] lustre_kcompr_30805: compr zstd(10) in 2048kB chunks took 1633173 us (2 MB/s), compress ratio: 5.76 [ 505.294499] lustre_kcompr_30805: compr zstd(10) in 4096kB chunks took 811986 us (4 MB/s), compress ratio: 5.89 [ 505.386668] lustre_kcompr_30805: decompr zstd(10) took 63407 us (10 MB/s) [ 505.404212] lustre_kcompr_30805: test_comp_compress_decompress(zstd,10) ret 0 [ 505.455572] lustre_kcompr_30805: acompr zstd(10) of 128kB chunks took 40342 us (3 MB/s), compress ratio: 4.46 [ 505.459360] lustre_kcompr_30805: adecompr zstd(10) took 452 us (62 MB/s) [ 505.504140] lustre_kcompr_30805: test_acomp_compress_decompress(zstd,10) ret 0 [ 517.889169] lustre_kcompr_30805: compr zstd(15) in 64kB chunks took 12359492 us (0 MB/s), compress ratio: 4.96 [ 529.964989] lustre_kcompr_30805: compr zstd(15) in 128kB chunks took 12070714 us (0 MB/s), compress ratio: 5.28 [ 544.634568] lustre_kcompr_30805: compr zstd(15) in 256kB chunks took 14664249 us (0 MB/s), compress ratio: 5.57 [ 557.086635] lustre_kcompr_30805: compr zstd(15) in 512kB chunks took 12437135 us (0 MB/s), compress ratio: 5.83 [ 567.498514] lustre_kcompr_30805: compr zstd(15) in 1024kB chunks took 10406316 us (0 MB/s), compress ratio: 6.06 [ 579.213349] lustre_kcompr_30805: compr zstd(15) in 2048kB chunks took 11707704 us (0 MB/s), compress ratio: 6.26 [ 595.411110] lustre_kcompr_30805: compr zstd(15) in 4096kB chunks took 16194431 us (0 MB/s), compress ratio: 6.46 [ 595.440183] lustre_kcompr_30805: decompr zstd(15) took 19685 us (31 MB/s) [ 595.445949] lustre_kcompr_30805: test_comp_compress_decompress(zstd,15) ret 0 [ 595.832372] lustre_kcompr_30805: acompr zstd(15) of 128kB chunks took 366150 us (0 MB/s), compress ratio: 4.64 [ 595.837574] lustre_kcompr_30805: adecompr zstd(15) took 970 us (27 MB/s) [ 595.846175] lustre_kcompr_30805: test_acomp_compress_decompress(zstd,15) ret 0 [ 595.964370] lustre_kcompr_30805: compr zstdfast(1) in 64kB chunks took 99568 us (40 MB/s), compress ratio: 3.49 [ 596.018098] lustre_kcompr_30805: compr zstdfast(1) in 128kB chunks took 49254 us (81 MB/s), compress ratio: 3.62 [ 596.057247] lustre_kcompr_30805: compr zstdfast(1) in 256kB chunks took 34993 us (114 MB/s), compress ratio: 3.84 [ 596.207274] lustre_kcompr_30805: compr zstdfast(1) in 512kB chunks took 145091 us (27 MB/s), compress ratio: 3.73 [ 596.386372] lustre_kcompr_30805: compr zstdfast(1) in 1024kB chunks took 167894 us (23 MB/s), compress ratio: 3.76 [ 596.453968] lustre_kcompr_30805: compr zstdfast(1) in 2048kB chunks took 50695 us (78 MB/s), compress ratio: 3.77 [ 596.501890] lustre_kcompr_30805: compr zstdfast(1) in 4096kB chunks took 43443 us (92 MB/s), compress ratio: 3.78 [ 596.522469] lustre_kcompr_30805: decompr zstdfast(1) took 12457 us (84 MB/s) [ 596.527761] lustre_kcompr_30805: test_comp_compress_decompress(zstdfast,1) ret 0 [ 596.533141] lustre_kcompr_30805: acompr zstdfast(1) of 128kB chunks took 1413 us (88 MB/s), compress ratio: 3.19 [ 596.552160] lustre_kcompr_30805: adecompr zstdfast(1) took 608 us (64 MB/s) [ 596.564657] lustre_kcompr_30805: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 596.653564] lustre_kcompr_30805: compr zstdfast(5) in 64kB chunks took 57194 us (69 MB/s), compress ratio: 2.81 [ 596.757447] lustre_kcompr_30805: compr zstdfast(5) in 128kB chunks took 94938 us (42 MB/s), compress ratio: 2.93 [ 596.859526] lustre_kcompr_30805: compr zstdfast(5) in 256kB chunks took 86359 us (46 MB/s), compress ratio: 3.16 [ 596.947461] lustre_kcompr_30805: compr zstdfast(5) in 512kB chunks took 74493 us (53 MB/s), compress ratio: 3.04 [ 597.006633] lustre_kcompr_30805: compr zstdfast(5) in 1024kB chunks took 54273 us (73 MB/s), compress ratio: 3.07 [ 597.078975] lustre_kcompr_30805: compr zstdfast(5) in 2048kB chunks took 58522 us (68 MB/s), compress ratio: 3.08 [ 597.132380] lustre_kcompr_30805: compr zstdfast(5) in 4096kB chunks took 48994 us (81 MB/s), compress ratio: 3.09 [ 597.170727] lustre_kcompr_30805: decompr zstdfast(5) took 22285 us (58 MB/s) [ 597.178653] lustre_kcompr_30805: test_comp_compress_decompress(zstdfast,5) ret 0 [ 597.190944] lustre_kcompr_30805: acompr zstdfast(5) of 128kB chunks took 3361 us (37 MB/s), compress ratio: 2.56 [ 597.200412] lustre_kcompr_30805: adecompr zstdfast(5) took 848 us (57 MB/s) [ 597.226566] lustre_kcompr_30805: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 597.303373] lustre_kcompr_30805: compr zstdfast(12) in 64kB chunks took 53335 us (74 MB/s), compress ratio: 1.43 [ 597.373840] lustre_kcompr_30805: compr zstdfast(12) in 128kB chunks took 57831 us (69 MB/s), compress ratio: 1.50 [ 597.435917] lustre_kcompr_30805: compr zstdfast(12) in 256kB chunks took 56375 us (70 MB/s), compress ratio: 1.62 [ 597.532430] lustre_kcompr_30805: compr zstdfast(12) in 512kB chunks took 85843 us (46 MB/s), compress ratio: 1.55 [ 597.599605] lustre_kcompr_30805: compr zstdfast(12) in 1024kB chunks took 55770 us (71 MB/s), compress ratio: 1.58 [ 597.638840] lustre_kcompr_30805: compr zstdfast(12) in 2048kB chunks took 31929 us (125 MB/s), compress ratio: 1.60 [ 597.694100] lustre_kcompr_30805: compr zstdfast(12) in 4096kB chunks took 41341 us (96 MB/s), compress ratio: 1.60 [ 597.718338] lustre_kcompr_30805: decompr zstdfast(12) took 9480 us (263 MB/s) [ 597.722231] lustre_kcompr_30805: test_comp_compress_decompress(zstdfast,12) ret 0 [ 597.726064] lustre_kcompr_30805: acompr zstdfast(12) of 128kB chunks took 645 us (193 MB/s), compress ratio: 1.37 [ 597.729595] lustre_kcompr_30805: adecompr zstdfast(12) took 241 us (378 MB/s) [ 597.746370] lustre_kcompr_30805: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 597.764851] lustre_kcompr_30805: compr zstdfast(15) in 64kB chunks took 9438 us (423 MB/s), compress ratio: 1.12 [ 597.784762] lustre_kcompr_30805: compr zstdfast(15) in 128kB chunks took 10513 us (380 MB/s), compress ratio: 1.16 [ 597.797421] lustre_kcompr_30805: compr zstdfast(15) in 256kB chunks took 9025 us (443 MB/s), compress ratio: 1.22 [ 597.809556] lustre_kcompr_30805: compr zstdfast(15) in 512kB chunks took 8555 us (467 MB/s), compress ratio: 1.20 [ 597.825329] lustre_kcompr_30805: compr zstdfast(15) in 1024kB chunks took 12046 us (332 MB/s), compress ratio: 1.22 [ 597.839221] lustre_kcompr_30805: compr zstdfast(15) in 2048kB chunks took 9681 us (413 MB/s), compress ratio: 1.23 [ 597.853094] lustre_kcompr_30805: compr zstdfast(15) in 4096kB chunks took 9054 us (441 MB/s), compress ratio: 1.23 [ 597.867121] lustre_kcompr_30805: decompr zstdfast(15) took 5935 us (545 MB/s) [ 597.871706] lustre_kcompr_30805: test_comp_compress_decompress(zstdfast,15) ret 0 [ 597.879200] lustre_kcompr_30805: acompr zstdfast(15) of 128kB chunks took 472 us (264 MB/s), compress ratio: 1.08 [ 597.885127] lustre_kcompr_30805: adecompr zstdfast(15) took 177 us (652 MB/s) [ 597.890578] lustre_kcompr_30805: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 597.893566] lustre_kcompr_30805: SUCCESS [ 604.843127] lustre_kcompr_15378: ***** [ 604.845476] lustre_kcompr_15378: (de)compression test on provided file /tmp/f84.sanity [ 604.849138] lustre_kcompr_15378: ***** [ 604.886214] lustre_kcompr_15378: compr lz4(1) in 64kB chunks took 15813 us (252 MB/s), compress ratio: 2.45 [ 604.899304] lustre_kcompr_15378: compr lz4(1) in 128kB chunks took 10024 us (399 MB/s), compress ratio: 2.39 [ 604.911303] lustre_kcompr_15378: compr lz4(1) in 256kB chunks took 9230 us (433 MB/s), compress ratio: 2.39 [ 604.925596] lustre_kcompr_15378: compr lz4(1) in 512kB chunks took 11204 us (357 MB/s), compress ratio: 2.39 [ 604.946594] lustre_kcompr_15378: compr lz4(1) in 1024kB chunks took 18877 us (211 MB/s), compress ratio: 2.39 [ 604.964993] lustre_kcompr_15378: compr lz4(1) in 2048kB chunks took 14459 us (276 MB/s), compress ratio: 2.39 [ 605.053798] lustre_kcompr_15378: compr lz4(1) in 4096kB chunks took 83453 us (47 MB/s), compress ratio: 2.39 [ 605.074512] lustre_kcompr_15378: decompr lz4(1) took 2850 us (585 MB/s) [ 605.078571] lustre_kcompr_15378: test_comp_compress_decompress(lz4,1) ret 0 [ 605.088230] lustre_kcompr_15378: acompr lz4(1) of 128kB chunks took 3775 us (33 MB/s), compress ratio: 15.67 [ 605.103143] lustre_kcompr_15378: adecompr lz4(1) took 2262 us (3 MB/s) [ 605.202415] lustre_kcompr_15378: test_acomp_compress_decompress(lz4,1) ret 0 [ 605.282497] lustre_kcompr_15378: compr lz4(4) in 64kB chunks took 19258 us (207 MB/s), compress ratio: 2.36 [ 605.320377] lustre_kcompr_15378: compr lz4(4) in 128kB chunks took 20527 us (194 MB/s), compress ratio: 2.35 [ 605.337404] lustre_kcompr_15378: compr lz4(4) in 256kB chunks took 12114 us (330 MB/s), compress ratio: 2.35 [ 605.351304] lustre_kcompr_15378: compr lz4(4) in 512kB chunks took 10074 us (397 MB/s), compress ratio: 2.35 [ 605.360572] lustre_kcompr_15378: compr lz4(4) in 1024kB chunks took 6711 us (596 MB/s), compress ratio: 2.35 [ 605.374219] lustre_kcompr_15378: compr lz4(4) in 2048kB chunks took 10223 us (391 MB/s), compress ratio: 2.35 [ 605.392595] lustre_kcompr_15378: compr lz4(4) in 4096kB chunks took 14787 us (270 MB/s), compress ratio: 2.35 [ 605.427221] lustre_kcompr_15378: decompr lz4(4) took 5553 us (306 MB/s) [ 605.431396] lustre_kcompr_15378: test_comp_compress_decompress(lz4,4) ret 0 [ 605.436111] lustre_kcompr_15378: acompr lz4(4) of 128kB chunks took 196 us (637 MB/s), compress ratio: 15.30 [ 605.441661] lustre_kcompr_15378: adecompr lz4(4) took 129 us (63 MB/s) [ 605.448717] lustre_kcompr_15378: test_acomp_compress_decompress(lz4,4) ret 0 [ 605.474304] lustre_kcompr_15378: compr lz4(9) in 64kB chunks took 13496 us (296 MB/s), compress ratio: 2.32 [ 605.512829] lustre_kcompr_15378: compr lz4(9) in 128kB chunks took 28564 us (140 MB/s), compress ratio: 2.31 [ 605.535204] lustre_kcompr_15378: compr lz4(9) in 256kB chunks took 16278 us (245 MB/s), compress ratio: 2.31 [ 605.564755] lustre_kcompr_15378: compr lz4(9) in 512kB chunks took 19556 us (204 MB/s), compress ratio: 2.31 [ 605.582939] lustre_kcompr_15378: compr lz4(9) in 1024kB chunks took 10618 us (376 MB/s), compress ratio: 2.31 [ 605.596865] lustre_kcompr_15378: compr lz4(9) in 2048kB chunks took 9168 us (436 MB/s), compress ratio: 2.32 [ 605.606518] lustre_kcompr_15378: compr lz4(9) in 4096kB chunks took 5843 us (684 MB/s), compress ratio: 2.32 [ 605.625702] lustre_kcompr_15378: decompr lz4(9) took 4601 us (374 MB/s) [ 605.631932] lustre_kcompr_15378: test_comp_compress_decompress(lz4,9) ret 0 [ 605.635616] lustre_kcompr_15378: acompr lz4(9) of 128kB chunks took 104 us (1201 MB/s), compress ratio: 14.81 [ 605.640787] lustre_kcompr_15378: adecompr lz4(9) took 210 us (40 MB/s) [ 605.650820] lustre_kcompr_15378: test_acomp_compress_decompress(lz4,9) ret 0 [ 605.698306] lustre_kcompr_15378: compr lz4(15) in 64kB chunks took 9001 us (444 MB/s), compress ratio: 2.23 [ 605.710284] lustre_kcompr_15378: compr lz4(15) in 128kB chunks took 8310 us (481 MB/s), compress ratio: 2.23 [ 605.739224] lustre_kcompr_15378: compr lz4(15) in 256kB chunks took 17887 us (223 MB/s), compress ratio: 2.23 [ 605.764303] lustre_kcompr_15378: compr lz4(15) in 512kB chunks took 16876 us (237 MB/s), compress ratio: 2.23 [ 605.794954] lustre_kcompr_15378: compr lz4(15) in 1024kB chunks took 23820 us (167 MB/s), compress ratio: 2.23 [ 605.830517] lustre_kcompr_15378: compr lz4(15) in 2048kB chunks took 22386 us (178 MB/s), compress ratio: 2.23 [ 605.848932] lustre_kcompr_15378: compr lz4(15) in 4096kB chunks took 8975 us (445 MB/s), compress ratio: 2.23 [ 605.881995] lustre_kcompr_15378: decompr lz4(15) took 11511 us (155 MB/s) [ 605.895082] lustre_kcompr_15378: test_comp_compress_decompress(lz4,15) ret 0 [ 605.913930] lustre_kcompr_15378: acompr lz4(15) of 128kB chunks took 1143 us (109 MB/s), compress ratio: 14.18 [ 605.928792] lustre_kcompr_15378: adecompr lz4(15) took 164 us (53 MB/s) [ 605.938419] lustre_kcompr_15378: test_acomp_compress_decompress(lz4,15) ret 0 [ 606.230442] lustre_kcompr_15378: compr lz4hc(1) in 64kB chunks took 279799 us (14 MB/s), compress ratio: 2.54 [ 606.400378] lustre_kcompr_15378: compr lz4hc(1) in 128kB chunks took 151250 us (26 MB/s), compress ratio: 2.61 [ 606.544085] lustre_kcompr_15378: compr lz4hc(1) in 256kB chunks took 138156 us (28 MB/s), compress ratio: 2.64 [ 606.871084] lustre_kcompr_15378: compr lz4hc(1) in 512kB chunks took 322671 us (12 MB/s), compress ratio: 2.66 [ 607.187599] lustre_kcompr_15378: compr lz4hc(1) in 1024kB chunks took 297490 us (13 MB/s), compress ratio: 2.67 [ 607.542347] lustre_kcompr_15378: compr lz4hc(1) in 2048kB chunks took 338485 us (11 MB/s), compress ratio: 2.67 [ 607.710386] lustre_kcompr_15378: compr lz4hc(1) in 4096kB chunks took 162695 us (24 MB/s), compress ratio: 2.67 [ 607.742305] lustre_kcompr_15378: decompr lz4hc(1) took 13459 us (111 MB/s) [ 607.757265] lustre_kcompr_15378: test_comp_compress_decompress(lz4hc,1) ret 0 [ 607.789264] lustre_kcompr_15378: acompr lz4hc(1) of 128kB chunks took 10652 us (11 MB/s), compress ratio: 15.97 [ 607.809131] lustre_kcompr_15378: adecompr lz4hc(1) took 131 us (59 MB/s) [ 607.903274] lustre_kcompr_15378: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 608.374688] lustre_kcompr_15378: compr lz4hc(3) in 64kB chunks took 406830 us (9 MB/s), compress ratio: 2.57 [ 608.632741] lustre_kcompr_15378: compr lz4hc(3) in 128kB chunks took 250743 us (15 MB/s), compress ratio: 2.64 [ 608.817270] lustre_kcompr_15378: compr lz4hc(3) in 256kB chunks took 174457 us (22 MB/s), compress ratio: 2.68 [ 609.012278] lustre_kcompr_15378: compr lz4hc(3) in 512kB chunks took 189401 us (21 MB/s), compress ratio: 2.69 [ 609.131908] lustre_kcompr_15378: compr lz4hc(3) in 1024kB chunks took 115701 us (34 MB/s), compress ratio: 2.70 [ 609.596642] lustre_kcompr_15378: compr lz4hc(3) in 2048kB chunks took 462487 us (8 MB/s), compress ratio: 2.71 [ 610.042557] lustre_kcompr_15378: compr lz4hc(3) in 4096kB chunks took 424142 us (9 MB/s), compress ratio: 2.71 [ 610.103744] lustre_kcompr_15378: decompr lz4hc(3) took 43128 us (34 MB/s) [ 610.110891] lustre_kcompr_15378: test_comp_compress_decompress(lz4hc,3) ret 0 [ 610.115443] lustre_kcompr_15378: acompr lz4hc(3) of 128kB chunks took 666 us (187 MB/s), compress ratio: 16.00 [ 610.117890] lustre_kcompr_15378: adecompr lz4hc(3) took 88 us (88 MB/s) [ 610.122300] lustre_kcompr_15378: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 610.599697] lustre_kcompr_15378: compr lz4hc(8) in 64kB chunks took 467286 us (8 MB/s), compress ratio: 2.60 [ 611.142143] lustre_kcompr_15378: compr lz4hc(8) in 128kB chunks took 536117 us (7 MB/s), compress ratio: 2.66 [ 612.302503] lustre_kcompr_15378: compr lz4hc(8) in 256kB chunks took 1157503 us (3 MB/s), compress ratio: 2.70 [ 613.069173] lustre_kcompr_15378: compr lz4hc(8) in 512kB chunks took 757348 us (5 MB/s), compress ratio: 2.71 [ 613.885714] lustre_kcompr_15378: compr lz4hc(8) in 1024kB chunks took 811290 us (4 MB/s), compress ratio: 2.72 [ 615.089037] lustre_kcompr_15378: compr lz4hc(8) in 2048kB chunks took 1192049 us (3 MB/s), compress ratio: 2.73 [ 615.875693] lustre_kcompr_15378: compr lz4hc(8) in 4096kB chunks took 777566 us (5 MB/s), compress ratio: 2.73 [ 615.889272] lustre_kcompr_15378: decompr lz4hc(8) took 4313 us (338 MB/s) [ 615.892767] lustre_kcompr_15378: test_comp_compress_decompress(lz4hc,8) ret 0 [ 615.899854] lustre_kcompr_15378: acompr lz4hc(8) of 128kB chunks took 3561 us (35 MB/s), compress ratio: 16.17 [ 615.904560] lustre_kcompr_15378: adecompr lz4hc(8) took 155 us (49 MB/s) [ 615.915810] lustre_kcompr_15378: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 622.450328] lustre_kcompr_15378: compr lz4hc(15) in 64kB chunks took 6522078 us (0 MB/s), compress ratio: 2.61 [ 634.172850] lustre_kcompr_15378: compr lz4hc(15) in 128kB chunks took 11714488 us (0 MB/s), compress ratio: 2.67 [ 651.122395] lustre_kcompr_15378: compr lz4hc(15) in 256kB chunks took 16940646 us (0 MB/s), compress ratio: 2.71 [ 661.414672] lustre_kcompr_15378: compr lz4hc(15) in 512kB chunks took 10286544 us (0 MB/s), compress ratio: 2.72 [ 672.686241] lustre_kcompr_15378: compr lz4hc(15) in 1024kB chunks took 11258815 us (0 MB/s), compress ratio: 2.73 [ 690.186629] lustre_kcompr_15378: compr lz4hc(15) in 2048kB chunks took 17493989 us (0 MB/s), compress ratio: 2.74 [ 706.235158] lustre_kcompr_15378: compr lz4hc(15) in 4096kB chunks took 16040088 us (0 MB/s), compress ratio: 2.74 [ 706.259678] lustre_kcompr_15378: decompr lz4hc(15) took 8848 us (164 MB/s) [ 706.265654] lustre_kcompr_15378: test_comp_compress_decompress(lz4hc,15) ret 0 [ 706.290987] lustre_kcompr_15378: acompr lz4hc(15) of 128kB chunks took 22170 us (5 MB/s), compress ratio: 16.30 [ 706.299767] lustre_kcompr_15378: adecompr lz4hc(15) took 789 us (9 MB/s) [ 706.308493] lustre_kcompr_15378: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 706.330366] lustre_kcompr_15378: compr lzo(-1) in 64kB chunks took 14966 us (267 MB/s), compress ratio: 2.35 [ 706.353954] lustre_kcompr_15378: compr lzo(-1) in 128kB chunks took 18323 us (218 MB/s), compress ratio: 2.35 [ 706.378662] lustre_kcompr_15378: compr lzo(-1) in 256kB chunks took 19181 us (208 MB/s), compress ratio: 2.35 [ 706.409423] lustre_kcompr_15378: compr lzo(-1) in 512kB chunks took 23341 us (171 MB/s), compress ratio: 2.36 [ 706.445320] lustre_kcompr_15378: compr lzo(-1) in 1024kB chunks took 24867 us (160 MB/s), compress ratio: 2.36 [ 706.489466] lustre_kcompr_15378: compr lzo(-1) in 2048kB chunks took 38920 us (102 MB/s), compress ratio: 2.36 [ 706.521510] lustre_kcompr_15378: compr lzo(-1) in 4096kB chunks took 25132 us (159 MB/s), compress ratio: 2.36 [ 706.542771] lustre_kcompr_15378: decompr lzo(-1) took 8826 us (191 MB/s) [ 706.547634] lustre_kcompr_15378: test_comp_compress_decompress(lzo,-1) ret 0 [ 706.557434] lustre_kcompr_15378: acompr lzo(-1) of 128kB chunks took 182 us (686 MB/s), compress ratio: 15.45 [ 706.562935] lustre_kcompr_15378: adecompr lzo(-1) took 208 us (38 MB/s) [ 706.569084] lustre_kcompr_15378: test_acomp_compress_decompress(lzo,-1) ret 0 [ 707.489183] lustre_kcompr_15378: compr deflate(1) in 64kB chunks took 908630 us (4 MB/s), compress ratio: 3.27 [ 708.287399] lustre_kcompr_15378: compr deflate(1) in 128kB chunks took 778827 us (5 MB/s), compress ratio: 3.28 [ 709.248360] lustre_kcompr_15378: compr deflate(1) in 256kB chunks took 952794 us (4 MB/s), compress ratio: 3.28 [ 710.257379] lustre_kcompr_15378: compr deflate(1) in 512kB chunks took 999495 us (4 MB/s), compress ratio: 3.28 [ 711.238733] lustre_kcompr_15378: compr deflate(1) in 1024kB chunks took 962389 us (4 MB/s), compress ratio: 3.28 [ 711.948578] lustre_kcompr_15378: compr deflate(1) in 2048kB chunks took 699344 us (5 MB/s), compress ratio: 3.28 [ 712.523258] lustre_kcompr_15378: compr deflate(1) in 4096kB chunks took 569860 us (7 MB/s), compress ratio: 3.28 [ 712.561462] lustre_kcompr_15378: decompr deflate(1) took 24385 us (49 MB/s) [ 712.569586] lustre_kcompr_15378: test_comp_compress_decompress(deflate,1) ret 0 [ 712.614453] lustre_kcompr_15378: acompr deflate(1) of 128kB chunks took 24487 us (5 MB/s), compress ratio: 21.43 [ 712.621491] lustre_kcompr_15378: adecompr deflate(1) took 505 us (11 MB/s) [ 712.667619] lustre_kcompr_15378: test_acomp_compress_decompress(deflate,1) ret 0 [ 713.513318] lustre_kcompr_15378: compr deflate(6) in 64kB chunks took 816685 us (4 MB/s), compress ratio: 3.27 [ 713.933507] lustre_kcompr_15378: compr deflate(6) in 128kB chunks took 415071 us (9 MB/s), compress ratio: 3.28 [ 714.559913] lustre_kcompr_15378: compr deflate(6) in 256kB chunks took 620329 us (6 MB/s), compress ratio: 3.28 [ 715.537328] lustre_kcompr_15378: compr deflate(6) in 512kB chunks took 960135 us (4 MB/s), compress ratio: 3.28 [ 716.336348] lustre_kcompr_15378: compr deflate(6) in 1024kB chunks took 792107 us (5 MB/s), compress ratio: 3.28 [ 717.325920] lustre_kcompr_15378: compr deflate(6) in 2048kB chunks took 974131 us (4 MB/s), compress ratio: 3.28 [ 718.081661] lustre_kcompr_15378: compr deflate(6) in 4096kB chunks took 751277 us (5 MB/s), compress ratio: 3.28 [ 718.173476] lustre_kcompr_15378: decompr deflate(6) took 72044 us (16 MB/s) [ 718.178314] lustre_kcompr_15378: test_comp_compress_decompress(deflate,6) ret 0 [ 718.193091] lustre_kcompr_15378: acompr deflate(6) of 128kB chunks took 10532 us (11 MB/s), compress ratio: 21.43 [ 718.198872] lustre_kcompr_15378: adecompr deflate(6) took 287 us (20 MB/s) [ 718.205240] lustre_kcompr_15378: test_acomp_compress_decompress(deflate,6) ret 0 [ 718.955390] lustre_kcompr_15378: compr deflate(9) in 64kB chunks took 726191 us (5 MB/s), compress ratio: 3.27 [ 719.708567] lustre_kcompr_15378: compr deflate(9) in 128kB chunks took 746424 us (5 MB/s), compress ratio: 3.28 [ 720.344920] lustre_kcompr_15378: compr deflate(9) in 256kB chunks took 632484 us (6 MB/s), compress ratio: 3.28 [ 721.091600] lustre_kcompr_15378: compr deflate(9) in 512kB chunks took 733766 us (5 MB/s), compress ratio: 3.28 [ 721.759272] lustre_kcompr_15378: compr deflate(9) in 1024kB chunks took 658677 us (6 MB/s), compress ratio: 3.28 [ 722.561403] lustre_kcompr_15378: compr deflate(9) in 2048kB chunks took 792833 us (5 MB/s), compress ratio: 3.28 [ 723.398455] lustre_kcompr_15378: compr deflate(9) in 4096kB chunks took 822811 us (4 MB/s), compress ratio: 3.28 [ 723.474682] lustre_kcompr_15378: decompr deflate(9) took 49407 us (24 MB/s) [ 723.492229] lustre_kcompr_15378: test_comp_compress_decompress(deflate,9) ret 0 [ 723.519348] lustre_kcompr_15378: acompr deflate(9) of 128kB chunks took 20174 us (6 MB/s), compress ratio: 21.43 [ 723.538212] lustre_kcompr_15378: adecompr deflate(9) took 640 us (9 MB/s) [ 723.553368] lustre_kcompr_15378: test_acomp_compress_decompress(deflate,9) ret 0 [ 723.667320] lustre_kcompr_15378: compr zstd(0) in 64kB chunks took 94312 us (42 MB/s), compress ratio: 3.28 [ 723.799509] lustre_kcompr_15378: compr zstd(0) in 128kB chunks took 127908 us (31 MB/s), compress ratio: 3.26 [ 724.022054] lustre_kcompr_15378: compr zstd(0) in 256kB chunks took 200751 us (19 MB/s), compress ratio: 3.31 [ 724.455862] lustre_kcompr_15378: compr zstd(0) in 512kB chunks took 424249 us (9 MB/s), compress ratio: 3.32 [ 724.810732] lustre_kcompr_15378: compr zstd(0) in 1024kB chunks took 343032 us (11 MB/s), compress ratio: 3.32 [ 725.013632] lustre_kcompr_15378: compr zstd(0) in 2048kB chunks took 195978 us (20 MB/s), compress ratio: 3.33 [ 725.154322] lustre_kcompr_15378: compr zstd(0) in 4096kB chunks took 133862 us (29 MB/s), compress ratio: 3.33 [ 725.201498] lustre_kcompr_15378: decompr zstd(0) took 30914 us (38 MB/s) [ 725.215628] lustre_kcompr_15378: test_comp_compress_decompress(zstd,0) ret 0 [ 725.223323] lustre_kcompr_15378: acompr zstd(0) of 128kB chunks took 488 us (256 MB/s), compress ratio: 22.64 [ 725.231952] lustre_kcompr_15378: adecompr zstd(0) took 242 us (22 MB/s) [ 725.247578] lustre_kcompr_15378: test_acomp_compress_decompress(zstd,0) ret 0 [ 725.357354] lustre_kcompr_15378: compr zstd(1) in 64kB chunks took 73348 us (54 MB/s), compress ratio: 3.22 [ 725.458180] lustre_kcompr_15378: compr zstd(1) in 128kB chunks took 83117 us (48 MB/s), compress ratio: 3.18 [ 725.533581] lustre_kcompr_15378: compr zstd(1) in 256kB chunks took 62288 us (64 MB/s), compress ratio: 3.19 [ 725.629573] lustre_kcompr_15378: compr zstd(1) in 512kB chunks took 86156 us (46 MB/s), compress ratio: 3.19 [ 725.740490] lustre_kcompr_15378: compr zstd(1) in 1024kB chunks took 99889 us (40 MB/s), compress ratio: 3.19 [ 725.859681] lustre_kcompr_15378: compr zstd(1) in 2048kB chunks took 111545 us (35 MB/s), compress ratio: 3.19 [ 725.957308] lustre_kcompr_15378: compr zstd(1) in 4096kB chunks took 70828 us (56 MB/s), compress ratio: 3.19 [ 726.008930] lustre_kcompr_15378: decompr zstd(1) took 38260 us (32 MB/s) [ 726.017156] lustre_kcompr_15378: test_comp_compress_decompress(zstd,1) ret 0 [ 726.027829] lustre_kcompr_15378: acompr zstd(1) of 128kB chunks took 1577 us (79 MB/s), compress ratio: 22.79 [ 726.033248] lustre_kcompr_15378: adecompr zstd(1) took 264 us (20 MB/s) [ 726.048128] lustre_kcompr_15378: test_acomp_compress_decompress(zstd,1) ret 0 [ 726.892534] lustre_kcompr_15378: compr zstd(10) in 64kB chunks took 831729 us (4 MB/s), compress ratio: 3.33 [ 727.857215] lustre_kcompr_15378: compr zstd(10) in 128kB chunks took 958965 us (4 MB/s), compress ratio: 3.33 [ 728.821454] lustre_kcompr_15378: compr zstd(10) in 256kB chunks took 920508 us (4 MB/s), compress ratio: 3.37 [ 730.129211] lustre_kcompr_15378: compr zstd(10) in 512kB chunks took 1302133 us (3 MB/s), compress ratio: 3.40 [ 730.731324] lustre_kcompr_15378: compr zstd(10) in 1024kB chunks took 598596 us (6 MB/s), compress ratio: 3.42 [ 732.285488] lustre_kcompr_15378: compr zstd(10) in 2048kB chunks took 1543025 us (2 MB/s), compress ratio: 3.46 [ 733.375148] lustre_kcompr_15378: compr zstd(10) in 4096kB chunks took 1065949 us (3 MB/s), compress ratio: 3.50 [ 733.473994] lustre_kcompr_15378: decompr zstd(10) took 77022 us (14 MB/s) [ 733.490611] lustre_kcompr_15378: test_comp_compress_decompress(zstd,10) ret 0 [ 733.509148] lustre_kcompr_15378: acompr zstd(10) of 128kB chunks took 2145 us (58 MB/s), compress ratio: 22.78 [ 733.514256] lustre_kcompr_15378: adecompr zstd(10) took 384 us (14 MB/s) [ 733.536792] lustre_kcompr_15378: test_acomp_compress_decompress(zstd,10) ret 0 [ 742.234661] lustre_kcompr_15378: compr zstd(15) in 64kB chunks took 8671038 us (0 MB/s), compress ratio: 3.36 [ 751.747779] lustre_kcompr_15378: compr zstd(15) in 128kB chunks took 9503784 us (0 MB/s), compress ratio: 3.39 [ 761.085287] lustre_kcompr_15378: compr zstd(15) in 256kB chunks took 9320121 us (0 MB/s), compress ratio: 3.40 [ 769.295693] lustre_kcompr_15378: compr zstd(15) in 512kB chunks took 8202142 us (0 MB/s), compress ratio: 3.42 [ 775.345328] lustre_kcompr_15378: compr zstd(15) in 1024kB chunks took 6040908 us (0 MB/s), compress ratio: 3.43 [ 779.683704] lustre_kcompr_15378: compr zstd(15) in 2048kB chunks took 4331007 us (0 MB/s), compress ratio: 3.48 [ 787.074048] lustre_kcompr_15378: compr zstd(15) in 4096kB chunks took 7377297 us (0 MB/s), compress ratio: 3.56 [ 787.212669] lustre_kcompr_15378: decompr zstd(15) took 112526 us (9 MB/s) [ 787.243805] lustre_kcompr_15378: test_comp_compress_decompress(zstd,15) ret 0 [ 787.411362] lustre_kcompr_15378: acompr zstd(15) of 128kB chunks took 151243 us (0 MB/s), compress ratio: 23.92 [ 787.424198] lustre_kcompr_15378: adecompr zstd(15) took 802 us (6 MB/s) [ 787.462613] lustre_kcompr_15378: test_acomp_compress_decompress(zstd,15) ret 0 [ 787.570896] lustre_kcompr_15378: compr zstdfast(1) in 64kB chunks took 77179 us (51 MB/s), compress ratio: 2.47 [ 787.646585] lustre_kcompr_15378: compr zstdfast(1) in 128kB chunks took 66186 us (60 MB/s), compress ratio: 2.48 [ 787.728391] lustre_kcompr_15378: compr zstdfast(1) in 256kB chunks took 71762 us (55 MB/s), compress ratio: 2.53 [ 787.859140] lustre_kcompr_15378: compr zstdfast(1) in 512kB chunks took 111060 us (36 MB/s), compress ratio: 2.42 [ 787.943371] lustre_kcompr_15378: compr zstdfast(1) in 1024kB chunks took 72660 us (55 MB/s), compress ratio: 2.42 [ 788.025819] lustre_kcompr_15378: compr zstdfast(1) in 2048kB chunks took 75369 us (53 MB/s), compress ratio: 2.42 [ 788.129647] lustre_kcompr_15378: compr zstdfast(1) in 4096kB chunks took 87586 us (45 MB/s), compress ratio: 2.42 [ 788.163934] lustre_kcompr_15378: decompr zstdfast(1) took 12802 us (128 MB/s) [ 788.180370] lustre_kcompr_15378: test_comp_compress_decompress(zstdfast,1) ret 0 [ 788.202876] lustre_kcompr_15378: acompr zstdfast(1) of 128kB chunks took 345 us (362 MB/s), compress ratio: 17.28 [ 788.224607] lustre_kcompr_15378: adecompr zstdfast(1) took 710 us (10 MB/s) [ 788.247484] lustre_kcompr_15378: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 788.278537] lustre_kcompr_15378: compr zstdfast(5) in 64kB chunks took 14963 us (267 MB/s), compress ratio: 2.38 [ 788.312386] lustre_kcompr_15378: compr zstdfast(5) in 128kB chunks took 22938 us (174 MB/s), compress ratio: 2.38 [ 788.373725] lustre_kcompr_15378: compr zstdfast(5) in 256kB chunks took 51493 us (77 MB/s), compress ratio: 2.40 [ 788.410742] lustre_kcompr_15378: compr zstdfast(5) in 512kB chunks took 26257 us (152 MB/s), compress ratio: 2.36 [ 788.448701] lustre_kcompr_15378: compr zstdfast(5) in 1024kB chunks took 28312 us (141 MB/s), compress ratio: 2.36 [ 788.474127] lustre_kcompr_15378: compr zstdfast(5) in 2048kB chunks took 17425 us (229 MB/s), compress ratio: 2.36 [ 788.501703] lustre_kcompr_15378: compr zstdfast(5) in 4096kB chunks took 22267 us (179 MB/s), compress ratio: 2.36 [ 788.528931] lustre_kcompr_15378: decompr zstdfast(5) took 7951 us (212 MB/s) [ 788.537692] lustre_kcompr_15378: test_comp_compress_decompress(zstdfast,5) ret 0 [ 788.546986] lustre_kcompr_15378: acompr zstdfast(5) of 128kB chunks took 220 us (568 MB/s), compress ratio: 16.12 [ 788.557738] lustre_kcompr_15378: adecompr zstdfast(5) took 631 us (12 MB/s) [ 788.566388] lustre_kcompr_15378: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 788.602203] lustre_kcompr_15378: compr zstdfast(12) in 64kB chunks took 13178 us (303 MB/s), compress ratio: 2.07 [ 788.615744] lustre_kcompr_15378: compr zstdfast(12) in 128kB chunks took 7149 us (559 MB/s), compress ratio: 2.07 [ 788.641494] lustre_kcompr_15378: compr zstdfast(12) in 256kB chunks took 17530 us (228 MB/s), compress ratio: 2.08 [ 788.673627] lustre_kcompr_15378: compr zstdfast(12) in 512kB chunks took 19506 us (205 MB/s), compress ratio: 2.07 [ 788.709554] lustre_kcompr_15378: compr zstdfast(12) in 1024kB chunks took 28970 us (138 MB/s), compress ratio: 2.07 [ 788.741455] lustre_kcompr_15378: compr zstdfast(12) in 2048kB chunks took 23264 us (171 MB/s), compress ratio: 2.07 [ 788.769683] lustre_kcompr_15378: compr zstdfast(12) in 4096kB chunks took 16172 us (247 MB/s), compress ratio: 2.08 [ 788.791970] lustre_kcompr_15378: decompr zstdfast(12) took 4685 us (410 MB/s) [ 788.813896] lustre_kcompr_15378: test_comp_compress_decompress(zstdfast,12) ret 0 [ 788.824856] lustre_kcompr_15378: acompr zstdfast(12) of 128kB chunks took 185 us (675 MB/s), compress ratio: 13.13 [ 788.847676] lustre_kcompr_15378: adecompr zstdfast(12) took 198 us (48 MB/s) [ 788.860671] lustre_kcompr_15378: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 788.897115] lustre_kcompr_15378: compr zstdfast(15) in 64kB chunks took 16551 us (241 MB/s), compress ratio: 1.82 [ 788.924684] lustre_kcompr_15378: compr zstdfast(15) in 128kB chunks took 12212 us (327 MB/s), compress ratio: 1.83 [ 788.947349] lustre_kcompr_15378: compr zstdfast(15) in 256kB chunks took 13133 us (304 MB/s), compress ratio: 1.83 [ 788.962450] lustre_kcompr_15378: compr zstdfast(15) in 512kB chunks took 8312 us (481 MB/s), compress ratio: 1.83 [ 788.972848] lustre_kcompr_15378: compr zstdfast(15) in 1024kB chunks took 5656 us (707 MB/s), compress ratio: 1.83 [ 788.986354] lustre_kcompr_15378: compr zstdfast(15) in 2048kB chunks took 8714 us (459 MB/s), compress ratio: 1.83 [ 789.001656] lustre_kcompr_15378: compr zstdfast(15) in 4096kB chunks took 7042 us (568 MB/s), compress ratio: 1.84 [ 789.017961] lustre_kcompr_15378: decompr zstdfast(15) took 2932 us (740 MB/s) [ 789.026500] lustre_kcompr_15378: test_comp_compress_decompress(zstdfast,15) ret 0 [ 789.031927] lustre_kcompr_15378: acompr zstdfast(15) of 128kB chunks took 165 us (757 MB/s), compress ratio: 10.73 [ 789.039287] lustre_kcompr_15378: adecompr zstdfast(15) took 236 us (49 MB/s) [ 789.063650] lustre_kcompr_15378: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 789.067182] lustre_kcompr_15378: SUCCESS [ 814.996892] Lustre: DEBUG MARKER: == sanity test complete, duration 478 sec ================ 12:50:19 (1789059019) [ 817.666272] Lustre: DEBUG MARKER: === sanity: start cleanup 12:50:21 (1789059021) === [ 822.289955] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:50:26 (1789059026) === [ 824.677691] LustreError: 14255:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff91330812e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 824.788095] Lustre: Unmounted lustre-client [ 889.094825] Key type lgssc unregistered [ 889.419537] LNet: 14941:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 889.432957] LNetError: 14941:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 889.468296] LNet: Removed LNI 192.168.201.33@tcp [ 890.811161] Key type .llcrypt unregistered [ 890.812606] Key type ._llcrypt unregistered