[ 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 463114980 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 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, 524580K 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.001012] APIC: Switch to symmetric I/O mode setup [ 0.002394] x2apic enabled [ 0.003010] Switched APIC routing to physical x2apic. [ 0.005011] kvm-guest: setup PV IPIs [ 0.008298] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009026] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010016] pid_max: default: 32768 minimum: 301 [ 0.011152] LSM: Security Framework initializing [ 0.012074] Yama: becoming mindful. [ 0.013041] SELinux: Initializing. [ 0.014087] *** VALIDATE selinux *** [ 0.023287] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028733] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029160] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030125] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031137] *** VALIDATE tmpfs *** [ 0.032492] *** VALIDATE proc *** [ 0.034257] *** VALIDATE cgroup *** [ 0.035011] *** VALIDATE cgroup2 *** [ 0.036290] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037212] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039033] Spectre V2 : User space: Vulnerable [ 0.040012] Speculative Store Bypass: Vulnerable [ 0.043069] debug: unmapping init [mem 0xffffffffad059000-0xffffffffad060fff] [ 0.046178] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047693] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048026] ... version: 2 [ 0.049014] ... bit width: 48 [ 0.050014] ... generic registers: 4 [ 0.051018] ... value mask: 0000ffffffffffff [ 0.052017] ... max period: 00007fffffffffff [ 0.053015] ... fixed-purpose events: 3 [ 0.054017] ... event mask: 000000070000000f [ 0.056270] rcu: Hierarchical SRCU implementation. [ 0.058602] smp: Bringing up secondary CPUs ... [ 0.059664] x86: Booting SMP configuration: [ 0.060027] .... node #0, CPUs: #1 #2 #3 [ 0.064119] smp: Brought up 1 node, 4 CPUs [ 0.066017] smpboot: Max logical packages: 1 [ 0.067022] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.240034] node 0 deferred pages initialised in 168ms [ 0.244198] devtmpfs: initialized [ 0.245244] x86/mm: Memory block size: 128MB [ 0.248200] gcov: version magic: 0x41383552 [ 0.250189] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.251084] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.252291] pinctrl core: initialized pinctrl subsystem [ 0.253228] [ 0.253835] ************************************************************* [ 0.254018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.255016] ** ** [ 0.256016] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.257014] ** ** [ 0.258018] ** This means that this kernel is built to expose internal ** [ 0.259015] ** IOMMU data structures, which may compromise security on ** [ 0.260022] ** your system. ** [ 0.261017] ** ** [ 0.262014] ** If you see this message and you are not debugging the ** [ 0.263018] ** kernel, report this immediately to your vendor! ** [ 0.264015] ** ** [ 0.265015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.266012] ************************************************************* [ 0.267698] NET: Registered protocol family 16 [ 0.268487] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.269064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.270067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.271642] cpuidle: using governor menu [ 0.273977] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.276832] PCI: Using configuration type 1 for base access [ 0.280155] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.294128] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.296027] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.301092] cryptd: max_cpu_qlen set to 1000 [ 0.304282] ACPI: Added _OSI(Module Device) [ 0.305021] ACPI: Added _OSI(Processor Device) [ 0.307016] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.308017] ACPI: Added _OSI(Processor Aggregator Device) [ 0.314269] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.321551] ACPI: Interpreter enabled [ 0.323080] ACPI: PM: (supports S0 S3 S4 S5) [ 0.324017] ACPI: Using IOAPIC for interrupt routing [ 0.326169] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.330451] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.341694] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.344047] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.347021] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.351106] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.355612] acpiphp: Slot [2] registered [ 0.357140] acpiphp: Slot [5] registered [ 0.358129] acpiphp: Slot [6] registered [ 0.361172] acpiphp: Slot [3] registered [ 0.362160] acpiphp: Slot [4] registered [ 0.364113] acpiphp: Slot [7] registered [ 0.365141] acpiphp: Slot [8] registered [ 0.367154] acpiphp: Slot [9] registered [ 0.369133] acpiphp: Slot [10] registered [ 0.371130] acpiphp: Slot [11] registered [ 0.372126] acpiphp: Slot [12] registered [ 0.374126] acpiphp: Slot [13] registered [ 0.376455] acpiphp: Slot [14] registered [ 0.378202] acpiphp: Slot [15] registered [ 0.380138] acpiphp: Slot [16] registered [ 0.381106] acpiphp: Slot [17] registered [ 0.383110] acpiphp: Slot [18] registered [ 0.384112] acpiphp: Slot [19] registered [ 0.386108] acpiphp: Slot [20] registered [ 0.387188] acpiphp: Slot [21] registered [ 0.389108] acpiphp: Slot [22] registered [ 0.391138] acpiphp: Slot [23] registered [ 0.392113] acpiphp: Slot [24] registered [ 0.394110] acpiphp: Slot [25] registered [ 0.395117] acpiphp: Slot [26] registered [ 0.397126] acpiphp: Slot [27] registered [ 0.399136] acpiphp: Slot [28] registered [ 0.400134] acpiphp: Slot [29] registered [ 0.402133] acpiphp: Slot [30] registered [ 0.403111] acpiphp: Slot [31] registered [ 0.404081] PCI host bridge to bus 0000:00 [ 0.406025] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.408030] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.410030] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.412031] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.415029] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.417032] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.419306] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.422175] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.425350] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.431688] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.435065] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.437027] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.440023] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.441017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.443781] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.447037] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.450050] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.455883] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.460016] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.470016] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.476015] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.481390] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.488020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.494024] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.507023] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.517546] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.522932] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.528958] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.549017] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.559776] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.562460] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.564358] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.567393] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.570355] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.575173] iommu: Default domain type: Passthrough [ 0.578135] SCSI subsystem initialized [ 0.579163] ACPI: bus type USB registered [ 0.581165] usbcore: registered new interface driver usbfs [ 0.582090] usbcore: registered new interface driver hub [ 0.584079] usbcore: registered new device driver usb [ 0.586203] pps_core: LinuxPPS API ver. 1 registered [ 0.587013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.589082] PTP clock support registered [ 0.592041] EDAC MC: Ver: 3.0.0 [ 0.594045] PCI: Using ACPI for IRQ routing [ 0.595696] NetLabel: Initializing [ 0.596009] NetLabel: domain hash size = 128 [ 0.597011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.598190] NetLabel: unlabeled traffic allowed by default [ 0.601037] vgaarb: loaded [ 0.602314] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.603013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.612248] clocksource: Switched to clocksource kvm-clock [ 0.720697] VFS: Disk quotas dquot_6.6.0 [ 0.722726] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.725629] *** VALIDATE ramfs *** [ 0.727181] *** VALIDATE hugetlbfs *** [ 0.729110] pnp: PnP ACPI init [ 0.731599] pnp: PnP ACPI: found 6 devices [ 0.752169] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.755855] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.758711] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.761386] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.764158] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.766677] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.769023] NET: Registered protocol family 2 [ 0.771522] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.777394] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.781235] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.787402] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.791426] TCP: Hash tables configured (established 65536 bind 65536) [ 0.794572] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.798221] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.801771] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.805557] NET: Registered protocol family 1 [ 0.808675] RPC: Registered named UNIX socket transport module. [ 0.811455] RPC: Registered udp transport module. [ 0.813439] RPC: Registered tcp transport module. [ 0.815504] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.818350] NET: Registered protocol family 44 [ 0.820513] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.823407] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.826375] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.829637] PCI: CLS 0 bytes, default 64 [ 0.831636] Unpacking initramfs... [ 2.238090] debug: unmapping init [mem 0xffff9f46bcc64000-0xffff9f46bffcffff] [ 2.241517] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.243282] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.245703] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.733925] Initialise system trusted keyrings [ 2.735888] Key type blacklist registered [ 2.738085] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.748412] zbud: loaded [ 2.752197] *** VALIDATE nfs *** [ 2.753385] *** VALIDATE nfs4 *** [ 2.755027] pstore: using deflate compression [ 2.758581] Platform Keyring initialized [ 2.864626] NET: Registered protocol family 38 [ 2.866118] Key type asymmetric registered [ 2.867634] Asymmetric key parser 'x509' registered [ 2.869662] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.873150] io scheduler mq-deadline registered [ 2.874754] io scheduler kyber registered [ 2.876524] io scheduler bfq registered [ 2.878415] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.881450] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.884416] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.887652] ACPI: Power Button [PWRF] [ 2.894175] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.900966] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.911954] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.940332] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.971729] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.977688] Non-volatile memory driver v1.3 [ 2.980993] Linux agpgart interface v0.103 [ 3.016127] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 3.019642] vda: detected capacity change from 0 to 73097216 [ 3.040333] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.044632] vdb: detected capacity change from 0 to 1073741824 [ 3.070085] libphy: Fixed MDIO Bus: probed [ 3.079536] usbcore: registered new interface driver usbserial_generic [ 3.082414] usbserial: USB Serial support registered for generic [ 3.086028] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.091102] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.093354] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.096357] mousedev: PS/2 mouse device common for all mice [ 3.099756] rtc_cmos 00:05: RTC can wake from S4 [ 3.102612] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.109822] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.111280] rtc_cmos 00:05: registered as rtc0 [ 3.114814] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.118841] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.124736] intel_pstate: CPU model not supported [ 3.128641] hid: raw HID events driver (C) Jiri Kosina [ 3.131327] usbcore: registered new interface driver usbhid [ 3.133664] usbhid: USB HID core driver [ 3.135382] drop_monitor: Initializing network drop monitor service [ 3.138102] Initializing XFRM netlink socket [ 3.140388] NET: Registered protocol family 10 [ 3.144060] Segment Routing with IPv6 [ 3.145711] NET: Registered protocol family 17 [ 3.148498] mpls_gso: MPLS GSO support [ 3.154049] RAS: Correctable Errors collector initialized. [ 3.156074] AVX version of gcm_enc/dec engaged. [ 3.157879] AES CTR mode by8 optimization enabled [ 3.235342] sched_clock: Marking stable (3235273103, 0)->(4172559929, -937286826) [ 3.239485] registered taskstats version 1 [ 3.241623] Loading compiled-in X.509 certificates [ 3.244234] zswap: loaded using pool lzo/zbud [ 3.269672] Key type big_key registered [ 3.282642] Key type encrypted registered [ 3.284449] ima: No TPM chip found, activating TPM-bypass! [ 3.287043] ima: Allocated hash algorithm: sha1 [ 3.289197] ima: No architecture policies found [ 3.291348] evm: Initialising EVM extended attributes: [ 3.293504] evm: security.selinux [ 3.295165] evm: security.ima [ 3.296250] evm: security.capability [ 3.297800] evm: HMAC attrs: 0x1 [ 3.300647] rtc_cmos 00:05: setting system clock to 2026-09-10 16:31:20 UTC (1789057880) [ 3.307406] debug: unmapping init [mem 0xffffffffae003000-0xffffffffae1fffff] [ 3.311184] debug: unmapping init [mem 0xffffffffacd82000-0xffffffffad058fff] [ 3.321125] Write protecting the kernel read-only data: 28672k [ 3.324755] debug: unmapping init [mem 0xffffffffab403000-0xffffffffab5fffff] [ 3.327942] debug: unmapping init [mem 0xffffffffabd14000-0xffffffffabdfffff] [ 3.360862] 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.369680] systemd[1]: Detected virtualization kvm. [ 3.372089] systemd[1]: Detected architecture x86-64. [ 3.374282] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.397219] systemd[1]: No hostname configured. [ 3.398593] systemd[1]: Set hostname to . [ 3.400727] random: systemd: uninitialized urandom read (16 bytes read) [ 3.403361] systemd[1]: Initializing machine ID from random generator. [ 3.459219] random: ln: uninitialized urandom read (6 bytes read) [ 3.540341] random: systemd: uninitialized urandom read (16 bytes read) [ 3.543104] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.548689] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.553289] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Slices. [ OK ] Reached target Paths. [ OK ] Reached target Timers. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ 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... [ 4.149995] device-mapper: uevent: version 1.0.3 [ 4.152165] 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 ] [ 4.550294] random: fast init done 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. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.953977] virtio_net virtio0 ens2: renamed from eth0 [ 5.011166] scsi host0: ata_piix [ 5.036558] scsi host1: ata_piix [ 5.041249] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.043823] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.339969] dracut-initqueue[586]: RTNETLINK answers: File exists [ 9.803671] random: crng init done [ 9.805581] 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... [ 10.207353] 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 dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. [ 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 Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ 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 dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ 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... [ 11.399141] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.663759] SELinux: Disabled at runtime. [ 11.727218] 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.735226] systemd[1]: Detected virtualization kvm. [ 11.736780] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.276097] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.279081] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.282922] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.286368] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.290688] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.300371] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.303668] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. Mounting POSIX Message Queue File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on initctl Compatibility Named Pipe. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on udev Kernel Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Reached target Paths. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Huge Pages File System... [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-getty.slice. [ OK ] Listening on udev Control Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. Starting udev Coldplug all Devices... Mounting Kernel Debug File System... [ OK ] Stopped target Initrd Root File System. [ OK ] Reached target Local Encrypted Volumes. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Journal Service. [ 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. [ 12.508545] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ 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 /home/green/git/lustre-release... Mounting /mnt... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.785771] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.102806] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.103684] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.247427] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.278993] EDAC sbridge: Ver: 1.1.2 [ 14.518945] Key type dns_resolver registered [ 14.843106] NFS: Registering the id_resolver key type [ 14.845355] Key type id_resolver registered [ 14.847400] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... 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 ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Login Service... Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ 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 OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ 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 Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Authorization Manager. [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg449-client login: [ 71.884841] libcfs: loading out-of-tree module taints kernel. [ 72.089136] Key type ._llcrypt registered [ 72.093334] Key type .llcrypt registered [ 73.192356] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 73.201477] alg: No test for adler32 (adler32-zlib) [ 75.000528] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 76.254131] LNet: Added LNI 192.168.204.49@tcp [8/256/0/180] [ 78.201214] Key type lgssc registered [ 81.329894] Lustre: Echo OBD driver; http://www.lustre.org/ [ 88.827453] alg: No test for zstdfast (zstdfast-lustre-generic) [ 88.873413] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 154.102017] hrtimer: interrupt took 12961819 ns [ 215.896230] Lustre: Mounted lustre-client [ 221.164855] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 237.281949] Lustre: DEBUG MARKER: oleg449-client.virtnet: executing check_logdir /tmp/testlogs/ [ 241.637462] Lustre: lustre-OST0000-osc-ffff9f470726d000: disconnect after 23s idle [ 243.125709] Lustre: DEBUG MARKER: oleg449-client.virtnet: executing yml_node [ 247.783690] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 250.235497] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 252.818118] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 254.683749] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:35:30 EDT 2026 [ 275.701380] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 277.386747] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 279.633189] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a 130b 130c 130d 130e 130f 130g [ 281.268530] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51b 51c 51e 834 [ 283.621348] Lustre: DEBUG MARKER: === sanity: start setup 12:35:59 (1789058159) === [ 287.641914] Lustre: DEBUG MARKER: oleg449-client.virtnet: executing check_config_client /mnt/lustre [ 306.215790] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 318.090788] Lustre: DEBUG MARKER: === sanity: finish setup 12:36:33 (1789058193) === [ 326.914183] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:36:42 (1789058202) [ 327.855563] lustre_kcompr_8382: ***** [ 327.867725] lustre_kcompr_8382: (de)compression test on random binary data [ 327.871830] lustre_kcompr_8382: ***** [ 327.892742] lustre_kcompr_8382: compr lz4(1) in 64kB chunks took 1592 us (2512 MB/s), compress ratio: 96.56 [ 327.899343] lustre_kcompr_8382: compr lz4(1) in 128kB chunks took 2028 us (1972 MB/s), compress ratio: 101.59 [ 327.905977] lustre_kcompr_8382: compr lz4(1) in 256kB chunks took 1987 us (2013 MB/s), compress ratio: 104.25 [ 327.911367] lustre_kcompr_8382: compr lz4(1) in 512kB chunks took 1706 us (2344 MB/s), compress ratio: 105.89 [ 327.918288] lustre_kcompr_8382: compr lz4(1) in 1024kB chunks took 2002 us (1998 MB/s), compress ratio: 106.64 [ 327.927591] lustre_kcompr_8382: compr lz4(1) in 2048kB chunks took 1448 us (2762 MB/s), compress ratio: 106.66 [ 327.934596] lustre_kcompr_8382: compr lz4(1) in 4096kB chunks took 1603 us (2495 MB/s), compress ratio: 107.19 [ 327.947589] lustre_kcompr_8382: decompr lz4(1) took 2054 us (18 MB/s) [ 327.951712] lustre_kcompr_8382: test_comp_compress_decompress(lz4,1) ret 0 [ 327.957438] lustre_kcompr_8382: acompr lz4(1) of 128kB chunks took 88 us (1420 MB/s), compress ratio: 104.69 [ 327.962270] lustre_kcompr_8382: adecompr lz4(1) took 180 us (6 MB/s) [ 327.966789] lustre_kcompr_8382: test_acomp_compress_decompress(lz4,1) ret 0 [ 327.981659] lustre_kcompr_8382: compr lz4(4) in 64kB chunks took 5195 us (769 MB/s), compress ratio: 82.29 [ 327.989206] lustre_kcompr_8382: compr lz4(4) in 128kB chunks took 2287 us (1749 MB/s), compress ratio: 92.35 [ 327.995380] lustre_kcompr_8382: compr lz4(4) in 256kB chunks took 1600 us (2500 MB/s), compress ratio: 99.51 [ 328.004592] lustre_kcompr_8382: compr lz4(4) in 512kB chunks took 1685 us (2373 MB/s), compress ratio: 102.92 [ 328.010217] lustre_kcompr_8382: compr lz4(4) in 1024kB chunks took 1635 us (2446 MB/s), compress ratio: 104.52 [ 328.016815] lustre_kcompr_8382: compr lz4(4) in 2048kB chunks took 2151 us (1859 MB/s), compress ratio: 105.47 [ 328.023110] lustre_kcompr_8382: compr lz4(4) in 4096kB chunks took 1596 us (2506 MB/s), compress ratio: 105.84 [ 328.037427] lustre_kcompr_8382: decompr lz4(4) took 2287 us (16 MB/s) [ 328.041808] lustre_kcompr_8382: test_comp_compress_decompress(lz4,4) ret 0 [ 328.046221] lustre_kcompr_8382: acompr lz4(4) of 128kB chunks took 94 us (1329 MB/s), compress ratio: 91.27 [ 328.050600] lustre_kcompr_8382: adecompr lz4(4) took 93 us (14 MB/s) [ 328.056202] lustre_kcompr_8382: test_acomp_compress_decompress(lz4,4) ret 0 [ 328.068381] lustre_kcompr_8382: compr lz4(9) in 64kB chunks took 1978 us (2022 MB/s), compress ratio: 60.40 [ 328.074978] lustre_kcompr_8382: compr lz4(9) in 128kB chunks took 1733 us (2308 MB/s), compress ratio: 75.21 [ 328.081736] lustre_kcompr_8382: compr lz4(9) in 256kB chunks took 1600 us (2500 MB/s), compress ratio: 86.96 [ 328.093740] lustre_kcompr_8382: compr lz4(9) in 512kB chunks took 4528 us (883 MB/s), compress ratio: 93.82 [ 328.102168] lustre_kcompr_8382: compr lz4(9) in 1024kB chunks took 1985 us (2015 MB/s), compress ratio: 97.60 [ 328.112650] lustre_kcompr_8382: compr lz4(9) in 2048kB chunks took 2038 us (1962 MB/s), compress ratio: 99.70 [ 328.125320] lustre_kcompr_8382: compr lz4(9) in 4096kB chunks took 2412 us (1658 MB/s), compress ratio: 100.73 [ 328.153441] lustre_kcompr_8382: decompr lz4(9) took 5941 us (6 MB/s) [ 328.159495] lustre_kcompr_8382: test_comp_compress_decompress(lz4,9) ret 0 [ 328.166384] lustre_kcompr_8382: acompr lz4(9) of 128kB chunks took 420 us (297 MB/s), compress ratio: 74.59 [ 328.170655] lustre_kcompr_8382: adecompr lz4(9) took 90 us (18 MB/s) [ 328.185632] lustre_kcompr_8382: test_acomp_compress_decompress(lz4,9) ret 0 [ 328.208988] lustre_kcompr_8382: compr lz4(15) in 64kB chunks took 2797 us (1430 MB/s), compress ratio: 29.43 [ 328.221934] lustre_kcompr_8382: compr lz4(15) in 128kB chunks took 2587 us (1546 MB/s), compress ratio: 43.74 [ 328.234449] lustre_kcompr_8382: compr lz4(15) in 256kB chunks took 2648 us (1510 MB/s), compress ratio: 59.10 [ 328.251501] lustre_kcompr_8382: compr lz4(15) in 512kB chunks took 1993 us (2007 MB/s), compress ratio: 72.26 [ 328.263410] lustre_kcompr_8382: compr lz4(15) in 1024kB chunks took 3080 us (1298 MB/s), compress ratio: 80.34 [ 328.271518] lustre_kcompr_8382: compr lz4(15) in 2048kB chunks took 1593 us (2510 MB/s), compress ratio: 84.10 [ 328.277980] lustre_kcompr_8382: compr lz4(15) in 4096kB chunks took 1902 us (2103 MB/s), compress ratio: 87.68 [ 328.299963] lustre_kcompr_8382: decompr lz4(15) took 4775 us (9 MB/s) [ 328.304661] lustre_kcompr_8382: test_comp_compress_decompress(lz4,15) ret 0 [ 328.310992] lustre_kcompr_8382: acompr lz4(15) of 128kB chunks took 90 us (1388 MB/s), compress ratio: 42.96 [ 328.316332] lustre_kcompr_8382: adecompr lz4(15) took 102 us (28 MB/s) [ 328.323215] lustre_kcompr_8382: test_acomp_compress_decompress(lz4,15) ret 0 [ 328.365402] lustre_kcompr_8382: compr lz4hc(1) in 64kB chunks took 26882 us (148 MB/s), compress ratio: 97.62 [ 328.401962] lustre_kcompr_8382: compr lz4hc(1) in 128kB chunks took 32554 us (122 MB/s), compress ratio: 103.55 [ 328.464303] lustre_kcompr_8382: compr lz4hc(1) in 256kB chunks took 47546 us (84 MB/s), compress ratio: 106.79 [ 328.506940] lustre_kcompr_8382: compr lz4hc(1) in 512kB chunks took 32582 us (122 MB/s), compress ratio: 108.49 [ 328.561876] lustre_kcompr_8382: compr lz4hc(1) in 1024kB chunks took 47441 us (84 MB/s), compress ratio: 109.36 [ 328.642280] lustre_kcompr_8382: compr lz4hc(1) in 2048kB chunks took 72798 us (54 MB/s), compress ratio: 109.81 [ 328.702861] lustre_kcompr_8382: compr lz4hc(1) in 4096kB chunks took 45286 us (88 MB/s), compress ratio: 110.03 [ 328.722147] lustre_kcompr_8382: decompr lz4hc(1) took 2603 us (13 MB/s) [ 328.727377] lustre_kcompr_8382: test_comp_compress_decompress(lz4hc,1) ret 0 [ 328.735883] lustre_kcompr_8382: acompr lz4hc(1) of 128kB chunks took 2048 us (61 MB/s), compress ratio: 104.27 [ 328.749799] lustre_kcompr_8382: adecompr lz4hc(1) took 881 us (1 MB/s) [ 328.792768] lustre_kcompr_8382: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 328.898076] lustre_kcompr_8382: compr lz4hc(3) in 64kB chunks took 80902 us (49 MB/s), compress ratio: 98.10 [ 328.998416] lustre_kcompr_8382: compr lz4hc(3) in 128kB chunks took 87763 us (45 MB/s), compress ratio: 104.10 [ 329.080459] lustre_kcompr_8382: compr lz4hc(3) in 256kB chunks took 71497 us (55 MB/s), compress ratio: 107.36 [ 329.219021] lustre_kcompr_8382: compr lz4hc(3) in 512kB chunks took 124732 us (32 MB/s), compress ratio: 109.08 [ 329.361568] lustre_kcompr_8382: compr lz4hc(3) in 1024kB chunks took 119976 us (33 MB/s), compress ratio: 109.95 [ 329.495304] lustre_kcompr_8382: compr lz4hc(3) in 2048kB chunks took 113074 us (35 MB/s), compress ratio: 110.38 [ 329.598782] lustre_kcompr_8382: compr lz4hc(3) in 4096kB chunks took 80798 us (49 MB/s), compress ratio: 110.61 [ 329.610601] lustre_kcompr_8382: decompr lz4hc(3) took 1490 us (24 MB/s) [ 329.615173] lustre_kcompr_8382: test_comp_compress_decompress(lz4hc,3) ret 0 [ 329.620781] lustre_kcompr_8382: acompr lz4hc(3) of 128kB chunks took 1126 us (111 MB/s), compress ratio: 104.85 [ 329.624327] lustre_kcompr_8382: adecompr lz4hc(3) took 88 us (13 MB/s) [ 329.630082] lustre_kcompr_8382: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 330.741437] lustre_kcompr_8382: compr lz4hc(8) in 64kB chunks took 1101571 us (3 MB/s), compress ratio: 104.33 [ 331.807151] lustre_kcompr_8382: compr lz4hc(8) in 128kB chunks took 1054357 us (3 MB/s), compress ratio: 111.38 [ 332.938281] lustre_kcompr_8382: compr lz4hc(8) in 256kB chunks took 1124004 us (3 MB/s), compress ratio: 115.32 [ 334.048540] lustre_kcompr_8382: compr lz4hc(8) in 512kB chunks took 1095735 us (3 MB/s), compress ratio: 117.39 [ 335.264652] lustre_kcompr_8382: compr lz4hc(8) in 1024kB chunks took 1203576 us (3 MB/s), compress ratio: 118.43 [ 336.687483] lustre_kcompr_8382: compr lz4hc(8) in 2048kB chunks took 1402714 us (2 MB/s), compress ratio: 118.95 [ 337.919814] lustre_kcompr_8382: compr lz4hc(8) in 4096kB chunks took 1222655 us (3 MB/s), compress ratio: 119.22 [ 337.945691] lustre_kcompr_8382: decompr lz4hc(8) took 2982 us (11 MB/s) [ 337.953486] lustre_kcompr_8382: test_comp_compress_decompress(lz4hc,8) ret 0 [ 338.009034] lustre_kcompr_8382: acompr lz4hc(8) of 128kB chunks took 44348 us (2 MB/s), compress ratio: 112.60 [ 338.020481] lustre_kcompr_8382: adecompr lz4hc(8) took 108 us (10 MB/s) [ 338.049485] lustre_kcompr_8382: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 338.912619] Lustre: lustre-OST0000-osc-ffff9f470726d000: disconnect after 20s idle [ 338.920564] Lustre: Skipped 1 previous similar message [ 339.627746] lustre_kcompr_8382: compr lz4hc(15) in 64kB chunks took 1562976 us (2 MB/s), compress ratio: 104.87 [ 341.216574] lustre_kcompr_8382: compr lz4hc(15) in 128kB chunks took 1579326 us (2 MB/s), compress ratio: 112.41 [ 342.725554] lustre_kcompr_8382: compr lz4hc(15) in 256kB chunks took 1503208 us (2 MB/s), compress ratio: 116.67 [ 344.278402] lustre_kcompr_8382: compr lz4hc(15) in 512kB chunks took 1537451 us (2 MB/s), compress ratio: 119.01 [ 346.022957] lustre_kcompr_8382: compr lz4hc(15) in 1024kB chunks took 1738546 us (2 MB/s), compress ratio: 120.19 [ 347.731129] lustre_kcompr_8382: compr lz4hc(15) in 2048kB chunks took 1700171 us (2 MB/s), compress ratio: 120.74 [ 349.254873] lustre_kcompr_8382: compr lz4hc(15) in 4096kB chunks took 1516906 us (2 MB/s), compress ratio: 121.07 [ 349.273630] lustre_kcompr_8382: decompr lz4hc(15) took 2556 us (12 MB/s) [ 349.281517] lustre_kcompr_8382: test_comp_compress_decompress(lz4hc,15) ret 0 [ 349.339974] lustre_kcompr_8382: acompr lz4hc(15) of 128kB chunks took 52866 us (2 MB/s), compress ratio: 113.67 [ 349.363206] lustre_kcompr_8382: adecompr lz4hc(15) took 128 us (8 MB/s) [ 349.391504] lustre_kcompr_8382: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 349.407080] lustre_kcompr_8382: compr lzo(-1) in 64kB chunks took 6267 us (638 MB/s), compress ratio: 81.40 [ 349.426488] lustre_kcompr_8382: compr lzo(-1) in 128kB chunks took 6448 us (620 MB/s), compress ratio: 86.48 [ 349.441390] lustre_kcompr_8382: compr lzo(-1) in 256kB chunks took 1889 us (2117 MB/s), compress ratio: 86.30 [ 349.455851] lustre_kcompr_8382: compr lzo(-1) in 512kB chunks took 7066 us (566 MB/s), compress ratio: 88.00 [ 349.465561] lustre_kcompr_8382: compr lzo(-1) in 1024kB chunks took 3399 us (1176 MB/s), compress ratio: 87.63 [ 349.471805] lustre_kcompr_8382: compr lzo(-1) in 2048kB chunks took 2495 us (1603 MB/s), compress ratio: 88.26 [ 349.478564] lustre_kcompr_8382: compr lzo(-1) in 4096kB chunks took 2118 us (1888 MB/s), compress ratio: 87.87 [ 349.495804] lustre_kcompr_8382: decompr lzo(-1) took 2487 us (18 MB/s) [ 349.500253] lustre_kcompr_8382: test_comp_compress_decompress(lzo,-1) ret 0 [ 349.510897] lustre_kcompr_8382: acompr lzo(-1) of 128kB chunks took 103 us (1213 MB/s), compress ratio: 91.98 [ 349.516928] lustre_kcompr_8382: adecompr lzo(-1) took 154 us (8 MB/s) [ 349.531186] lustre_kcompr_8382: test_acomp_compress_decompress(lzo,-1) ret 0 [ 350.177976] lustre_kcompr_8382: compr deflate(1) in 64kB chunks took 626162 us (6 MB/s), compress ratio: 97.77 [ 350.529491] lustre_kcompr_8382: compr deflate(1) in 128kB chunks took 340864 us (11 MB/s), compress ratio: 108.16 [ 350.977989] lustre_kcompr_8382: compr deflate(1) in 256kB chunks took 439903 us (9 MB/s), compress ratio: 114.64 [ 351.326932] lustre_kcompr_8382: compr deflate(1) in 512kB chunks took 340148 us (11 MB/s), compress ratio: 118.47 [ 351.586180] lustre_kcompr_8382: compr deflate(1) in 1024kB chunks took 253538 us (15 MB/s), compress ratio: 120.32 [ 351.885234] lustre_kcompr_8382: compr deflate(1) in 2048kB chunks took 293901 us (13 MB/s), compress ratio: 121.29 [ 352.219549] lustre_kcompr_8382: compr deflate(1) in 4096kB chunks took 328131 us (12 MB/s), compress ratio: 121.58 [ 352.238388] lustre_kcompr_8382: decompr deflate(1) took 6669 us (4 MB/s) [ 352.243843] lustre_kcompr_8382: test_comp_compress_decompress(deflate,1) ret 0 [ 352.257740] lustre_kcompr_8382: acompr deflate(1) of 128kB chunks took 7294 us (17 MB/s), compress ratio: 108.59 [ 352.262156] lustre_kcompr_8382: adecompr deflate(1) took 199 us (5 MB/s) [ 352.267573] lustre_kcompr_8382: test_acomp_compress_decompress(deflate,1) ret 0 [ 352.549991] lustre_kcompr_8382: compr deflate(6) in 64kB chunks took 272239 us (14 MB/s), compress ratio: 97.77 [ 353.062147] lustre_kcompr_8382: compr deflate(6) in 128kB chunks took 506318 us (7 MB/s), compress ratio: 108.16 [ 353.649399] lustre_kcompr_8382: compr deflate(6) in 256kB chunks took 580816 us (6 MB/s), compress ratio: 114.64 [ 354.210704] lustre_kcompr_8382: compr deflate(6) in 512kB chunks took 550608 us (7 MB/s), compress ratio: 118.47 [ 354.764260] lustre_kcompr_8382: compr deflate(6) in 1024kB chunks took 541092 us (7 MB/s), compress ratio: 120.32 [ 355.345737] lustre_kcompr_8382: compr deflate(6) in 2048kB chunks took 572346 us (6 MB/s), compress ratio: 121.29 [ 355.827493] lustre_kcompr_8382: compr deflate(6) in 4096kB chunks took 466538 us (8 MB/s), compress ratio: 121.58 [ 355.875938] lustre_kcompr_8382: decompr deflate(6) took 15026 us (2 MB/s) [ 355.901551] lustre_kcompr_8382: test_comp_compress_decompress(deflate,6) ret 0 [ 355.932057] lustre_kcompr_8382: acompr deflate(6) of 128kB chunks took 18158 us (6 MB/s), compress ratio: 108.59 [ 355.939671] lustre_kcompr_8382: adecompr deflate(6) took 199 us (5 MB/s) [ 355.953282] lustre_kcompr_8382: test_acomp_compress_decompress(deflate,6) ret 0 [ 356.582727] lustre_kcompr_8382: compr deflate(9) in 64kB chunks took 580834 us (6 MB/s), compress ratio: 97.77 [ 356.949147] lustre_kcompr_8382: compr deflate(9) in 128kB chunks took 357397 us (11 MB/s), compress ratio: 108.16 [ 357.486106] lustre_kcompr_8382: compr deflate(9) in 256kB chunks took 520349 us (7 MB/s), compress ratio: 114.64 [ 357.907949] lustre_kcompr_8382: compr deflate(9) in 512kB chunks took 408718 us (9 MB/s), compress ratio: 118.47 [ 358.544523] lustre_kcompr_8382: compr deflate(9) in 1024kB chunks took 623796 us (6 MB/s), compress ratio: 120.32 [ 359.047948] lustre_kcompr_8382: compr deflate(9) in 2048kB chunks took 483868 us (8 MB/s), compress ratio: 121.29 [ 359.559064] lustre_kcompr_8382: compr deflate(9) in 4096kB chunks took 500882 us (7 MB/s), compress ratio: 121.58 [ 359.584855] lustre_kcompr_8382: decompr deflate(9) took 9584 us (3 MB/s) [ 359.598076] lustre_kcompr_8382: test_comp_compress_decompress(deflate,9) ret 0 [ 359.620981] lustre_kcompr_8382: acompr deflate(9) of 128kB chunks took 16025 us (7 MB/s), compress ratio: 108.59 [ 359.628629] lustre_kcompr_8382: adecompr deflate(9) took 173 us (6 MB/s) [ 359.644307] lustre_kcompr_8382: test_acomp_compress_decompress(deflate,9) ret 0 [ 359.683574] lustre_kcompr_8382: compr zstd(0) in 64kB chunks took 16292 us (245 MB/s), compress ratio: 158.45 [ 359.735819] lustre_kcompr_8382: compr zstd(0) in 128kB chunks took 43900 us (91 MB/s), compress ratio: 191.87 [ 359.787313] lustre_kcompr_8382: compr zstd(0) in 256kB chunks took 42908 us (93 MB/s), compress ratio: 204.41 [ 359.837280] lustre_kcompr_8382: compr zstd(0) in 512kB chunks took 37390 us (106 MB/s), compress ratio: 211.15 [ 359.859359] lustre_kcompr_8382: compr zstd(0) in 1024kB chunks took 9483 us (421 MB/s), compress ratio: 213.71 [ 359.870406] lustre_kcompr_8382: compr zstd(0) in 2048kB chunks took 6028 us (663 MB/s), compress ratio: 215.49 [ 359.882902] lustre_kcompr_8382: compr zstd(0) in 4096kB chunks took 6018 us (664 MB/s), compress ratio: 215.40 [ 359.903949] lustre_kcompr_8382: decompr zstd(0) took 2608 us (7 MB/s) [ 359.910450] lustre_kcompr_8382: test_comp_compress_decompress(zstd,0) ret 0 [ 359.919300] lustre_kcompr_8382: acompr zstd(0) of 128kB chunks took 503 us (248 MB/s), compress ratio: 195.04 [ 359.926895] lustre_kcompr_8382: adecompr zstd(0) took 99 us (6 MB/s) [ 359.937410] lustre_kcompr_8382: test_acomp_compress_decompress(zstd,0) ret 0 [ 359.959562] lustre_kcompr_8382: compr zstd(1) in 64kB chunks took 6709 us (596 MB/s), compress ratio: 157.79 [ 359.970419] lustre_kcompr_8382: compr zstd(1) in 128kB chunks took 5026 us (795 MB/s), compress ratio: 191.07 [ 359.978878] lustre_kcompr_8382: compr zstd(1) in 256kB chunks took 3558 us (1124 MB/s), compress ratio: 202.91 [ 359.993439] lustre_kcompr_8382: compr zstd(1) in 512kB chunks took 3262 us (1226 MB/s), compress ratio: 209.31 [ 360.009575] lustre_kcompr_8382: compr zstd(1) in 1024kB chunks took 4872 us (821 MB/s), compress ratio: 211.40 [ 360.022593] lustre_kcompr_8382: compr zstd(1) in 2048kB chunks took 2016 us (1984 MB/s), compress ratio: 213.53 [ 360.036539] lustre_kcompr_8382: compr zstd(1) in 4096kB chunks took 2044 us (1956 MB/s), compress ratio: 214.48 [ 360.056405] lustre_kcompr_8382: decompr zstd(1) took 2309 us (8 MB/s) [ 360.062584] lustre_kcompr_8382: test_comp_compress_decompress(zstd,1) ret 0 [ 360.067588] lustre_kcompr_8382: acompr zstd(1) of 128kB chunks took 156 us (801 MB/s), compress ratio: 193.89 [ 360.074756] lustre_kcompr_8382: adecompr zstd(1) took 625 us (1 MB/s) [ 360.083938] lustre_kcompr_8382: test_acomp_compress_decompress(zstd,1) ret 0 [ 360.309945] lustre_kcompr_8382: compr zstd(10) in 64kB chunks took 208096 us (19 MB/s), compress ratio: 161.18 [ 360.538887] lustre_kcompr_8382: compr zstd(10) in 128kB chunks took 223355 us (17 MB/s), compress ratio: 184.04 [ 360.786762] lustre_kcompr_8382: compr zstd(10) in 256kB chunks took 239933 us (16 MB/s), compress ratio: 195.70 [ 361.038277] lustre_kcompr_8382: compr zstd(10) in 512kB chunks took 244477 us (16 MB/s), compress ratio: 216.55 [ 361.310171] lustre_kcompr_8382: compr zstd(10) in 1024kB chunks took 260913 us (15 MB/s), compress ratio: 220.69 [ 361.664622] lustre_kcompr_8382: compr zstd(10) in 2048kB chunks took 350883 us (11 MB/s), compress ratio: 222.49 [ 361.707888] lustre_kcompr_8382: compr zstd(10) in 4096kB chunks took 38959 us (102 MB/s), compress ratio: 223.39 [ 361.719785] lustre_kcompr_8382: decompr zstd(10) took 2245 us (7 MB/s) [ 361.723759] lustre_kcompr_8382: test_comp_compress_decompress(zstd,10) ret 0 [ 361.731329] lustre_kcompr_8382: acompr zstd(10) of 128kB chunks took 3031 us (41 MB/s), compress ratio: 185.91 [ 361.736282] lustre_kcompr_8382: adecompr zstd(10) took 248 us (2 MB/s) [ 361.741669] lustre_kcompr_8382: test_acomp_compress_decompress(zstd,10) ret 0 [ 362.590280] lustre_kcompr_8382: compr zstd(15) in 64kB chunks took 836891 us (4 MB/s), compress ratio: 169.68 [ 363.526232] lustre_kcompr_8382: compr zstd(15) in 128kB chunks took 923859 us (4 MB/s), compress ratio: 194.94 [ 364.341364] lustre_kcompr_8382: compr zstd(15) in 256kB chunks took 809079 us (4 MB/s), compress ratio: 208.50 [ 365.068294] lustre_kcompr_8382: compr zstd(15) in 512kB chunks took 722345 us (5 MB/s), compress ratio: 215.75 [ 365.760474] lustre_kcompr_8382: compr zstd(15) in 1024kB chunks took 680938 us (5 MB/s), compress ratio: 217.40 [ 366.932805] lustre_kcompr_8382: compr zstd(15) in 2048kB chunks took 1163931 us (3 MB/s), compress ratio: 219.17 [ 368.788687] lustre_kcompr_8382: compr zstd(15) in 4096kB chunks took 1846902 us (2 MB/s), compress ratio: 218.62 [ 368.807532] lustre_kcompr_8382: decompr zstd(15) took 4771 us (3 MB/s) [ 368.814562] lustre_kcompr_8382: test_comp_compress_decompress(zstd,15) ret 0 [ 368.883661] lustre_kcompr_8382: acompr zstd(15) of 128kB chunks took 60974 us (2 MB/s), compress ratio: 189.95 [ 368.896359] lustre_kcompr_8382: adecompr zstd(15) took 1444 us (0 MB/s) [ 368.927183] lustre_kcompr_8382: test_acomp_compress_decompress(zstd,15) ret 0 [ 368.958374] lustre_kcompr_8382: compr zstdfast(1) in 64kB chunks took 9517 us (420 MB/s), compress ratio: 157.82 [ 368.984945] lustre_kcompr_8382: compr zstdfast(1) in 128kB chunks took 13933 us (287 MB/s), compress ratio: 191.07 [ 369.000919] lustre_kcompr_8382: compr zstdfast(1) in 256kB chunks took 5074 us (788 MB/s), compress ratio: 202.91 [ 369.021227] lustre_kcompr_8382: compr zstdfast(1) in 512kB chunks took 14751 us (271 MB/s), compress ratio: 209.29 [ 369.048935] lustre_kcompr_8382: compr zstdfast(1) in 1024kB chunks took 2386 us (1676 MB/s), compress ratio: 211.40 [ 369.075378] lustre_kcompr_8382: compr zstdfast(1) in 2048kB chunks took 8210 us (487 MB/s), compress ratio: 213.53 [ 369.092563] lustre_kcompr_8382: compr zstdfast(1) in 4096kB chunks took 9019 us (443 MB/s), compress ratio: 214.58 [ 369.122667] lustre_kcompr_8382: decompr zstdfast(1) took 5368 us (3 MB/s) [ 369.137852] lustre_kcompr_8382: test_comp_compress_decompress(zstdfast,1) ret 0 [ 369.142893] lustre_kcompr_8382: acompr zstdfast(1) of 128kB chunks took 251 us (498 MB/s), compress ratio: 193.89 [ 369.155510] lustre_kcompr_8382: adecompr zstdfast(1) took 503 us (1 MB/s) [ 369.162873] lustre_kcompr_8382: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 369.182535] lustre_kcompr_8382: compr zstdfast(5) in 64kB chunks took 4583 us (872 MB/s), compress ratio: 140.24 [ 369.196814] lustre_kcompr_8382: compr zstdfast(5) in 128kB chunks took 4096 us (976 MB/s), compress ratio: 165.77 [ 369.208846] lustre_kcompr_8382: compr zstdfast(5) in 256kB chunks took 3504 us (1141 MB/s), compress ratio: 174.54 [ 369.231109] lustre_kcompr_8382: compr zstdfast(5) in 512kB chunks took 5845 us (684 MB/s), compress ratio: 178.99 [ 369.241240] lustre_kcompr_8382: compr zstdfast(5) in 1024kB chunks took 4724 us (846 MB/s), compress ratio: 181.07 [ 369.271538] lustre_kcompr_8382: compr zstdfast(5) in 2048kB chunks took 10185 us (392 MB/s), compress ratio: 181.54 [ 369.287963] lustre_kcompr_8382: compr zstdfast(5) in 4096kB chunks took 6377 us (627 MB/s), compress ratio: 181.14 [ 369.302876] lustre_kcompr_8382: decompr zstdfast(5) took 3470 us (6 MB/s) [ 369.311457] lustre_kcompr_8382: test_comp_compress_decompress(zstdfast,5) ret 0 [ 369.316504] lustre_kcompr_8382: acompr zstdfast(5) of 128kB chunks took 211 us (592 MB/s), compress ratio: 165.70 [ 369.322259] lustre_kcompr_8382: adecompr zstdfast(5) took 181 us (4 MB/s) [ 369.328314] lustre_kcompr_8382: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 369.345271] lustre_kcompr_8382: compr zstdfast(12) in 64kB chunks took 4917 us (813 MB/s), compress ratio: 38.12 [ 369.356252] lustre_kcompr_8382: compr zstdfast(12) in 128kB chunks took 4629 us (864 MB/s), compress ratio: 43.07 [ 369.377262] lustre_kcompr_8382: compr zstdfast(12) in 256kB chunks took 3604 us (1109 MB/s), compress ratio: 47.54 [ 369.386403] lustre_kcompr_8382: compr zstdfast(12) in 512kB chunks took 5053 us (791 MB/s), compress ratio: 52.18 [ 369.393965] lustre_kcompr_8382: compr zstdfast(12) in 1024kB chunks took 2554 us (1566 MB/s), compress ratio: 53.59 [ 369.402591] lustre_kcompr_8382: compr zstdfast(12) in 2048kB chunks took 3012 us (1328 MB/s), compress ratio: 57.99 [ 369.410286] lustre_kcompr_8382: compr zstdfast(12) in 4096kB chunks took 2325 us (1720 MB/s), compress ratio: 80.95 [ 369.427789] lustre_kcompr_8382: decompr zstdfast(12) took 5060 us (9 MB/s) [ 369.434562] lustre_kcompr_8382: test_comp_compress_decompress(zstdfast,12) ret 0 [ 369.441684] lustre_kcompr_8382: acompr zstdfast(12) of 128kB chunks took 203 us (615 MB/s), compress ratio: 43.80 [ 369.449881] lustre_kcompr_8382: adecompr zstdfast(12) took 157 us (18 MB/s) [ 369.462549] lustre_kcompr_8382: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 369.496485] lustre_kcompr_8382: compr zstdfast(15) in 64kB chunks took 14522 us (275 MB/s), compress ratio: 19.09 [ 369.512038] lustre_kcompr_8382: compr zstdfast(15) in 128kB chunks took 6420 us (623 MB/s), compress ratio: 20.04 [ 369.524806] lustre_kcompr_8382: compr zstdfast(15) in 256kB chunks took 5815 us (687 MB/s), compress ratio: 20.54 [ 369.538117] lustre_kcompr_8382: compr zstdfast(15) in 512kB chunks took 6112 us (654 MB/s), compress ratio: 20.64 [ 369.549168] lustre_kcompr_8382: compr zstdfast(15) in 1024kB chunks took 5457 us (733 MB/s), compress ratio: 21.97 [ 369.560775] lustre_kcompr_8382: compr zstdfast(15) in 2048kB chunks took 4143 us (965 MB/s), compress ratio: 27.04 [ 369.577552] lustre_kcompr_8382: compr zstdfast(15) in 4096kB chunks took 3190 us (1253 MB/s), compress ratio: 30.85 [ 369.592167] lustre_kcompr_8382: decompr zstdfast(15) took 3087 us (41 MB/s) [ 369.596608] lustre_kcompr_8382: test_comp_compress_decompress(zstdfast,15) ret 0 [ 369.603367] lustre_kcompr_8382: acompr zstdfast(15) of 128kB chunks took 300 us (416 MB/s), compress ratio: 18.79 [ 369.612043] lustre_kcompr_8382: adecompr zstdfast(15) took 149 us (44 MB/s) [ 369.618818] lustre_kcompr_8382: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 369.623429] lustre_kcompr_8382: SUCCESS [ 377.201234] lustre_kcompr_21487: ***** [ 377.210051] lustre_kcompr_21487: (de)compression test on provided file /tmp/f84.sanity [ 377.216459] lustre_kcompr_21487: ***** [ 377.255895] lustre_kcompr_21487: compr lz4(1) in 64kB chunks took 28161 us (142 MB/s), compress ratio: 2.93 [ 377.295175] lustre_kcompr_21487: compr lz4(1) in 128kB chunks took 32740 us (122 MB/s), compress ratio: 3.04 [ 377.341281] lustre_kcompr_21487: compr lz4(1) in 256kB chunks took 39315 us (101 MB/s), compress ratio: 3.08 [ 377.382172] lustre_kcompr_21487: compr lz4(1) in 512kB chunks took 34742 us (115 MB/s), compress ratio: 3.10 [ 377.434455] lustre_kcompr_21487: compr lz4(1) in 1024kB chunks took 35505 us (112 MB/s), compress ratio: 3.11 [ 377.482703] lustre_kcompr_21487: compr lz4(1) in 2048kB chunks took 38332 us (104 MB/s), compress ratio: 3.11 [ 377.534778] lustre_kcompr_21487: compr lz4(1) in 4096kB chunks took 42533 us (94 MB/s), compress ratio: 3.12 [ 377.565595] lustre_kcompr_21487: decompr lz4(1) took 10331 us (124 MB/s) [ 377.571844] lustre_kcompr_21487: test_comp_compress_decompress(lz4,1) ret 0 [ 377.578711] lustre_kcompr_21487: acompr lz4(1) of 128kB chunks took 1021 us (122 MB/s), compress ratio: 2.68 [ 377.586293] lustre_kcompr_21487: adecompr lz4(1) took 976 us (47 MB/s) [ 377.595192] lustre_kcompr_21487: test_acomp_compress_decompress(lz4,1) ret 0 [ 377.638248] lustre_kcompr_21487: compr lz4(4) in 64kB chunks took 33045 us (121 MB/s), compress ratio: 2.67 [ 377.703366] lustre_kcompr_21487: compr lz4(4) in 128kB chunks took 55207 us (72 MB/s), compress ratio: 2.63 [ 377.752386] lustre_kcompr_21487: compr lz4(4) in 256kB chunks took 36748 us (108 MB/s), compress ratio: 2.68 [ 377.806369] lustre_kcompr_21487: compr lz4(4) in 512kB chunks took 47675 us (83 MB/s), compress ratio: 2.71 [ 377.863456] lustre_kcompr_21487: compr lz4(4) in 1024kB chunks took 42798 us (93 MB/s), compress ratio: 2.72 [ 377.915062] lustre_kcompr_21487: compr lz4(4) in 2048kB chunks took 41015 us (97 MB/s), compress ratio: 2.72 [ 377.942874] lustre_kcompr_21487: compr lz4(4) in 4096kB chunks took 21648 us (184 MB/s), compress ratio: 2.73 [ 377.965840] lustre_kcompr_21487: decompr lz4(4) took 7972 us (183 MB/s) [ 377.971359] lustre_kcompr_21487: test_comp_compress_decompress(lz4,4) ret 0 [ 377.982339] lustre_kcompr_21487: acompr lz4(4) of 128kB chunks took 1060 us (117 MB/s), compress ratio: 2.30 [ 377.992638] lustre_kcompr_21487: adecompr lz4(4) took 186 us (291 MB/s) [ 378.019915] lustre_kcompr_21487: test_acomp_compress_decompress(lz4,4) ret 0 [ 378.090735] lustre_kcompr_21487: compr lz4(9) in 64kB chunks took 26011 us (153 MB/s), compress ratio: 2.30 [ 378.151057] lustre_kcompr_21487: compr lz4(9) in 128kB chunks took 41067 us (97 MB/s), compress ratio: 2.15 [ 378.213130] lustre_kcompr_21487: compr lz4(9) in 256kB chunks took 35271 us (113 MB/s), compress ratio: 2.20 [ 378.242907] lustre_kcompr_21487: compr lz4(9) in 512kB chunks took 22065 us (181 MB/s), compress ratio: 2.23 [ 378.267551] lustre_kcompr_21487: compr lz4(9) in 1024kB chunks took 18569 us (215 MB/s), compress ratio: 2.25 [ 378.293353] lustre_kcompr_21487: compr lz4(9) in 2048kB chunks took 20394 us (196 MB/s), compress ratio: 2.25 [ 378.316403] lustre_kcompr_21487: compr lz4(9) in 4096kB chunks took 18559 us (215 MB/s), compress ratio: 2.26 [ 378.331601] lustre_kcompr_21487: decompr lz4(9) took 3892 us (454 MB/s) [ 378.336270] lustre_kcompr_21487: test_comp_compress_decompress(lz4,9) ret 0 [ 378.341609] lustre_kcompr_21487: acompr lz4(9) of 128kB chunks took 575 us (217 MB/s), compress ratio: 1.87 [ 378.346681] lustre_kcompr_21487: adecompr lz4(9) took 172 us (387 MB/s) [ 378.360526] lustre_kcompr_21487: test_acomp_compress_decompress(lz4,9) ret 0 [ 378.385485] lustre_kcompr_21487: compr lz4(15) in 64kB chunks took 12148 us (329 MB/s), compress ratio: 1.63 [ 378.413983] lustre_kcompr_21487: compr lz4(15) in 128kB chunks took 16564 us (241 MB/s), compress ratio: 1.52 [ 378.440215] lustre_kcompr_21487: compr lz4(15) in 256kB chunks took 16337 us (244 MB/s), compress ratio: 1.56 [ 378.464324] lustre_kcompr_21487: compr lz4(15) in 512kB chunks took 16432 us (243 MB/s), compress ratio: 1.58 [ 378.493958] lustre_kcompr_21487: compr lz4(15) in 1024kB chunks took 21583 us (185 MB/s), compress ratio: 1.60 [ 378.530676] lustre_kcompr_21487: compr lz4(15) in 2048kB chunks took 25538 us (156 MB/s), compress ratio: 1.60 [ 378.557433] lustre_kcompr_21487: compr lz4(15) in 4096kB chunks took 20462 us (195 MB/s), compress ratio: 1.60 [ 378.585539] lustre_kcompr_21487: decompr lz4(15) took 9783 us (254 MB/s) [ 378.592224] lustre_kcompr_21487: test_comp_compress_decompress(lz4,15) ret 0 [ 378.599526] lustre_kcompr_21487: acompr lz4(15) of 128kB chunks took 417 us (299 MB/s), compress ratio: 1.33 [ 378.616188] lustre_kcompr_21487: adecompr lz4(15) took 227 us (413 MB/s) [ 378.623771] lustre_kcompr_21487: test_acomp_compress_decompress(lz4,15) ret 0 [ 378.857086] lustre_kcompr_21487: compr lz4hc(1) in 64kB chunks took 218648 us (18 MB/s), compress ratio: 3.58 [ 379.083144] lustre_kcompr_21487: compr lz4hc(1) in 128kB chunks took 214670 us (18 MB/s), compress ratio: 3.77 [ 379.360382] lustre_kcompr_21487: compr lz4hc(1) in 256kB chunks took 267997 us (14 MB/s), compress ratio: 3.88 [ 379.726654] lustre_kcompr_21487: compr lz4hc(1) in 512kB chunks took 347017 us (11 MB/s), compress ratio: 3.93 [ 380.118641] lustre_kcompr_21487: compr lz4hc(1) in 1024kB chunks took 369492 us (10 MB/s), compress ratio: 3.96 [ 380.347781] lustre_kcompr_21487: compr lz4hc(1) in 2048kB chunks took 224134 us (17 MB/s), compress ratio: 3.97 [ 380.449247] lustre_kcompr_21487: compr lz4hc(1) in 4096kB chunks took 96063 us (41 MB/s), compress ratio: 3.98 [ 380.468589] lustre_kcompr_21487: decompr lz4hc(1) took 6174 us (162 MB/s) [ 380.473817] lustre_kcompr_21487: test_comp_compress_decompress(lz4hc,1) ret 0 [ 380.482290] lustre_kcompr_21487: acompr lz4hc(1) of 128kB chunks took 3451 us (36 MB/s), compress ratio: 3.27 [ 380.486844] lustre_kcompr_21487: adecompr lz4hc(1) took 169 us (226 MB/s) [ 380.492189] lustre_kcompr_21487: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 380.647935] lustre_kcompr_21487: compr lz4hc(3) in 64kB chunks took 138228 us (28 MB/s), compress ratio: 3.68 [ 380.802832] lustre_kcompr_21487: compr lz4hc(3) in 128kB chunks took 149846 us (26 MB/s), compress ratio: 3.91 [ 380.990448] lustre_kcompr_21487: compr lz4hc(3) in 256kB chunks took 183038 us (21 MB/s), compress ratio: 4.04 [ 381.252858] lustre_kcompr_21487: compr lz4hc(3) in 512kB chunks took 256907 us (15 MB/s), compress ratio: 4.10 [ 381.614202] lustre_kcompr_21487: compr lz4hc(3) in 1024kB chunks took 352442 us (11 MB/s), compress ratio: 4.13 [ 381.947881] lustre_kcompr_21487: compr lz4hc(3) in 2048kB chunks took 321231 us (12 MB/s), compress ratio: 4.15 [ 382.270322] lustre_kcompr_21487: compr lz4hc(3) in 4096kB chunks took 312849 us (12 MB/s), compress ratio: 4.16 [ 382.289587] lustre_kcompr_21487: decompr lz4hc(3) took 6958 us (138 MB/s) [ 382.294558] lustre_kcompr_21487: test_comp_compress_decompress(lz4hc,3) ret 0 [ 382.306909] lustre_kcompr_21487: acompr lz4hc(3) of 128kB chunks took 5598 us (22 MB/s), compress ratio: 3.38 [ 382.312924] lustre_kcompr_21487: adecompr lz4hc(3) took 221 us (166 MB/s) [ 382.320298] lustre_kcompr_21487: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 382.603727] lustre_kcompr_21487: compr lz4hc(8) in 64kB chunks took 271725 us (14 MB/s), compress ratio: 3.72 [ 383.102619] lustre_kcompr_21487: compr lz4hc(8) in 128kB chunks took 491911 us (8 MB/s), compress ratio: 3.96 [ 383.763274] lustre_kcompr_21487: compr lz4hc(8) in 256kB chunks took 649164 us (6 MB/s), compress ratio: 4.10 [ 384.802495] lustre_kcompr_21487: compr lz4hc(8) in 512kB chunks took 1027002 us (3 MB/s), compress ratio: 4.17 [ 385.639226] lustre_kcompr_21487: compr lz4hc(8) in 1024kB chunks took 831166 us (4 MB/s), compress ratio: 4.21 [ 386.234770] lustre_kcompr_21487: compr lz4hc(8) in 2048kB chunks took 586196 us (6 MB/s), compress ratio: 4.22 [ 386.808772] lustre_kcompr_21487: compr lz4hc(8) in 4096kB chunks took 566377 us (7 MB/s), compress ratio: 4.23 [ 386.837434] lustre_kcompr_21487: decompr lz4hc(8) took 8801 us (107 MB/s) [ 386.847174] lustre_kcompr_21487: test_comp_compress_decompress(lz4hc,8) ret 0 [ 386.873495] lustre_kcompr_21487: acompr lz4hc(8) of 128kB chunks took 20101 us (6 MB/s), compress ratio: 3.42 [ 386.880724] lustre_kcompr_21487: adecompr lz4hc(8) took 965 us (37 MB/s) [ 386.896987] lustre_kcompr_21487: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 387.383152] lustre_kcompr_21487: compr lz4hc(15) in 64kB chunks took 463584 us (8 MB/s), compress ratio: 3.72 [ 387.749311] lustre_kcompr_21487: compr lz4hc(15) in 128kB chunks took 355087 us (11 MB/s), compress ratio: 3.96 [ 388.299048] lustre_kcompr_21487: compr lz4hc(15) in 256kB chunks took 545123 us (7 MB/s), compress ratio: 4.10 [ 388.781869] lustre_kcompr_21487: compr lz4hc(15) in 512kB chunks took 477033 us (8 MB/s), compress ratio: 4.17 [ 389.431187] lustre_kcompr_21487: compr lz4hc(15) in 1024kB chunks took 642612 us (6 MB/s), compress ratio: 4.21 [ 389.981430] lustre_kcompr_21487: compr lz4hc(15) in 2048kB chunks took 545534 us (7 MB/s), compress ratio: 4.22 [ 390.853920] lustre_kcompr_21487: compr lz4hc(15) in 4096kB chunks took 866615 us (4 MB/s), compress ratio: 4.23 [ 390.875320] lustre_kcompr_21487: decompr lz4hc(15) took 6640 us (142 MB/s) [ 390.879916] lustre_kcompr_21487: test_comp_compress_decompress(lz4hc,15) ret 0 [ 390.931892] lustre_kcompr_21487: acompr lz4hc(15) of 128kB chunks took 47273 us (2 MB/s), compress ratio: 3.42 [ 390.946521] lustre_kcompr_21487: adecompr lz4hc(15) took 4189 us (8 MB/s) [ 390.965794] lustre_kcompr_21487: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 391.011217] lustre_kcompr_21487: compr lzo(-1) in 64kB chunks took 41448 us (96 MB/s), compress ratio: 2.90 [ 391.050673] lustre_kcompr_21487: compr lzo(-1) in 128kB chunks took 32715 us (122 MB/s), compress ratio: 2.95 [ 391.081835] lustre_kcompr_21487: compr lzo(-1) in 256kB chunks took 24987 us (160 MB/s), compress ratio: 2.96 [ 391.120446] lustre_kcompr_21487: compr lzo(-1) in 512kB chunks took 33402 us (119 MB/s), compress ratio: 2.98 [ 391.162352] lustre_kcompr_21487: compr lzo(-1) in 1024kB chunks took 34463 us (116 MB/s), compress ratio: 2.97 [ 391.205476] lustre_kcompr_21487: compr lzo(-1) in 2048kB chunks took 36561 us (109 MB/s), compress ratio: 2.97 [ 391.245921] lustre_kcompr_21487: compr lzo(-1) in 4096kB chunks took 35277 us (113 MB/s), compress ratio: 2.96 [ 391.281564] lustre_kcompr_21487: decompr lzo(-1) took 20010 us (67 MB/s) [ 391.286756] lustre_kcompr_21487: test_comp_compress_decompress(lzo,-1) ret 0 [ 391.292848] lustre_kcompr_21487: acompr lzo(-1) of 128kB chunks took 795 us (157 MB/s), compress ratio: 2.62 [ 391.298491] lustre_kcompr_21487: adecompr lzo(-1) took 260 us (183 MB/s) [ 391.311614] lustre_kcompr_21487: test_acomp_compress_decompress(lzo,-1) ret 0 [ 392.145213] lustre_kcompr_21487: compr deflate(1) in 64kB chunks took 820547 us (4 MB/s), compress ratio: 3.51 [ 393.098495] lustre_kcompr_21487: compr deflate(1) in 128kB chunks took 944594 us (4 MB/s), compress ratio: 3.53 [ 393.973636] lustre_kcompr_21487: compr deflate(1) in 256kB chunks took 865887 us (4 MB/s), compress ratio: 3.53 [ 394.494500] lustre_kcompr_21487: compr deflate(1) in 512kB chunks took 504413 us (7 MB/s), compress ratio: 3.54 [ 395.331978] lustre_kcompr_21487: compr deflate(1) in 1024kB chunks took 830624 us (4 MB/s), compress ratio: 3.54 [ 396.309484] lustre_kcompr_21487: compr deflate(1) in 2048kB chunks took 961919 us (4 MB/s), compress ratio: 3.54 [ 397.077635] lustre_kcompr_21487: compr deflate(1) in 4096kB chunks took 760299 us (5 MB/s), compress ratio: 3.54 [ 397.176610] lustre_kcompr_21487: decompr deflate(1) took 81050 us (13 MB/s) [ 397.197607] lustre_kcompr_21487: test_comp_compress_decompress(deflate,1) ret 0 [ 397.237595] lustre_kcompr_21487: acompr deflate(1) of 128kB chunks took 27742 us (4 MB/s), compress ratio: 3.09 [ 397.250067] lustre_kcompr_21487: adecompr deflate(1) took 1083 us (37 MB/s) [ 397.297666] lustre_kcompr_21487: test_acomp_compress_decompress(deflate,1) ret 0 [ 398.086498] lustre_kcompr_21487: compr deflate(6) in 64kB chunks took 762148 us (5 MB/s), compress ratio: 3.51 [ 398.954327] lustre_kcompr_21487: compr deflate(6) in 128kB chunks took 862420 us (4 MB/s), compress ratio: 3.53 [ 399.720570] lustre_kcompr_21487: compr deflate(6) in 256kB chunks took 753518 us (5 MB/s), compress ratio: 3.53 [ 400.435406] lustre_kcompr_21487: compr deflate(6) in 512kB chunks took 698077 us (5 MB/s), compress ratio: 3.54 [ 401.356024] lustre_kcompr_21487: compr deflate(6) in 1024kB chunks took 913500 us (4 MB/s), compress ratio: 3.54 [ 401.916167] lustre_kcompr_21487: compr deflate(6) in 2048kB chunks took 551745 us (7 MB/s), compress ratio: 3.54 [ 402.456202] lustre_kcompr_21487: compr deflate(6) in 4096kB chunks took 534967 us (7 MB/s), compress ratio: 3.54 [ 402.538537] lustre_kcompr_21487: decompr deflate(6) took 71113 us (15 MB/s) [ 402.546690] lustre_kcompr_21487: test_comp_compress_decompress(deflate,6) ret 0 [ 402.590246] lustre_kcompr_21487: acompr deflate(6) of 128kB chunks took 15868 us (7 MB/s), compress ratio: 3.09 [ 402.605400] lustre_kcompr_21487: adecompr deflate(6) took 1864 us (21 MB/s) [ 402.629586] lustre_kcompr_21487: test_acomp_compress_decompress(deflate,6) ret 0 [ 403.338835] lustre_kcompr_21487: compr deflate(9) in 64kB chunks took 693921 us (5 MB/s), compress ratio: 3.51 [ 404.012806] lustre_kcompr_21487: compr deflate(9) in 128kB chunks took 663889 us (6 MB/s), compress ratio: 3.53 [ 404.718546] lustre_kcompr_21487: compr deflate(9) in 256kB chunks took 682607 us (5 MB/s), compress ratio: 3.53 [ 405.589959] lustre_kcompr_21487: compr deflate(9) in 512kB chunks took 854560 us (4 MB/s), compress ratio: 3.54 [ 406.586286] lustre_kcompr_21487: compr deflate(9) in 1024kB chunks took 986470 us (4 MB/s), compress ratio: 3.54 [ 407.342665] lustre_kcompr_21487: compr deflate(9) in 2048kB chunks took 738719 us (5 MB/s), compress ratio: 3.54 [ 408.211899] lustre_kcompr_21487: compr deflate(9) in 4096kB chunks took 863224 us (4 MB/s), compress ratio: 3.54 [ 408.308039] lustre_kcompr_21487: decompr deflate(9) took 75123 us (15 MB/s) [ 408.333904] lustre_kcompr_21487: test_comp_compress_decompress(deflate,9) ret 0 [ 408.385844] lustre_kcompr_21487: acompr deflate(9) of 128kB chunks took 24934 us (5 MB/s), compress ratio: 3.09 [ 408.400741] lustre_kcompr_21487: adecompr deflate(9) took 7546 us (5 MB/s) [ 408.438961] lustre_kcompr_21487: test_acomp_compress_decompress(deflate,9) ret 0 [ 408.687694] lustre_kcompr_21487: compr zstd(0) in 64kB chunks took 200573 us (19 MB/s), compress ratio: 4.28 [ 408.860686] lustre_kcompr_21487: compr zstd(0) in 128kB chunks took 159900 us (25 MB/s), compress ratio: 4.46 [ 409.044250] lustre_kcompr_21487: compr zstd(0) in 256kB chunks took 177755 us (22 MB/s), compress ratio: 4.61 [ 409.349411] lustre_kcompr_21487: compr zstd(0) in 512kB chunks took 297316 us (13 MB/s), compress ratio: 4.72 [ 409.624743] lustre_kcompr_21487: compr zstd(0) in 1024kB chunks took 262961 us (15 MB/s), compress ratio: 4.80 [ 409.849310] lustre_kcompr_21487: compr zstd(0) in 2048kB chunks took 213649 us (18 MB/s), compress ratio: 4.85 [ 410.031663] lustre_kcompr_21487: compr zstd(0) in 4096kB chunks took 174027 us (22 MB/s), compress ratio: 4.88 [ 410.121689] lustre_kcompr_21487: decompr zstd(0) took 67225 us (12 MB/s) [ 410.128367] lustre_kcompr_21487: test_comp_compress_decompress(zstd,0) ret 0 [ 410.142378] lustre_kcompr_21487: acompr zstd(0) of 128kB chunks took 4019 us (31 MB/s), compress ratio: 3.98 [ 410.160031] lustre_kcompr_21487: adecompr zstd(0) took 3313 us (9 MB/s) [ 410.186671] lustre_kcompr_21487: test_acomp_compress_decompress(zstd,0) ret 0 [ 410.317532] lustre_kcompr_21487: compr zstd(1) in 64kB chunks took 95727 us (41 MB/s), compress ratio: 4.06 [ 410.444754] lustre_kcompr_21487: compr zstd(1) in 128kB chunks took 113127 us (35 MB/s), compress ratio: 4.20 [ 410.532430] lustre_kcompr_21487: compr zstd(1) in 256kB chunks took 77354 us (51 MB/s), compress ratio: 4.34 [ 410.631825] lustre_kcompr_21487: compr zstd(1) in 512kB chunks took 85977 us (46 MB/s), compress ratio: 4.34 [ 410.742479] lustre_kcompr_21487: compr zstd(1) in 1024kB chunks took 102376 us (39 MB/s), compress ratio: 4.37 [ 410.833849] lustre_kcompr_21487: compr zstd(1) in 2048kB chunks took 77877 us (51 MB/s), compress ratio: 4.39 [ 410.912464] lustre_kcompr_21487: compr zstd(1) in 4096kB chunks took 67914 us (58 MB/s), compress ratio: 4.40 [ 410.951172] lustre_kcompr_21487: decompr zstd(1) took 24228 us (37 MB/s) [ 410.955550] lustre_kcompr_21487: test_comp_compress_decompress(zstd,1) ret 0 [ 410.961253] lustre_kcompr_21487: acompr zstd(1) of 128kB chunks took 1309 us (95 MB/s), compress ratio: 3.73 [ 410.964826] lustre_kcompr_21487: adecompr zstd(1) took 587 us (57 MB/s) [ 410.969826] lustre_kcompr_21487: test_acomp_compress_decompress(zstd,1) ret 0 [ 412.153601] lustre_kcompr_21487: compr zstd(10) in 64kB chunks took 1173908 us (3 MB/s), compress ratio: 4.80 [ 413.823149] lustre_kcompr_21487: compr zstd(10) in 128kB chunks took 1656265 us (2 MB/s), compress ratio: 5.09 [ 415.816617] lustre_kcompr_21487: compr zstd(10) in 256kB chunks took 1981021 us (2 MB/s), compress ratio: 5.34 [ 417.313135] lustre_kcompr_21487: compr zstd(10) in 512kB chunks took 1474940 us (2 MB/s), compress ratio: 5.45 [ 418.737562] lustre_kcompr_21487: compr zstd(10) in 1024kB chunks took 1416829 us (2 MB/s), compress ratio: 5.62 [ 420.329484] lustre_kcompr_21487: compr zstd(10) in 2048kB chunks took 1588286 us (2 MB/s), compress ratio: 5.76 [ 421.906782] lustre_kcompr_21487: compr zstd(10) in 4096kB chunks took 1571316 us (2 MB/s), compress ratio: 5.89 [ 421.976610] lustre_kcompr_21487: decompr zstd(10) took 45025 us (15 MB/s) [ 421.986279] lustre_kcompr_21487: test_comp_compress_decompress(zstd,10) ret 0 [ 422.076713] lustre_kcompr_21487: acompr zstd(10) of 128kB chunks took 83196 us (1 MB/s), compress ratio: 4.46 [ 422.094570] lustre_kcompr_21487: adecompr zstd(10) took 623 us (44 MB/s) [ 422.114133] lustre_kcompr_21487: test_acomp_compress_decompress(zstd,10) ret 0 [ 442.144450] lustre_kcompr_21487: compr zstd(15) in 64kB chunks took 20003983 us (0 MB/s), compress ratio: 4.96 [ 460.797162] lustre_kcompr_21487: compr zstd(15) in 128kB chunks took 18638891 us (0 MB/s), compress ratio: 5.28 [ 472.953595] lustre_kcompr_21487: compr zstd(15) in 256kB chunks took 12141825 us (0 MB/s), compress ratio: 5.57 [ 484.021477] lustre_kcompr_21487: compr zstd(15) in 512kB chunks took 11057474 us (0 MB/s), compress ratio: 5.83 [ 497.073782] lustre_kcompr_21487: compr zstd(15) in 1024kB chunks took 13036842 us (0 MB/s), compress ratio: 6.06 [ 510.400104] lustre_kcompr_21487: compr zstd(15) in 2048kB chunks took 13321350 us (0 MB/s), compress ratio: 6.26 [ 525.003625] lustre_kcompr_21487: compr zstd(15) in 4096kB chunks took 14588316 us (0 MB/s), compress ratio: 6.46 [ 525.095080] lustre_kcompr_21487: decompr zstd(15) took 54216 us (11 MB/s) [ 525.115546] lustre_kcompr_21487: test_comp_compress_decompress(zstd,15) ret 0 [ 525.672145] lustre_kcompr_21487: acompr zstd(15) of 128kB chunks took 544814 us (0 MB/s), compress ratio: 4.64 [ 525.688066] lustre_kcompr_21487: adecompr zstd(15) took 1218 us (22 MB/s) [ 525.714574] lustre_kcompr_21487: test_acomp_compress_decompress(zstd,15) ret 0 [ 525.857778] lustre_kcompr_21487: compr zstdfast(1) in 64kB chunks took 114333 us (34 MB/s), compress ratio: 3.49 [ 525.989546] lustre_kcompr_21487: compr zstdfast(1) in 128kB chunks took 99558 us (40 MB/s), compress ratio: 3.62 [ 526.146839] lustre_kcompr_21487: compr zstdfast(1) in 256kB chunks took 138860 us (28 MB/s), compress ratio: 3.84 [ 526.265965] lustre_kcompr_21487: compr zstdfast(1) in 512kB chunks took 108978 us (36 MB/s), compress ratio: 3.73 [ 526.345142] lustre_kcompr_21487: compr zstdfast(1) in 1024kB chunks took 69523 us (57 MB/s), compress ratio: 3.76 [ 526.500753] lustre_kcompr_21487: compr zstdfast(1) in 2048kB chunks took 149578 us (26 MB/s), compress ratio: 3.77 [ 526.589754] lustre_kcompr_21487: compr zstdfast(1) in 4096kB chunks took 72241 us (55 MB/s), compress ratio: 3.78 [ 526.626959] lustre_kcompr_21487: decompr zstdfast(1) took 23824 us (44 MB/s) [ 526.633192] lustre_kcompr_21487: test_comp_compress_decompress(zstdfast,1) ret 0 [ 526.639584] lustre_kcompr_21487: acompr zstdfast(1) of 128kB chunks took 1502 us (83 MB/s), compress ratio: 3.19 [ 526.647635] lustre_kcompr_21487: adecompr zstdfast(1) took 509 us (76 MB/s) [ 526.654884] lustre_kcompr_21487: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 526.720492] lustre_kcompr_21487: compr zstdfast(5) in 64kB chunks took 46543 us (85 MB/s), compress ratio: 2.81 [ 526.765532] lustre_kcompr_21487: compr zstdfast(5) in 128kB chunks took 40628 us (98 MB/s), compress ratio: 2.93 [ 526.817275] lustre_kcompr_21487: compr zstdfast(5) in 256kB chunks took 46040 us (86 MB/s), compress ratio: 3.16 [ 526.871501] lustre_kcompr_21487: compr zstdfast(5) in 512kB chunks took 49050 us (81 MB/s), compress ratio: 3.04 [ 526.934740] lustre_kcompr_21487: compr zstdfast(5) in 1024kB chunks took 58233 us (68 MB/s), compress ratio: 3.07 [ 526.990348] lustre_kcompr_21487: compr zstdfast(5) in 2048kB chunks took 49164 us (81 MB/s), compress ratio: 3.08 [ 527.035452] lustre_kcompr_21487: compr zstdfast(5) in 4096kB chunks took 40883 us (97 MB/s), compress ratio: 3.09 [ 527.061841] lustre_kcompr_21487: decompr zstdfast(5) took 13602 us (95 MB/s) [ 527.068562] lustre_kcompr_21487: test_comp_compress_decompress(zstdfast,5) ret 0 [ 527.075192] lustre_kcompr_21487: acompr zstdfast(5) of 128kB chunks took 1882 us (66 MB/s), compress ratio: 2.56 [ 527.080427] lustre_kcompr_21487: adecompr zstdfast(5) took 431 us (113 MB/s) [ 527.086238] lustre_kcompr_21487: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 527.129539] lustre_kcompr_21487: compr zstdfast(12) in 64kB chunks took 32215 us (124 MB/s), compress ratio: 1.43 [ 527.197337] lustre_kcompr_21487: compr zstdfast(12) in 128kB chunks took 57037 us (70 MB/s), compress ratio: 1.50 [ 527.262400] lustre_kcompr_21487: compr zstdfast(12) in 256kB chunks took 52942 us (75 MB/s), compress ratio: 1.62 [ 527.323384] lustre_kcompr_21487: compr zstdfast(12) in 512kB chunks took 46351 us (86 MB/s), compress ratio: 1.55 [ 527.370638] lustre_kcompr_21487: compr zstdfast(12) in 1024kB chunks took 39451 us (101 MB/s), compress ratio: 1.58 [ 527.429289] lustre_kcompr_21487: compr zstdfast(12) in 2048kB chunks took 41992 us (95 MB/s), compress ratio: 1.60 [ 527.490938] lustre_kcompr_21487: compr zstdfast(12) in 4096kB chunks took 56034 us (71 MB/s), compress ratio: 1.60 [ 527.551195] lustre_kcompr_21487: decompr zstdfast(12) took 39931 us (62 MB/s) [ 527.565153] lustre_kcompr_21487: test_comp_compress_decompress(zstdfast,12) ret 0 [ 527.574181] lustre_kcompr_21487: acompr zstdfast(12) of 128kB chunks took 1837 us (68 MB/s), compress ratio: 1.37 [ 527.583214] lustre_kcompr_21487: adecompr zstdfast(12) took 1482 us (61 MB/s) [ 527.604272] lustre_kcompr_21487: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 527.672481] lustre_kcompr_21487: compr zstdfast(15) in 64kB chunks took 40623 us (98 MB/s), compress ratio: 1.12 [ 527.704470] lustre_kcompr_21487: compr zstdfast(15) in 128kB chunks took 15580 us (256 MB/s), compress ratio: 1.16 [ 527.731598] lustre_kcompr_21487: compr zstdfast(15) in 256kB chunks took 19724 us (202 MB/s), compress ratio: 1.22 [ 527.764409] lustre_kcompr_21487: compr zstdfast(15) in 512kB chunks took 22588 us (177 MB/s), compress ratio: 1.20 [ 527.791425] lustre_kcompr_21487: compr zstdfast(15) in 1024kB chunks took 20797 us (192 MB/s), compress ratio: 1.22 [ 527.830851] lustre_kcompr_21487: compr zstdfast(15) in 2048kB chunks took 28419 us (140 MB/s), compress ratio: 1.23 [ 527.866331] lustre_kcompr_21487: compr zstdfast(15) in 4096kB chunks took 25682 us (155 MB/s), compress ratio: 1.23 [ 527.904502] lustre_kcompr_21487: decompr zstdfast(15) took 15209 us (212 MB/s) [ 527.912208] lustre_kcompr_21487: test_comp_compress_decompress(zstdfast,15) ret 0 [ 527.931155] lustre_kcompr_21487: acompr zstdfast(15) of 128kB chunks took 414 us (301 MB/s), compress ratio: 1.08 [ 527.956425] lustre_kcompr_21487: adecompr zstdfast(15) took 197 us (586 MB/s) [ 528.036923] lustre_kcompr_21487: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 528.052275] lustre_kcompr_21487: SUCCESS [ 533.829010] lustre_kcompr_7676: ***** [ 533.831343] lustre_kcompr_7676: (de)compression test on provided file /tmp/f84.sanity [ 533.837100] lustre_kcompr_7676: ***** [ 533.883325] lustre_kcompr_7676: compr lz4(1) in 64kB chunks took 30561 us (130 MB/s), compress ratio: 2.45 [ 533.915819] lustre_kcompr_7676: compr lz4(1) in 128kB chunks took 25370 us (157 MB/s), compress ratio: 2.39 [ 533.951874] lustre_kcompr_7676: compr lz4(1) in 256kB chunks took 27954 us (143 MB/s), compress ratio: 2.39 [ 533.982148] lustre_kcompr_7676: compr lz4(1) in 512kB chunks took 23788 us (168 MB/s), compress ratio: 2.39 [ 534.025625] lustre_kcompr_7676: compr lz4(1) in 1024kB chunks took 35754 us (111 MB/s), compress ratio: 2.39 [ 534.051731] lustre_kcompr_7676: compr lz4(1) in 2048kB chunks took 20601 us (194 MB/s), compress ratio: 2.39 [ 534.082467] lustre_kcompr_7676: compr lz4(1) in 4096kB chunks took 23498 us (170 MB/s), compress ratio: 2.39 [ 534.099099] lustre_kcompr_7676: decompr lz4(1) took 3160 us (528 MB/s) [ 534.103622] lustre_kcompr_7676: test_comp_compress_decompress(lz4,1) ret 0 [ 534.109811] lustre_kcompr_7676: acompr lz4(1) of 128kB chunks took 215 us (581 MB/s), compress ratio: 15.67 [ 534.119682] lustre_kcompr_7676: adecompr lz4(1) took 149 us (53 MB/s) [ 534.127915] lustre_kcompr_7676: test_acomp_compress_decompress(lz4,1) ret 0 [ 534.161401] lustre_kcompr_7676: compr lz4(4) in 64kB chunks took 16323 us (245 MB/s), compress ratio: 2.36 [ 534.183651] lustre_kcompr_7676: compr lz4(4) in 128kB chunks took 12951 us (308 MB/s), compress ratio: 2.35 [ 534.200658] lustre_kcompr_7676: compr lz4(4) in 256kB chunks took 11793 us (339 MB/s), compress ratio: 2.35 [ 534.230981] lustre_kcompr_7676: compr lz4(4) in 512kB chunks took 24750 us (161 MB/s), compress ratio: 2.35 [ 534.261518] lustre_kcompr_7676: compr lz4(4) in 1024kB chunks took 20900 us (191 MB/s), compress ratio: 2.35 [ 534.276315] lustre_kcompr_7676: compr lz4(4) in 2048kB chunks took 9884 us (404 MB/s), compress ratio: 2.35 [ 534.297989] lustre_kcompr_7676: compr lz4(4) in 4096kB chunks took 13450 us (297 MB/s), compress ratio: 2.35 [ 534.316632] lustre_kcompr_7676: decompr lz4(4) took 3401 us (499 MB/s) [ 534.320538] lustre_kcompr_7676: test_comp_compress_decompress(lz4,4) ret 0 [ 534.325875] lustre_kcompr_7676: acompr lz4(4) of 128kB chunks took 508 us (246 MB/s), compress ratio: 15.30 [ 534.332118] lustre_kcompr_7676: adecompr lz4(4) took 232 us (35 MB/s) [ 534.339842] lustre_kcompr_7676: test_acomp_compress_decompress(lz4,4) ret 0 [ 534.372936] lustre_kcompr_7676: compr lz4(9) in 64kB chunks took 15520 us (257 MB/s), compress ratio: 2.32 [ 534.403944] lustre_kcompr_7676: compr lz4(9) in 128kB chunks took 12430 us (321 MB/s), compress ratio: 2.31 [ 534.436044] lustre_kcompr_7676: compr lz4(9) in 256kB chunks took 24084 us (166 MB/s), compress ratio: 2.31 [ 534.460388] lustre_kcompr_7676: compr lz4(9) in 512kB chunks took 16995 us (235 MB/s), compress ratio: 2.31 [ 534.478495] lustre_kcompr_7676: compr lz4(9) in 1024kB chunks took 12731 us (314 MB/s), compress ratio: 2.31 [ 534.493935] lustre_kcompr_7676: compr lz4(9) in 2048kB chunks took 9957 us (401 MB/s), compress ratio: 2.32 [ 534.513941] lustre_kcompr_7676: compr lz4(9) in 4096kB chunks took 13999 us (285 MB/s), compress ratio: 2.32 [ 534.537250] lustre_kcompr_7676: decompr lz4(9) took 4583 us (376 MB/s) [ 534.543728] lustre_kcompr_7676: test_comp_compress_decompress(lz4,9) ret 0 [ 534.550489] lustre_kcompr_7676: acompr lz4(9) of 128kB chunks took 140 us (892 MB/s), compress ratio: 14.81 [ 534.558406] lustre_kcompr_7676: adecompr lz4(9) took 94 us (89 MB/s) [ 534.564805] lustre_kcompr_7676: test_acomp_compress_decompress(lz4,9) ret 0 [ 534.589322] lustre_kcompr_7676: compr lz4(15) in 64kB chunks took 10548 us (379 MB/s), compress ratio: 2.23 [ 534.608137] lustre_kcompr_7676: compr lz4(15) in 128kB chunks took 13010 us (307 MB/s), compress ratio: 2.23 [ 534.620744] lustre_kcompr_7676: compr lz4(15) in 256kB chunks took 6800 us (588 MB/s), compress ratio: 2.23 [ 534.633513] lustre_kcompr_7676: compr lz4(15) in 512kB chunks took 7827 us (511 MB/s), compress ratio: 2.23 [ 534.643978] lustre_kcompr_7676: compr lz4(15) in 1024kB chunks took 5990 us (667 MB/s), compress ratio: 2.23 [ 534.660299] lustre_kcompr_7676: compr lz4(15) in 2048kB chunks took 9146 us (437 MB/s), compress ratio: 2.23 [ 534.674430] lustre_kcompr_7676: compr lz4(15) in 4096kB chunks took 9253 us (432 MB/s), compress ratio: 2.23 [ 534.697101] lustre_kcompr_7676: decompr lz4(15) took 4567 us (391 MB/s) [ 534.702595] lustre_kcompr_7676: test_comp_compress_decompress(lz4,15) ret 0 [ 534.707389] lustre_kcompr_7676: acompr lz4(15) of 128kB chunks took 162 us (771 MB/s), compress ratio: 14.18 [ 534.718182] lustre_kcompr_7676: adecompr lz4(15) took 318 us (27 MB/s) [ 534.726614] lustre_kcompr_7676: test_acomp_compress_decompress(lz4,15) ret 0 [ 535.015733] lustre_kcompr_7676: compr lz4hc(1) in 64kB chunks took 276483 us (14 MB/s), compress ratio: 2.54 [ 535.402135] lustre_kcompr_7676: compr lz4hc(1) in 128kB chunks took 365560 us (10 MB/s), compress ratio: 2.61 [ 535.767684] lustre_kcompr_7676: compr lz4hc(1) in 256kB chunks took 341535 us (11 MB/s), compress ratio: 2.64 [ 536.095620] lustre_kcompr_7676: compr lz4hc(1) in 512kB chunks took 315698 us (12 MB/s), compress ratio: 2.66 [ 536.366592] lustre_kcompr_7676: compr lz4hc(1) in 1024kB chunks took 248687 us (16 MB/s), compress ratio: 2.67 [ 536.672351] lustre_kcompr_7676: compr lz4hc(1) in 2048kB chunks took 300652 us (13 MB/s), compress ratio: 2.67 [ 536.964372] lustre_kcompr_7676: compr lz4hc(1) in 4096kB chunks took 275991 us (14 MB/s), compress ratio: 2.67 [ 536.987475] lustre_kcompr_7676: decompr lz4hc(1) took 5289 us (282 MB/s) [ 537.002077] lustre_kcompr_7676: test_comp_compress_decompress(lz4hc,1) ret 0 [ 537.018558] lustre_kcompr_7676: acompr lz4hc(1) of 128kB chunks took 1125 us (111 MB/s), compress ratio: 15.97 [ 537.039595] lustre_kcompr_7676: adecompr lz4hc(1) took 559 us (13 MB/s) [ 537.057400] lustre_kcompr_7676: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 537.283918] lustre_kcompr_7676: compr lz4hc(3) in 64kB chunks took 186575 us (21 MB/s), compress ratio: 2.57 [ 537.546230] lustre_kcompr_7676: compr lz4hc(3) in 128kB chunks took 253474 us (15 MB/s), compress ratio: 2.64 [ 537.796828] lustre_kcompr_7676: compr lz4hc(3) in 256kB chunks took 243007 us (16 MB/s), compress ratio: 2.68 [ 538.099302] lustre_kcompr_7676: compr lz4hc(3) in 512kB chunks took 290780 us (13 MB/s), compress ratio: 2.69 [ 538.367865] lustre_kcompr_7676: compr lz4hc(3) in 1024kB chunks took 258878 us (15 MB/s), compress ratio: 2.70 [ 538.654547] lustre_kcompr_7676: compr lz4hc(3) in 2048kB chunks took 280300 us (14 MB/s), compress ratio: 2.71 [ 538.951455] lustre_kcompr_7676: compr lz4hc(3) in 4096kB chunks took 290678 us (13 MB/s), compress ratio: 2.71 [ 538.975991] lustre_kcompr_7676: decompr lz4hc(3) took 8272 us (177 MB/s) [ 538.992593] lustre_kcompr_7676: test_comp_compress_decompress(lz4hc,3) ret 0 [ 539.017047] lustre_kcompr_7676: acompr lz4hc(3) of 128kB chunks took 6289 us (19 MB/s), compress ratio: 16.00 [ 539.028529] lustre_kcompr_7676: adecompr lz4hc(3) took 417 us (18 MB/s) [ 539.041307] lustre_kcompr_7676: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 539.730265] lustre_kcompr_7676: compr lz4hc(8) in 64kB chunks took 662710 us (6 MB/s), compress ratio: 2.60 [ 540.458110] lustre_kcompr_7676: compr lz4hc(8) in 128kB chunks took 707745 us (5 MB/s), compress ratio: 2.66 [ 541.192694] lustre_kcompr_7676: compr lz4hc(8) in 256kB chunks took 729773 us (5 MB/s), compress ratio: 2.70 [ 541.943029] lustre_kcompr_7676: compr lz4hc(8) in 512kB chunks took 737147 us (5 MB/s), compress ratio: 2.71 [ 542.809628] lustre_kcompr_7676: compr lz4hc(8) in 1024kB chunks took 861044 us (4 MB/s), compress ratio: 2.72 [ 543.422979] lustre_kcompr_7676: compr lz4hc(8) in 2048kB chunks took 600509 us (6 MB/s), compress ratio: 2.73 [ 544.297441] lustre_kcompr_7676: compr lz4hc(8) in 4096kB chunks took 865399 us (4 MB/s), compress ratio: 2.73 [ 544.327699] lustre_kcompr_7676: decompr lz4hc(8) took 5418 us (269 MB/s) [ 544.337567] lustre_kcompr_7676: test_comp_compress_decompress(lz4hc,8) ret 0 [ 544.357924] lustre_kcompr_7676: acompr lz4hc(8) of 128kB chunks took 8230 us (15 MB/s), compress ratio: 16.17 [ 544.366906] lustre_kcompr_7676: adecompr lz4hc(8) took 126 us (61 MB/s) [ 544.391700] lustre_kcompr_7676: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 553.397958] lustre_kcompr_7676: compr lz4hc(15) in 64kB chunks took 8982380 us (0 MB/s), compress ratio: 2.61 [ 565.596816] lustre_kcompr_7676: compr lz4hc(15) in 128kB chunks took 12190550 us (0 MB/s), compress ratio: 2.67 [ 578.668668] lustre_kcompr_7676: compr lz4hc(15) in 256kB chunks took 13063983 us (0 MB/s), compress ratio: 2.71 [ 591.429488] lustre_kcompr_7676: compr lz4hc(15) in 512kB chunks took 12752833 us (0 MB/s), compress ratio: 2.72 [ 606.296668] lustre_kcompr_7676: compr lz4hc(15) in 1024kB chunks took 14859836 us (0 MB/s), compress ratio: 2.73 [ 623.755782] lustre_kcompr_7676: compr lz4hc(15) in 2048kB chunks took 17448406 us (0 MB/s), compress ratio: 2.74 [ 639.270954] lustre_kcompr_7676: compr lz4hc(15) in 4096kB chunks took 15502793 us (0 MB/s), compress ratio: 2.74 [ 639.305598] lustre_kcompr_7676: decompr lz4hc(15) took 7945 us (183 MB/s) [ 639.313452] lustre_kcompr_7676: test_comp_compress_decompress(lz4hc,15) ret 0 [ 639.379986] lustre_kcompr_7676: acompr lz4hc(15) of 128kB chunks took 53537 us (2 MB/s), compress ratio: 16.30 [ 639.396954] lustre_kcompr_7676: adecompr lz4hc(15) took 156 us (49 MB/s) [ 639.433713] lustre_kcompr_7676: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 639.489433] lustre_kcompr_7676: compr lzo(-1) in 64kB chunks took 44675 us (89 MB/s), compress ratio: 2.35 [ 639.528628] lustre_kcompr_7676: compr lzo(-1) in 128kB chunks took 25853 us (154 MB/s), compress ratio: 2.35 [ 639.585306] lustre_kcompr_7676: compr lzo(-1) in 256kB chunks took 42361 us (94 MB/s), compress ratio: 2.35 [ 639.642370] lustre_kcompr_7676: compr lzo(-1) in 512kB chunks took 43847 us (91 MB/s), compress ratio: 2.36 [ 639.675354] lustre_kcompr_7676: compr lzo(-1) in 1024kB chunks took 20779 us (192 MB/s), compress ratio: 2.36 [ 639.700879] lustre_kcompr_7676: compr lzo(-1) in 2048kB chunks took 19122 us (209 MB/s), compress ratio: 2.36 [ 639.771993] lustre_kcompr_7676: compr lzo(-1) in 4096kB chunks took 56836 us (70 MB/s), compress ratio: 2.36 [ 639.826063] lustre_kcompr_7676: decompr lzo(-1) took 16805 us (100 MB/s) [ 639.833694] lustre_kcompr_7676: test_comp_compress_decompress(lzo,-1) ret 0 [ 639.859387] lustre_kcompr_7676: acompr lzo(-1) of 128kB chunks took 1114 us (112 MB/s), compress ratio: 15.45 [ 639.870883] lustre_kcompr_7676: adecompr lzo(-1) took 181 us (44 MB/s) [ 639.911327] lustre_kcompr_7676: test_acomp_compress_decompress(lzo,-1) ret 0 [ 640.890090] lustre_kcompr_7676: compr deflate(1) in 64kB chunks took 956153 us (4 MB/s), compress ratio: 3.27 [ 641.402736] lustre_kcompr_7676: compr deflate(1) in 128kB chunks took 507814 us (7 MB/s), compress ratio: 3.28 [ 642.223383] lustre_kcompr_7676: compr deflate(1) in 256kB chunks took 806795 us (4 MB/s), compress ratio: 3.28 [ 643.080696] lustre_kcompr_7676: compr deflate(1) in 512kB chunks took 852588 us (4 MB/s), compress ratio: 3.28 [ 643.737115] lustre_kcompr_7676: compr deflate(1) in 1024kB chunks took 640071 us (6 MB/s), compress ratio: 3.28 [ 644.645455] lustre_kcompr_7676: compr deflate(1) in 2048kB chunks took 897558 us (4 MB/s), compress ratio: 3.28 [ 645.524354] lustre_kcompr_7676: compr deflate(1) in 4096kB chunks took 859272 us (4 MB/s), compress ratio: 3.28 [ 645.584538] lustre_kcompr_7676: decompr deflate(1) took 42444 us (28 MB/s) [ 645.590472] lustre_kcompr_7676: test_comp_compress_decompress(deflate,1) ret 0 [ 645.610733] lustre_kcompr_7676: acompr deflate(1) of 128kB chunks took 14548 us (8 MB/s), compress ratio: 21.43 [ 645.616987] lustre_kcompr_7676: adecompr deflate(1) took 310 us (18 MB/s) [ 645.628455] lustre_kcompr_7676: test_acomp_compress_decompress(deflate,1) ret 0 [ 646.539293] lustre_kcompr_7676: compr deflate(6) in 64kB chunks took 898604 us (4 MB/s), compress ratio: 3.27 [ 647.531984] lustre_kcompr_7676: compr deflate(6) in 128kB chunks took 968816 us (4 MB/s), compress ratio: 3.28 [ 648.367363] lustre_kcompr_7676: compr deflate(6) in 256kB chunks took 827641 us (4 MB/s), compress ratio: 3.28 [ 649.352197] lustre_kcompr_7676: compr deflate(6) in 512kB chunks took 971498 us (4 MB/s), compress ratio: 3.28 [ 650.252669] lustre_kcompr_7676: compr deflate(6) in 1024kB chunks took 875374 us (4 MB/s), compress ratio: 3.28 [ 651.062812] lustre_kcompr_7676: compr deflate(6) in 2048kB chunks took 795840 us (5 MB/s), compress ratio: 3.28 [ 651.914991] lustre_kcompr_7676: compr deflate(6) in 4096kB chunks took 836696 us (4 MB/s), compress ratio: 3.28 [ 651.991753] lustre_kcompr_7676: decompr deflate(6) took 65381 us (18 MB/s) [ 652.006193] lustre_kcompr_7676: test_comp_compress_decompress(deflate,6) ret 0 [ 652.050674] lustre_kcompr_7676: acompr deflate(6) of 128kB chunks took 24794 us (5 MB/s), compress ratio: 21.43 [ 652.056366] lustre_kcompr_7676: adecompr deflate(6) took 318 us (18 MB/s) [ 652.067450] lustre_kcompr_7676: test_acomp_compress_decompress(deflate,6) ret 0 [ 653.022817] lustre_kcompr_7676: compr deflate(9) in 64kB chunks took 933055 us (4 MB/s), compress ratio: 3.27 [ 653.683387] lustre_kcompr_7676: compr deflate(9) in 128kB chunks took 648275 us (6 MB/s), compress ratio: 3.28 [ 654.569796] lustre_kcompr_7676: compr deflate(9) in 256kB chunks took 880266 us (4 MB/s), compress ratio: 3.28 [ 655.554191] lustre_kcompr_7676: compr deflate(9) in 512kB chunks took 971429 us (4 MB/s), compress ratio: 3.28 [ 656.464988] lustre_kcompr_7676: compr deflate(9) in 1024kB chunks took 904850 us (4 MB/s), compress ratio: 3.28 [ 657.319295] lustre_kcompr_7676: compr deflate(9) in 2048kB chunks took 847480 us (4 MB/s), compress ratio: 3.28 [ 658.503714] lustre_kcompr_7676: compr deflate(9) in 4096kB chunks took 1166885 us (3 MB/s), compress ratio: 3.28 [ 658.607315] lustre_kcompr_7676: decompr deflate(9) took 76720 us (15 MB/s) [ 658.630388] lustre_kcompr_7676: test_comp_compress_decompress(deflate,9) ret 0 [ 658.672330] lustre_kcompr_7676: acompr deflate(9) of 128kB chunks took 21382 us (5 MB/s), compress ratio: 21.43 [ 658.689789] lustre_kcompr_7676: adecompr deflate(9) took 407 us (14 MB/s) [ 658.750075] lustre_kcompr_7676: test_acomp_compress_decompress(deflate,9) ret 0 [ 659.047485] lustre_kcompr_7676: compr zstd(0) in 64kB chunks took 249697 us (16 MB/s), compress ratio: 3.28 [ 659.307599] lustre_kcompr_7676: compr zstd(0) in 128kB chunks took 254055 us (15 MB/s), compress ratio: 3.26 [ 659.554864] lustre_kcompr_7676: compr zstd(0) in 256kB chunks took 240031 us (16 MB/s), compress ratio: 3.31 [ 659.849190] lustre_kcompr_7676: compr zstd(0) in 512kB chunks took 282854 us (14 MB/s), compress ratio: 3.32 [ 660.082035] lustre_kcompr_7676: compr zstd(0) in 1024kB chunks took 220430 us (18 MB/s), compress ratio: 3.32 [ 660.365196] lustre_kcompr_7676: compr zstd(0) in 2048kB chunks took 268992 us (14 MB/s), compress ratio: 3.33 [ 660.593094] lustre_kcompr_7676: compr zstd(0) in 4096kB chunks took 220245 us (18 MB/s), compress ratio: 3.33 [ 660.631703] lustre_kcompr_7676: decompr zstd(0) took 26364 us (45 MB/s) [ 660.638740] lustre_kcompr_7676: test_comp_compress_decompress(zstd,0) ret 0 [ 660.649942] lustre_kcompr_7676: acompr zstd(0) of 128kB chunks took 1054 us (118 MB/s), compress ratio: 22.64 [ 660.661195] lustre_kcompr_7676: adecompr zstd(0) took 462 us (11 MB/s) [ 660.711063] lustre_kcompr_7676: test_acomp_compress_decompress(zstd,0) ret 0 [ 660.793358] lustre_kcompr_7676: compr zstd(1) in 64kB chunks took 59726 us (66 MB/s), compress ratio: 3.22 [ 660.904102] lustre_kcompr_7676: compr zstd(1) in 128kB chunks took 99380 us (40 MB/s), compress ratio: 3.18 [ 660.994082] lustre_kcompr_7676: compr zstd(1) in 256kB chunks took 76769 us (52 MB/s), compress ratio: 3.19 [ 661.064891] lustre_kcompr_7676: compr zstd(1) in 512kB chunks took 65387 us (61 MB/s), compress ratio: 3.19 [ 661.150515] lustre_kcompr_7676: compr zstd(1) in 1024kB chunks took 78564 us (50 MB/s), compress ratio: 3.19 [ 661.249193] lustre_kcompr_7676: compr zstd(1) in 2048kB chunks took 86952 us (46 MB/s), compress ratio: 3.19 [ 661.349176] lustre_kcompr_7676: compr zstd(1) in 4096kB chunks took 90534 us (44 MB/s), compress ratio: 3.19 [ 661.403954] lustre_kcompr_7676: decompr zstd(1) took 30771 us (40 MB/s) [ 661.412919] lustre_kcompr_7676: test_comp_compress_decompress(zstd,1) ret 0 [ 661.427272] lustre_kcompr_7676: acompr zstd(1) of 128kB chunks took 357 us (350 MB/s), compress ratio: 22.79 [ 661.439576] lustre_kcompr_7676: adecompr zstd(1) took 221 us (24 MB/s) [ 661.463913] lustre_kcompr_7676: test_acomp_compress_decompress(zstd,1) ret 0 [ 662.501355] lustre_kcompr_7676: compr zstd(10) in 64kB chunks took 1009692 us (3 MB/s), compress ratio: 3.33 [ 663.656891] lustre_kcompr_7676: compr zstd(10) in 128kB chunks took 1144846 us (3 MB/s), compress ratio: 3.33 [ 664.941484] lustre_kcompr_7676: compr zstd(10) in 256kB chunks took 1277991 us (3 MB/s), compress ratio: 3.37 [ 666.480396] lustre_kcompr_7676: compr zstd(10) in 512kB chunks took 1521765 us (2 MB/s), compress ratio: 3.40 [ 668.114132] lustre_kcompr_7676: compr zstd(10) in 1024kB chunks took 1618522 us (2 MB/s), compress ratio: 3.42 [ 669.685270] lustre_kcompr_7676: compr zstd(10) in 2048kB chunks took 1546111 us (2 MB/s), compress ratio: 3.46 [ 671.135520] lustre_kcompr_7676: compr zstd(10) in 4096kB chunks took 1445376 us (2 MB/s), compress ratio: 3.50 [ 671.247129] lustre_kcompr_7676: decompr zstd(10) took 85279 us (13 MB/s) [ 671.265083] lustre_kcompr_7676: test_comp_compress_decompress(zstd,10) ret 0 [ 671.282761] lustre_kcompr_7676: acompr zstd(10) of 128kB chunks took 6008 us (20 MB/s), compress ratio: 22.78 [ 671.293588] lustre_kcompr_7676: adecompr zstd(10) took 181 us (30 MB/s) [ 671.329914] lustre_kcompr_7676: test_acomp_compress_decompress(zstd,10) ret 0 [ 685.797769] lustre_kcompr_7676: compr zstd(15) in 64kB chunks took 14417289 us (0 MB/s), compress ratio: 3.36 [ 692.311563] lustre_kcompr_7676: compr zstd(15) in 128kB chunks took 6503700 us (0 MB/s), compress ratio: 3.39 [ 699.354435] lustre_kcompr_7676: compr zstd(15) in 256kB chunks took 7020146 us (0 MB/s), compress ratio: 3.40 [ 705.971897] lustre_kcompr_7676: compr zstd(15) in 512kB chunks took 6606849 us (0 MB/s), compress ratio: 3.42 [ 712.667888] lustre_kcompr_7676: compr zstd(15) in 1024kB chunks took 6688672 us (0 MB/s), compress ratio: 3.43 [ 718.268055] lustre_kcompr_7676: compr zstd(15) in 2048kB chunks took 5585348 us (0 MB/s), compress ratio: 3.48 [ 723.896816] lustre_kcompr_7676: compr zstd(15) in 4096kB chunks took 5619457 us (0 MB/s), compress ratio: 3.56 [ 724.036641] lustre_kcompr_7676: decompr zstd(15) took 109773 us (10 MB/s) [ 724.054848] lustre_kcompr_7676: test_comp_compress_decompress(zstd,15) ret 0 [ 724.194844] lustre_kcompr_7676: acompr zstd(15) of 128kB chunks took 110755 us (1 MB/s), compress ratio: 23.92 [ 724.212236] lustre_kcompr_7676: adecompr zstd(15) took 207 us (25 MB/s) [ 724.243237] lustre_kcompr_7676: test_acomp_compress_decompress(zstd,15) ret 0 [ 724.339864] lustre_kcompr_7676: compr zstdfast(1) in 64kB chunks took 56380 us (70 MB/s), compress ratio: 2.47 [ 724.392690] lustre_kcompr_7676: compr zstdfast(1) in 128kB chunks took 42889 us (93 MB/s), compress ratio: 2.48 [ 724.451856] lustre_kcompr_7676: compr zstdfast(1) in 256kB chunks took 52815 us (75 MB/s), compress ratio: 2.53 [ 724.517128] lustre_kcompr_7676: compr zstdfast(1) in 512kB chunks took 53616 us (74 MB/s), compress ratio: 2.42 [ 724.583242] lustre_kcompr_7676: compr zstdfast(1) in 1024kB chunks took 57796 us (69 MB/s), compress ratio: 2.42 [ 724.635291] lustre_kcompr_7676: compr zstdfast(1) in 2048kB chunks took 36316 us (110 MB/s), compress ratio: 2.42 [ 724.706279] lustre_kcompr_7676: compr zstdfast(1) in 4096kB chunks took 54387 us (73 MB/s), compress ratio: 2.42 [ 724.720695] lustre_kcompr_7676: decompr zstdfast(1) took 4012 us (411 MB/s) [ 724.725541] lustre_kcompr_7676: test_comp_compress_decompress(zstdfast,1) ret 0 [ 724.738126] lustre_kcompr_7676: acompr zstdfast(1) of 128kB chunks took 2124 us (58 MB/s), compress ratio: 17.28 [ 724.752118] lustre_kcompr_7676: adecompr zstdfast(1) took 121 us (59 MB/s) [ 724.765575] lustre_kcompr_7676: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 724.795983] lustre_kcompr_7676: compr zstdfast(5) in 64kB chunks took 18663 us (214 MB/s), compress ratio: 2.38 [ 724.846328] lustre_kcompr_7676: compr zstdfast(5) in 128kB chunks took 43469 us (92 MB/s), compress ratio: 2.38 [ 724.917515] lustre_kcompr_7676: compr zstdfast(5) in 256kB chunks took 60382 us (66 MB/s), compress ratio: 2.40 [ 724.963943] lustre_kcompr_7676: compr zstdfast(5) in 512kB chunks took 32150 us (124 MB/s), compress ratio: 2.36 [ 725.013301] lustre_kcompr_7676: compr zstdfast(5) in 1024kB chunks took 39983 us (100 MB/s), compress ratio: 2.36 [ 725.053739] lustre_kcompr_7676: compr zstdfast(5) in 2048kB chunks took 25936 us (154 MB/s), compress ratio: 2.36 [ 725.090895] lustre_kcompr_7676: compr zstdfast(5) in 4096kB chunks took 29985 us (133 MB/s), compress ratio: 2.36 [ 725.125976] lustre_kcompr_7676: decompr zstdfast(5) took 6749 us (250 MB/s) [ 725.135255] lustre_kcompr_7676: test_comp_compress_decompress(zstdfast,5) ret 0 [ 725.144068] lustre_kcompr_7676: acompr zstdfast(5) of 128kB chunks took 626 us (199 MB/s), compress ratio: 16.12 [ 725.158822] lustre_kcompr_7676: adecompr zstdfast(5) took 188 us (41 MB/s) [ 725.181582] lustre_kcompr_7676: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 725.230405] lustre_kcompr_7676: compr zstdfast(12) in 64kB chunks took 13114 us (305 MB/s), compress ratio: 2.07 [ 725.257914] lustre_kcompr_7676: compr zstdfast(12) in 128kB chunks took 15626 us (255 MB/s), compress ratio: 2.07 [ 725.294487] lustre_kcompr_7676: compr zstdfast(12) in 256kB chunks took 22530 us (177 MB/s), compress ratio: 2.08 [ 725.324947] lustre_kcompr_7676: compr zstdfast(12) in 512kB chunks took 17163 us (233 MB/s), compress ratio: 2.07 [ 725.349906] lustre_kcompr_7676: compr zstdfast(12) in 1024kB chunks took 11349 us (352 MB/s), compress ratio: 2.07 [ 725.387970] lustre_kcompr_7676: compr zstdfast(12) in 2048kB chunks took 25433 us (157 MB/s), compress ratio: 2.07 [ 725.408625] lustre_kcompr_7676: compr zstdfast(12) in 4096kB chunks took 9883 us (404 MB/s), compress ratio: 2.08 [ 725.442652] lustre_kcompr_7676: decompr zstdfast(12) took 10648 us (180 MB/s) [ 725.453446] lustre_kcompr_7676: test_comp_compress_decompress(zstdfast,12) ret 0 [ 725.466081] lustre_kcompr_7676: acompr zstdfast(12) of 128kB chunks took 239 us (523 MB/s), compress ratio: 13.13 [ 725.484843] lustre_kcompr_7676: adecompr zstdfast(12) took 333 us (28 MB/s) [ 725.520025] lustre_kcompr_7676: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 725.563671] lustre_kcompr_7676: compr zstdfast(15) in 64kB chunks took 14984 us (266 MB/s), compress ratio: 1.82 [ 725.591632] lustre_kcompr_7676: compr zstdfast(15) in 128kB chunks took 21985 us (181 MB/s), compress ratio: 1.83 [ 725.610438] lustre_kcompr_7676: compr zstdfast(15) in 256kB chunks took 8359 us (478 MB/s), compress ratio: 1.83 [ 725.624667] lustre_kcompr_7676: compr zstdfast(15) in 512kB chunks took 6667 us (599 MB/s), compress ratio: 1.83 [ 725.643848] lustre_kcompr_7676: compr zstdfast(15) in 1024kB chunks took 12272 us (325 MB/s), compress ratio: 1.83 [ 725.673658] lustre_kcompr_7676: compr zstdfast(15) in 2048kB chunks took 18974 us (210 MB/s), compress ratio: 1.83 [ 725.697083] lustre_kcompr_7676: compr zstdfast(15) in 4096kB chunks took 6523 us (613 MB/s), compress ratio: 1.84 [ 725.734809] lustre_kcompr_7676: decompr zstdfast(15) took 7763 us (279 MB/s) [ 725.750664] lustre_kcompr_7676: test_comp_compress_decompress(zstdfast,15) ret 0 [ 725.768307] lustre_kcompr_7676: acompr zstdfast(15) of 128kB chunks took 167 us (748 MB/s), compress ratio: 10.73 [ 725.784273] lustre_kcompr_7676: adecompr zstdfast(15) took 599 us (19 MB/s) [ 725.819659] lustre_kcompr_7676: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 725.824800] lustre_kcompr_7676: SUCCESS [ 757.558880] Lustre: DEBUG MARKER: == sanity test complete, duration 499 sec ================ 12:43:51 (1789058631) [ 760.884276] Lustre: DEBUG MARKER: === sanity: start cleanup 12:43:55 (1789058635) === [ 767.418878] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:44:01 (1789058641) === [ 770.172645] LustreError: 13368:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff9f470726d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 770.220758] Lustre: Unmounted lustre-client [ 798.854425] Key type lgssc unregistered [ 799.078489] LNet: 13850:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 799.088750] LNetError: 13850:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 799.113461] LNet: Removed LNI 192.168.204.49@tcp [ 800.059235] Key type .llcrypt unregistered [ 800.062567] Key type ._llcrypt unregistered