[ 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 431979590 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: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003318] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005013] kvm-guest: setup PV IPIs [ 0.008595] ..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.009023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010014] pid_max: default: 32768 minimum: 301 [ 0.011119] LSM: Security Framework initializing [ 0.012052] Yama: becoming mindful. [ 0.013033] SELinux: Initializing. [ 0.014065] *** VALIDATE selinux *** [ 0.021451] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026766] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027146] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028116] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029106] *** VALIDATE tmpfs *** [ 0.030434] *** VALIDATE proc *** [ 0.031236] *** VALIDATE cgroup *** [ 0.032010] *** VALIDATE cgroup2 *** [ 0.033340] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.034185] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.035015] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037007] Spectre V2 : User space: Vulnerable [ 0.038019] Speculative Store Bypass: Vulnerable [ 0.041465] debug: unmapping init [mem 0xffffffff85a59000-0xffffffff85a60fff] [ 0.043221] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044796] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045031] ... version: 2 [ 0.046018] ... bit width: 48 [ 0.047017] ... generic registers: 4 [ 0.048027] ... value mask: 0000ffffffffffff [ 0.049019] ... max period: 00007fffffffffff [ 0.050018] ... fixed-purpose events: 3 [ 0.051016] ... event mask: 000000070000000f [ 0.053322] rcu: Hierarchical SRCU implementation. [ 0.055775] smp: Bringing up secondary CPUs ... [ 0.056681] x86: Booting SMP configuration: [ 0.057040] .... node #0, CPUs: #1 #2 #3 [ 0.061027] smp: Brought up 1 node, 4 CPUs [ 0.063021] smpboot: Max logical packages: 1 [ 0.064021] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.196283] node 0 deferred pages initialised in 130ms [ 0.200013] devtmpfs: initialized [ 0.201287] x86/mm: Memory block size: 128MB [ 0.203776] gcov: version magic: 0x41383552 [ 0.207427] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.208145] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.211321] pinctrl core: initialized pinctrl subsystem [ 0.213170] [ 0.213744] ************************************************************* [ 0.216075] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.219017] ** ** [ 0.222014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.224013] ** ** [ 0.227024] ** This means that this kernel is built to expose internal ** [ 0.230014] ** IOMMU data structures, which may compromise security on ** [ 0.232012] ** your system. ** [ 0.235015] ** ** [ 0.239024] ** If you see this message and you are not debugging the ** [ 0.241023] ** kernel, report this immediately to your vendor! ** [ 0.244013] ** ** [ 0.247016] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.250013] ************************************************************* [ 0.252705] NET: Registered protocol family 16 [ 0.254466] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.257055] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.260063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.263452] cpuidle: using governor menu [ 0.266234] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.268496] PCI: Using configuration type 1 for base access [ 0.271132] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.281078] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.283029] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.285123] cryptd: max_cpu_qlen set to 1000 [ 0.288352] ACPI: Added _OSI(Module Device) [ 0.290021] ACPI: Added _OSI(Processor Device) [ 0.292014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.293030] ACPI: Added _OSI(Processor Aggregator Device) [ 0.299000] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.304522] ACPI: Interpreter enabled [ 0.306152] ACPI: PM: (supports S0 S3 S4 S5) [ 0.308019] ACPI: Using IOAPIC for interrupt routing [ 0.310176] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.314478] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.325321] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.327050] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.331020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.335081] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.340153] acpiphp: Slot [2] registered [ 0.341164] acpiphp: Slot [5] registered [ 0.343184] acpiphp: Slot [6] registered [ 0.345134] acpiphp: Slot [3] registered [ 0.346109] acpiphp: Slot [4] registered [ 0.348106] acpiphp: Slot [7] registered [ 0.350141] acpiphp: Slot [8] registered [ 0.351111] acpiphp: Slot [9] registered [ 0.353119] acpiphp: Slot [10] registered [ 0.355146] acpiphp: Slot [11] registered [ 0.357132] acpiphp: Slot [12] registered [ 0.358136] acpiphp: Slot [13] registered [ 0.359163] acpiphp: Slot [14] registered [ 0.361181] acpiphp: Slot [15] registered [ 0.363120] acpiphp: Slot [16] registered [ 0.365151] acpiphp: Slot [17] registered [ 0.366127] acpiphp: Slot [18] registered [ 0.367124] acpiphp: Slot [19] registered [ 0.369188] acpiphp: Slot [20] registered [ 0.371170] acpiphp: Slot [21] registered [ 0.373193] acpiphp: Slot [22] registered [ 0.375159] acpiphp: Slot [23] registered [ 0.376193] acpiphp: Slot [24] registered [ 0.378126] acpiphp: Slot [25] registered [ 0.380151] acpiphp: Slot [26] registered [ 0.381250] acpiphp: Slot [27] registered [ 0.383186] acpiphp: Slot [28] registered [ 0.385144] acpiphp: Slot [29] registered [ 0.386118] acpiphp: Slot [30] registered [ 0.388237] acpiphp: Slot [31] registered [ 0.390060] PCI host bridge to bus 0000:00 [ 0.391024] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.394023] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.396021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.398021] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.402025] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.405026] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.406167] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.409843] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.413292] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.421000] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.425121] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.428022] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.430017] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.432030] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.435568] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.438918] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.442045] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.444983] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.450017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.459000] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.464021] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.471000] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.478020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.486020] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.505025] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.514853] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.520017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.528018] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.552012] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.564343] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.566458] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.569385] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.571421] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.573230] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.578141] iommu: Default domain type: Passthrough [ 0.579410] SCSI subsystem initialized [ 0.581075] ACPI: bus type USB registered [ 0.582120] usbcore: registered new interface driver usbfs [ 0.584069] usbcore: registered new interface driver hub [ 0.586084] usbcore: registered new device driver usb [ 0.587184] pps_core: LinuxPPS API ver. 1 registered [ 0.589021] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.592087] PTP clock support registered [ 0.595118] EDAC MC: Ver: 3.0.0 [ 0.598158] PCI: Using ACPI for IRQ routing [ 0.599651] NetLabel: Initializing [ 0.601010] NetLabel: domain hash size = 128 [ 0.602010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.605151] NetLabel: unlabeled traffic allowed by default [ 0.607154] vgaarb: loaded [ 0.608328] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.610017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.616367] clocksource: Switched to clocksource kvm-clock [ 0.724701] VFS: Disk quotas dquot_6.6.0 [ 0.726355] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.729642] *** VALIDATE ramfs *** [ 0.731062] *** VALIDATE hugetlbfs *** [ 0.732739] pnp: PnP ACPI init [ 0.735196] pnp: PnP ACPI: found 6 devices [ 0.753799] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.757214] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.759613] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.761936] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.764537] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.767248] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.771525] NET: Registered protocol family 2 [ 0.774462] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.779744] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.783110] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.788554] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.792262] TCP: Hash tables configured (established 65536 bind 65536) [ 0.794752] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.797897] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.800183] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.803117] NET: Registered protocol family 1 [ 0.806643] RPC: Registered named UNIX socket transport module. [ 0.809059] RPC: Registered udp transport module. [ 0.810984] RPC: Registered tcp transport module. [ 0.812865] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.815468] NET: Registered protocol family 44 [ 0.817360] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.819962] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.822313] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.824869] PCI: CLS 0 bytes, default 64 [ 0.826801] Unpacking initramfs... [ 2.332853] debug: unmapping init [mem 0xffff93ec7cc64000-0xffff93ec7ffcffff] [ 2.337117] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.339928] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.343321] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.845201] Initialise system trusted keyrings [ 2.847102] Key type blacklist registered [ 2.849229] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.859186] zbud: loaded [ 2.862858] *** VALIDATE nfs *** [ 2.864272] *** VALIDATE nfs4 *** [ 2.865990] pstore: using deflate compression [ 2.869534] Platform Keyring initialized [ 2.976977] NET: Registered protocol family 38 [ 2.979091] Key type asymmetric registered [ 2.981537] Asymmetric key parser 'x509' registered [ 2.983676] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.987683] io scheduler mq-deadline registered [ 2.989596] io scheduler kyber registered [ 2.991205] io scheduler bfq registered [ 2.992939] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.996486] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.999717] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.003390] ACPI: Power Button [PWRF] [ 3.008548] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.013980] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.024254] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.052831] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.105509] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.125665] Non-volatile memory driver v1.3 [ 3.127218] Linux agpgart interface v0.103 [ 3.164188] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 3.168764] vda: detected capacity change from 0 to 73097216 [ 3.185816] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.188931] vdb: detected capacity change from 0 to 1073741824 [ 3.195242] libphy: Fixed MDIO Bus: probed [ 3.200357] usbcore: registered new interface driver usbserial_generic [ 3.203162] usbserial: USB Serial support registered for generic [ 3.205805] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.210514] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.212537] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.215677] mousedev: PS/2 mouse device common for all mice [ 3.219390] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.219645] rtc_cmos 00:05: RTC can wake from S4 [ 3.226513] rtc_cmos 00:05: registered as rtc0 [ 3.228637] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.232405] intel_pstate: CPU model not supported [ 3.234420] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.239638] hid: raw HID events driver (C) Jiri Kosina [ 3.242287] usbcore: registered new interface driver usbhid [ 3.244847] usbhid: USB HID core driver [ 3.246751] drop_monitor: Initializing network drop monitor service [ 3.247063] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.251618] Initializing XFRM netlink socket [ 3.257164] NET: Registered protocol family 10 [ 3.260041] Segment Routing with IPv6 [ 3.262121] NET: Registered protocol family 17 [ 3.264399] mpls_gso: MPLS GSO support [ 3.270730] RAS: Correctable Errors collector initialized. [ 3.272824] AVX version of gcm_enc/dec engaged. [ 3.274767] AES CTR mode by8 optimization enabled [ 3.351188] sched_clock: Marking stable (3351158115, 0)->(4275493395, -924335280) [ 3.354857] registered taskstats version 1 [ 3.357027] Loading compiled-in X.509 certificates [ 3.359309] zswap: loaded using pool lzo/zbud [ 3.381833] Key type big_key registered [ 3.393542] Key type encrypted registered [ 3.395225] ima: No TPM chip found, activating TPM-bypass! [ 3.397448] ima: Allocated hash algorithm: sha1 [ 3.399121] ima: No architecture policies found [ 3.400892] evm: Initialising EVM extended attributes: [ 3.402543] evm: security.selinux [ 3.403976] evm: security.ima [ 3.405008] evm: security.capability [ 3.406411] evm: HMAC attrs: 0x1 [ 3.409381] rtc_cmos 00:05: setting system clock to 2026-09-10 16:31:22 UTC (1789057882) [ 3.415847] debug: unmapping init [mem 0xffffffff86a03000-0xffffffff86bfffff] [ 3.418524] debug: unmapping init [mem 0xffffffff85782000-0xffffffff85a58fff] [ 3.429094] Write protecting the kernel read-only data: 28672k [ 3.432705] debug: unmapping init [mem 0xffffffff83e03000-0xffffffff83ffffff] [ 3.435194] debug: unmapping init [mem 0xffffffff84714000-0xffffffff847fffff] [ 3.475398] 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.483563] systemd[1]: Detected virtualization kvm. [ 3.487649] systemd[1]: Detected architecture x86-64. [ 3.490174] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.517654] systemd[1]: No hostname configured. [ 3.519044] systemd[1]: Set hostname to . [ 3.521176] random: systemd: uninitialized urandom read (16 bytes read) [ 3.524036] systemd[1]: Initializing machine ID from random generator. [ 3.567576] random: ln: uninitialized urandom read (6 bytes read) [ 3.657828] random: systemd: uninitialized urandom read (16 bytes read) [ 3.661201] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.665555] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.670430] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... Starting Apply Kernel Variables... [ OK ] Reached target Sockets. [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... Starting Create Volatile Files and Directories... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.317656] device-mapper: uevent: version 1.0.3 [ 4.319915] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ 4.955025] virtio_net virtio0 ens2: renamed from eth0 [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.978615] scsi host0: ata_piix [ 5.012258] scsi host1: ata_piix [ 5.014226] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.017424] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.742120] dracut-initqueue[580]: RTNETLINK answers: File exists [ 9.913313] random: crng init done [ 9.914788] 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.336438] 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 Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Timers. [ 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 udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.507736] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.788147] SELinux: Disabled at runtime. [ 11.850593] 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.858465] systemd[1]: Detected virtualization kvm. [ 11.860634] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.359862] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.364152] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.369709] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.372694] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.375313] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.384307] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.388722] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on udev Control Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... Activating swap /dev/disk/by-label/SWAP... Mounting POSIX Message Queue File System... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-getty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Huge Pages File System... [ OK ] Reached target rpc_pipefs.target. [ 12.491195] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on Process Core Dump Socket. Starting udev Coldplug all Devices... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd File Systems. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... 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 /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.902936] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.305835] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.325463] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.462531] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.474496] EDAC sbridge: Ver: 1.1.2 [ 14.626101] Key type dns_resolver registered [ 14.930912] NFS: Registering the id_resolver key type [ 14.933136] Key type id_resolver registered [ 14.935091] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ 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... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started Login Service. 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 Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ 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 System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started 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 Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg325-client login: [ 42.269629] libcfs: loading out-of-tree module taints kernel. [ 42.297834] Key type ._llcrypt registered [ 42.303106] Key type .llcrypt registered [ 42.518421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 42.527921] alg: No test for adler32 (adler32-zlib) [ 43.568707] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 43.941726] LNet: Added LNI 192.168.203.25@tcp [8/256/0/180] [ 45.584141] Key type lgssc registered [ 46.369818] Lustre: Echo OBD driver; http://www.lustre.org/ [ 50.355339] alg: No test for zstdfast (zstdfast-lustre-generic) [ 50.368673] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 175.164805] Lustre: Mounted lustre-client [ 180.087399] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 189.980280] hrtimer: interrupt took 3269815 ns [ 191.475968] Lustre: DEBUG MARKER: oleg325-client.virtnet: executing check_logdir /tmp/testlogs/ [ 196.685482] Lustre: DEBUG MARKER: oleg325-client.virtnet: executing yml_node [ 200.677274] Lustre: lustre-OST0000-osc-ffff93ecc6909800: disconnect after 23s idle [ 200.832395] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 203.413959] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 205.960382] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 207.448966] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:34:45 EDT 2026 [ 225.718733] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 227.325236] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 228.887544] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a 130b 130c 130d 130e 130f 130g [ 230.791315] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51b 51c 51e 834 [ 232.257500] Lustre: DEBUG MARKER: === sanity: start setup 12:35:10 (1789058110) === [ 236.366707] Lustre: DEBUG MARKER: oleg325-client.virtnet: executing check_config_client /mnt/lustre [ 259.245583] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 272.201426] Lustre: DEBUG MARKER: === sanity: finish setup 12:35:49 (1789058149) === [ 280.855425] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:35:58 (1789058158) [ 281.476322] lustre_kcompr_29854: ***** [ 281.478518] lustre_kcompr_29854: (de)compression test on random binary data [ 281.482286] lustre_kcompr_29854: ***** [ 281.496758] lustre_kcompr_29854: compr lz4(1) in 64kB chunks took 3578 us (1117 MB/s), compress ratio: 95.99 [ 281.503493] lustre_kcompr_29854: compr lz4(1) in 128kB chunks took 2055 us (1946 MB/s), compress ratio: 101.23 [ 281.510054] lustre_kcompr_29854: compr lz4(1) in 256kB chunks took 1860 us (2150 MB/s), compress ratio: 104.00 [ 281.516902] lustre_kcompr_29854: compr lz4(1) in 512kB chunks took 1915 us (2088 MB/s), compress ratio: 105.59 [ 281.523720] lustre_kcompr_29854: compr lz4(1) in 1024kB chunks took 1833 us (2182 MB/s), compress ratio: 106.16 [ 281.530262] lustre_kcompr_29854: compr lz4(1) in 2048kB chunks took 1698 us (2355 MB/s), compress ratio: 106.51 [ 281.537467] lustre_kcompr_29854: compr lz4(1) in 4096kB chunks took 1999 us (2001 MB/s), compress ratio: 106.65 [ 281.549501] lustre_kcompr_29854: decompr lz4(1) took 1805 us (20 MB/s) [ 281.553569] lustre_kcompr_29854: test_comp_compress_decompress(lz4,1) ret 0 [ 281.557893] lustre_kcompr_29854: acompr lz4(1) of 128kB chunks took 97 us (1288 MB/s), compress ratio: 97.52 [ 281.562969] lustre_kcompr_29854: adecompr lz4(1) took 126 us (10 MB/s) [ 281.568458] lustre_kcompr_29854: test_acomp_compress_decompress(lz4,1) ret 0 [ 281.581290] lustre_kcompr_29854: compr lz4(4) in 64kB chunks took 1763 us (2268 MB/s), compress ratio: 82.26 [ 281.588576] lustre_kcompr_29854: compr lz4(4) in 128kB chunks took 2195 us (1822 MB/s), compress ratio: 92.31 [ 281.595209] lustre_kcompr_29854: compr lz4(4) in 256kB chunks took 1658 us (2412 MB/s), compress ratio: 98.63 [ 281.601426] lustre_kcompr_29854: compr lz4(4) in 512kB chunks took 1575 us (2539 MB/s), compress ratio: 101.81 [ 281.607259] lustre_kcompr_29854: compr lz4(4) in 1024kB chunks took 1553 us (2575 MB/s), compress ratio: 103.21 [ 281.613295] lustre_kcompr_29854: compr lz4(4) in 2048kB chunks took 1459 us (2741 MB/s), compress ratio: 104.57 [ 281.619351] lustre_kcompr_29854: compr lz4(4) in 4096kB chunks took 1766 us (2265 MB/s), compress ratio: 104.87 [ 281.645106] lustre_kcompr_29854: decompr lz4(4) took 5798 us (6 MB/s) [ 281.648911] lustre_kcompr_29854: test_comp_compress_decompress(lz4,4) ret 0 [ 281.669842] lustre_kcompr_29854: acompr lz4(4) of 128kB chunks took 100 us (1250 MB/s), compress ratio: 86.00 [ 281.678897] lustre_kcompr_29854: adecompr lz4(4) took 134 us (10 MB/s) [ 281.685316] lustre_kcompr_29854: test_acomp_compress_decompress(lz4,4) ret 0 [ 281.705811] lustre_kcompr_29854: compr lz4(9) in 64kB chunks took 2381 us (1679 MB/s), compress ratio: 61.52 [ 281.721813] lustre_kcompr_29854: compr lz4(9) in 128kB chunks took 7084 us (564 MB/s), compress ratio: 75.97 [ 281.739723] lustre_kcompr_29854: compr lz4(9) in 256kB chunks took 2237 us (1788 MB/s), compress ratio: 87.07 [ 281.754218] lustre_kcompr_29854: compr lz4(9) in 512kB chunks took 8655 us (462 MB/s), compress ratio: 93.93 [ 281.762351] lustre_kcompr_29854: compr lz4(9) in 1024kB chunks took 1416 us (2824 MB/s), compress ratio: 97.33 [ 281.780404] lustre_kcompr_29854: compr lz4(9) in 2048kB chunks took 3288 us (1216 MB/s), compress ratio: 98.75 [ 281.805948] lustre_kcompr_29854: compr lz4(9) in 4096kB chunks took 8078 us (495 MB/s), compress ratio: 99.96 [ 281.828754] lustre_kcompr_29854: decompr lz4(9) took 4653 us (8 MB/s) [ 281.833567] lustre_kcompr_29854: test_comp_compress_decompress(lz4,9) ret 0 [ 281.840297] lustre_kcompr_29854: acompr lz4(9) of 128kB chunks took 97 us (1288 MB/s), compress ratio: 72.65 [ 281.852337] lustre_kcompr_29854: adecompr lz4(9) took 123 us (13 MB/s) [ 281.861446] lustre_kcompr_29854: test_acomp_compress_decompress(lz4,9) ret 0 [ 281.875288] lustre_kcompr_29854: compr lz4(15) in 64kB chunks took 2822 us (1417 MB/s), compress ratio: 29.42 [ 281.889812] lustre_kcompr_29854: compr lz4(15) in 128kB chunks took 8195 us (488 MB/s), compress ratio: 43.86 [ 281.898541] lustre_kcompr_29854: compr lz4(15) in 256kB chunks took 2651 us (1508 MB/s), compress ratio: 58.94 [ 281.916331] lustre_kcompr_29854: compr lz4(15) in 512kB chunks took 8484 us (471 MB/s), compress ratio: 71.01 [ 281.924598] lustre_kcompr_29854: compr lz4(15) in 1024kB chunks took 2004 us (1996 MB/s), compress ratio: 78.96 [ 281.933309] lustre_kcompr_29854: compr lz4(15) in 2048kB chunks took 3119 us (1282 MB/s), compress ratio: 83.79 [ 281.946915] lustre_kcompr_29854: compr lz4(15) in 4096kB chunks took 4755 us (841 MB/s), compress ratio: 86.73 [ 281.979563] lustre_kcompr_29854: decompr lz4(15) took 2211 us (20 MB/s) [ 281.989050] lustre_kcompr_29854: test_comp_compress_decompress(lz4,15) ret 0 [ 281.999391] lustre_kcompr_29854: acompr lz4(15) of 128kB chunks took 109 us (1146 MB/s), compress ratio: 40.50 [ 282.006487] lustre_kcompr_29854: adecompr lz4(15) took 121 us (25 MB/s) [ 282.023586] lustre_kcompr_29854: test_acomp_compress_decompress(lz4,15) ret 0 [ 282.082170] lustre_kcompr_29854: compr lz4hc(1) in 64kB chunks took 26637 us (150 MB/s), compress ratio: 96.80 [ 282.139979] lustre_kcompr_29854: compr lz4hc(1) in 128kB chunks took 51269 us (78 MB/s), compress ratio: 102.64 [ 282.174072] lustre_kcompr_29854: compr lz4hc(1) in 256kB chunks took 25638 us (156 MB/s), compress ratio: 105.82 [ 282.212906] lustre_kcompr_29854: compr lz4hc(1) in 512kB chunks took 33705 us (118 MB/s), compress ratio: 107.48 [ 282.233034] lustre_kcompr_29854: compr lz4hc(1) in 1024kB chunks took 15695 us (254 MB/s), compress ratio: 108.33 [ 282.329801] lustre_kcompr_29854: compr lz4hc(1) in 2048kB chunks took 92471 us (43 MB/s), compress ratio: 108.76 [ 282.429636] lustre_kcompr_29854: compr lz4hc(1) in 4096kB chunks took 89370 us (44 MB/s), compress ratio: 108.98 [ 282.450693] lustre_kcompr_29854: decompr lz4hc(1) took 2474 us (14 MB/s) [ 282.458867] lustre_kcompr_29854: test_comp_compress_decompress(lz4hc,1) ret 0 [ 282.467844] lustre_kcompr_29854: acompr lz4hc(1) of 128kB chunks took 2015 us (62 MB/s), compress ratio: 96.16 [ 282.480530] lustre_kcompr_29854: adecompr lz4hc(1) took 173 us (7 MB/s) [ 282.489890] lustre_kcompr_29854: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 282.590183] lustre_kcompr_29854: compr lz4hc(3) in 64kB chunks took 75561 us (52 MB/s), compress ratio: 97.31 [ 282.666670] lustre_kcompr_29854: compr lz4hc(3) in 128kB chunks took 44044 us (90 MB/s), compress ratio: 103.20 [ 282.723732] lustre_kcompr_29854: compr lz4hc(3) in 256kB chunks took 52176 us (76 MB/s), compress ratio: 106.39 [ 282.786667] lustre_kcompr_29854: compr lz4hc(3) in 512kB chunks took 51701 us (77 MB/s), compress ratio: 108.05 [ 282.839872] lustre_kcompr_29854: compr lz4hc(3) in 1024kB chunks took 49327 us (81 MB/s), compress ratio: 108.90 [ 282.880783] lustre_kcompr_29854: compr lz4hc(3) in 2048kB chunks took 36958 us (108 MB/s), compress ratio: 109.33 [ 282.984346] lustre_kcompr_29854: compr lz4hc(3) in 4096kB chunks took 98511 us (40 MB/s), compress ratio: 109.55 [ 283.003034] lustre_kcompr_29854: decompr lz4hc(3) took 1806 us (20 MB/s) [ 283.008690] lustre_kcompr_29854: test_comp_compress_decompress(lz4hc,3) ret 0 [ 283.021059] lustre_kcompr_29854: acompr lz4hc(3) of 128kB chunks took 4105 us (30 MB/s), compress ratio: 96.44 [ 283.028263] lustre_kcompr_29854: adecompr lz4hc(3) took 222 us (5 MB/s) [ 283.040966] lustre_kcompr_29854: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 283.682540] lustre_kcompr_29854: compr lz4hc(8) in 64kB chunks took 605332 us (6 MB/s), compress ratio: 103.85 [ 284.364779] lustre_kcompr_29854: compr lz4hc(8) in 128kB chunks took 675858 us (5 MB/s), compress ratio: 110.91 [ 284.953666] lustre_kcompr_29854: compr lz4hc(8) in 256kB chunks took 570829 us (7 MB/s), compress ratio: 114.77 [ 285.933247] lustre_kcompr_29854: compr lz4hc(8) in 512kB chunks took 971858 us (4 MB/s), compress ratio: 116.80 [ 286.934258] lustre_kcompr_29854: compr lz4hc(8) in 1024kB chunks took 991554 us (4 MB/s), compress ratio: 117.82 [ 288.180139] lustre_kcompr_29854: compr lz4hc(8) in 2048kB chunks took 1228968 us (3 MB/s), compress ratio: 118.35 [ 289.423703] lustre_kcompr_29854: compr lz4hc(8) in 4096kB chunks took 1223557 us (3 MB/s), compress ratio: 118.62 [ 289.447534] lustre_kcompr_29854: decompr lz4hc(8) took 2479 us (13 MB/s) [ 289.453855] lustre_kcompr_29854: test_comp_compress_decompress(lz4hc,8) ret 0 [ 289.503392] lustre_kcompr_29854: acompr lz4hc(8) of 128kB chunks took 37946 us (3 MB/s), compress ratio: 104.43 [ 289.517758] lustre_kcompr_29854: adecompr lz4hc(8) took 132 us (9 MB/s) [ 289.564801] lustre_kcompr_29854: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 290.999930] lustre_kcompr_29854: compr lz4hc(15) in 64kB chunks took 1401080 us (2 MB/s), compress ratio: 104.41 [ 292.250612] lustre_kcompr_29854: compr lz4hc(15) in 128kB chunks took 1245676 us (3 MB/s), compress ratio: 111.88 [ 292.832669] Lustre: lustre-OST0000-osc-ffff93ecc6909800: disconnect after 20s idle [ 292.842049] Lustre: Skipped 1 previous similar message [ 293.493199] lustre_kcompr_29854: compr lz4hc(15) in 256kB chunks took 1235689 us (3 MB/s), compress ratio: 116.02 [ 294.818985] lustre_kcompr_29854: compr lz4hc(15) in 512kB chunks took 1318097 us (3 MB/s), compress ratio: 118.21 [ 296.114972] lustre_kcompr_29854: compr lz4hc(15) in 1024kB chunks took 1288863 us (3 MB/s), compress ratio: 119.31 [ 297.443112] lustre_kcompr_29854: compr lz4hc(15) in 2048kB chunks took 1313159 us (3 MB/s), compress ratio: 119.88 [ 298.610310] lustre_kcompr_29854: compr lz4hc(15) in 4096kB chunks took 1153979 us (3 MB/s), compress ratio: 120.20 [ 298.624399] lustre_kcompr_29854: decompr lz4hc(15) took 3049 us (10 MB/s) [ 298.629268] lustre_kcompr_29854: test_comp_compress_decompress(lz4hc,15) ret 0 [ 298.656773] lustre_kcompr_29854: acompr lz4hc(15) of 128kB chunks took 22061 us (5 MB/s), compress ratio: 105.70 [ 298.669830] lustre_kcompr_29854: adecompr lz4hc(15) took 114 us (10 MB/s) [ 298.689113] lustre_kcompr_29854: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 298.699284] lustre_kcompr_29854: compr lzo(-1) in 64kB chunks took 2978 us (1343 MB/s), compress ratio: 81.19 [ 298.716703] lustre_kcompr_29854: compr lzo(-1) in 128kB chunks took 6322 us (632 MB/s), compress ratio: 86.06 [ 298.734797] lustre_kcompr_29854: compr lzo(-1) in 256kB chunks took 10142 us (394 MB/s), compress ratio: 86.24 [ 298.749787] lustre_kcompr_29854: compr lzo(-1) in 512kB chunks took 5188 us (771 MB/s), compress ratio: 86.83 [ 298.765280] lustre_kcompr_29854: compr lzo(-1) in 1024kB chunks took 6664 us (600 MB/s), compress ratio: 86.68 [ 298.778731] lustre_kcompr_29854: compr lzo(-1) in 2048kB chunks took 3923 us (1019 MB/s), compress ratio: 86.60 [ 298.786337] lustre_kcompr_29854: compr lzo(-1) in 4096kB chunks took 2292 us (1745 MB/s), compress ratio: 87.18 [ 298.797185] lustre_kcompr_29854: decompr lzo(-1) took 1893 us (24 MB/s) [ 298.804904] lustre_kcompr_29854: test_comp_compress_decompress(lzo,-1) ret 0 [ 298.809782] lustre_kcompr_29854: acompr lzo(-1) of 128kB chunks took 118 us (1059 MB/s), compress ratio: 83.32 [ 298.817384] lustre_kcompr_29854: adecompr lzo(-1) took 211 us (7 MB/s) [ 298.828310] lustre_kcompr_29854: test_acomp_compress_decompress(lzo,-1) ret 0 [ 299.266640] lustre_kcompr_29854: compr deflate(1) in 64kB chunks took 426234 us (9 MB/s), compress ratio: 97.24 [ 299.788394] lustre_kcompr_29854: compr deflate(1) in 128kB chunks took 512626 us (7 MB/s), compress ratio: 107.42 [ 300.279257] lustre_kcompr_29854: compr deflate(1) in 256kB chunks took 476698 us (8 MB/s), compress ratio: 113.81 [ 300.751191] lustre_kcompr_29854: compr deflate(1) in 512kB chunks took 464672 us (8 MB/s), compress ratio: 117.53 [ 301.208465] lustre_kcompr_29854: compr deflate(1) in 1024kB chunks took 438803 us (9 MB/s), compress ratio: 119.38 [ 301.673801] lustre_kcompr_29854: compr deflate(1) in 2048kB chunks took 458736 us (8 MB/s), compress ratio: 120.33 [ 302.181797] lustre_kcompr_29854: compr deflate(1) in 4096kB chunks took 501517 us (7 MB/s), compress ratio: 120.62 [ 302.211831] lustre_kcompr_29854: decompr deflate(1) took 10154 us (3 MB/s) [ 302.232854] lustre_kcompr_29854: test_comp_compress_decompress(deflate,1) ret 0 [ 302.262147] lustre_kcompr_29854: acompr deflate(1) of 128kB chunks took 14395 us (8 MB/s), compress ratio: 101.21 [ 302.268430] lustre_kcompr_29854: adecompr deflate(1) took 349 us (3 MB/s) [ 302.280453] lustre_kcompr_29854: test_acomp_compress_decompress(deflate,1) ret 0 [ 302.676828] lustre_kcompr_29854: compr deflate(6) in 64kB chunks took 379969 us (10 MB/s), compress ratio: 97.24 [ 303.107329] lustre_kcompr_29854: compr deflate(6) in 128kB chunks took 420723 us (9 MB/s), compress ratio: 107.42 [ 303.576635] lustre_kcompr_29854: compr deflate(6) in 256kB chunks took 464092 us (8 MB/s), compress ratio: 113.81 [ 303.986605] lustre_kcompr_29854: compr deflate(6) in 512kB chunks took 395963 us (10 MB/s), compress ratio: 117.53 [ 304.564675] lustre_kcompr_29854: compr deflate(6) in 1024kB chunks took 565093 us (7 MB/s), compress ratio: 119.38 [ 305.080321] lustre_kcompr_29854: compr deflate(6) in 2048kB chunks took 500963 us (7 MB/s), compress ratio: 120.33 [ 305.449527] lustre_kcompr_29854: compr deflate(6) in 4096kB chunks took 362211 us (11 MB/s), compress ratio: 120.62 [ 305.473776] lustre_kcompr_29854: decompr deflate(6) took 6968 us (4 MB/s) [ 305.486554] lustre_kcompr_29854: test_comp_compress_decompress(deflate,6) ret 0 [ 305.512824] lustre_kcompr_29854: acompr deflate(6) of 128kB chunks took 18900 us (6 MB/s), compress ratio: 101.21 [ 305.519408] lustre_kcompr_29854: adecompr deflate(6) took 390 us (3 MB/s) [ 305.532668] lustre_kcompr_29854: test_acomp_compress_decompress(deflate,6) ret 0 [ 306.030316] lustre_kcompr_29854: compr deflate(9) in 64kB chunks took 463377 us (8 MB/s), compress ratio: 97.24 [ 306.501901] lustre_kcompr_29854: compr deflate(9) in 128kB chunks took 462250 us (8 MB/s), compress ratio: 107.42 [ 306.982303] lustre_kcompr_29854: compr deflate(9) in 256kB chunks took 462675 us (8 MB/s), compress ratio: 113.81 [ 307.386540] lustre_kcompr_29854: compr deflate(9) in 512kB chunks took 394639 us (10 MB/s), compress ratio: 117.53 [ 307.932223] lustre_kcompr_29854: compr deflate(9) in 1024kB chunks took 538916 us (7 MB/s), compress ratio: 119.38 [ 308.332741] lustre_kcompr_29854: compr deflate(9) in 2048kB chunks took 383483 us (10 MB/s), compress ratio: 120.33 [ 308.742098] lustre_kcompr_29854: compr deflate(9) in 4096kB chunks took 402495 us (9 MB/s), compress ratio: 120.62 [ 308.759762] lustre_kcompr_29854: decompr deflate(9) took 5478 us (6 MB/s) [ 308.765510] lustre_kcompr_29854: test_comp_compress_decompress(deflate,9) ret 0 [ 308.781386] lustre_kcompr_29854: acompr deflate(9) of 128kB chunks took 8939 us (13 MB/s), compress ratio: 101.21 [ 308.787866] lustre_kcompr_29854: adecompr deflate(9) took 194 us (6 MB/s) [ 308.796493] lustre_kcompr_29854: test_acomp_compress_decompress(deflate,9) ret 0 [ 308.824929] lustre_kcompr_29854: compr zstd(0) in 64kB chunks took 12364 us (323 MB/s), compress ratio: 157.53 [ 308.867764] lustre_kcompr_29854: compr zstd(0) in 128kB chunks took 36094 us (110 MB/s), compress ratio: 190.24 [ 308.898654] lustre_kcompr_29854: compr zstd(0) in 256kB chunks took 20204 us (197 MB/s), compress ratio: 200.88 [ 308.949141] lustre_kcompr_29854: compr zstd(0) in 512kB chunks took 44900 us (89 MB/s), compress ratio: 206.68 [ 308.966703] lustre_kcompr_29854: compr zstd(0) in 1024kB chunks took 7447 us (537 MB/s), compress ratio: 208.94 [ 308.977260] lustre_kcompr_29854: compr zstd(0) in 2048kB chunks took 5303 us (754 MB/s), compress ratio: 212.01 [ 308.990507] lustre_kcompr_29854: compr zstd(0) in 4096kB chunks took 5812 us (688 MB/s), compress ratio: 212.20 [ 309.023741] lustre_kcompr_29854: decompr zstd(0) took 2336 us (8 MB/s) [ 309.031271] lustre_kcompr_29854: test_comp_compress_decompress(zstd,0) ret 0 [ 309.038557] lustre_kcompr_29854: acompr zstd(0) of 128kB chunks took 447 us (279 MB/s), compress ratio: 175.22 [ 309.044491] lustre_kcompr_29854: adecompr zstd(0) took 269 us (2 MB/s) [ 309.058502] lustre_kcompr_29854: test_acomp_compress_decompress(zstd,0) ret 0 [ 309.084986] lustre_kcompr_29854: compr zstd(1) in 64kB chunks took 2889 us (1384 MB/s), compress ratio: 156.50 [ 309.095855] lustre_kcompr_29854: compr zstd(1) in 128kB chunks took 3899 us (1025 MB/s), compress ratio: 187.39 [ 309.105248] lustre_kcompr_29854: compr zstd(1) in 256kB chunks took 4704 us (850 MB/s), compress ratio: 199.41 [ 309.113179] lustre_kcompr_29854: compr zstd(1) in 512kB chunks took 2068 us (1934 MB/s), compress ratio: 206.09 [ 309.125510] lustre_kcompr_29854: compr zstd(1) in 1024kB chunks took 6857 us (583 MB/s), compress ratio: 207.55 [ 309.139218] lustre_kcompr_29854: compr zstd(1) in 2048kB chunks took 2571 us (1555 MB/s), compress ratio: 209.17 [ 309.161331] lustre_kcompr_29854: compr zstd(1) in 4096kB chunks took 11114 us (359 MB/s), compress ratio: 209.33 [ 309.182868] lustre_kcompr_29854: decompr zstd(1) took 2541 us (7 MB/s) [ 309.188261] lustre_kcompr_29854: test_comp_compress_decompress(zstd,1) ret 0 [ 309.196681] lustre_kcompr_29854: acompr zstd(1) of 128kB chunks took 267 us (468 MB/s), compress ratio: 175.22 [ 309.203219] lustre_kcompr_29854: adecompr zstd(1) took 142 us (5 MB/s) [ 309.209772] lustre_kcompr_29854: test_acomp_compress_decompress(zstd,1) ret 0 [ 309.448314] lustre_kcompr_29854: compr zstd(10) in 64kB chunks took 213608 us (18 MB/s), compress ratio: 159.53 [ 309.619312] lustre_kcompr_29854: compr zstd(10) in 128kB chunks took 164615 us (24 MB/s), compress ratio: 181.79 [ 309.826244] lustre_kcompr_29854: compr zstd(10) in 256kB chunks took 194188 us (20 MB/s), compress ratio: 193.21 [ 309.970449] lustre_kcompr_29854: compr zstd(10) in 512kB chunks took 138923 us (28 MB/s), compress ratio: 214.15 [ 310.206957] lustre_kcompr_29854: compr zstd(10) in 1024kB chunks took 232224 us (17 MB/s), compress ratio: 218.48 [ 310.606806] lustre_kcompr_29854: compr zstd(10) in 2048kB chunks took 393825 us (10 MB/s), compress ratio: 220.59 [ 310.723432] lustre_kcompr_29854: compr zstd(10) in 4096kB chunks took 108791 us (36 MB/s), compress ratio: 221.80 [ 310.746027] lustre_kcompr_29854: decompr zstd(10) took 3063 us (5 MB/s) [ 310.760294] lustre_kcompr_29854: test_comp_compress_decompress(zstd,10) ret 0 [ 310.774808] lustre_kcompr_29854: acompr zstd(10) of 128kB chunks took 5502 us (22 MB/s), compress ratio: 164.87 [ 310.793162] lustre_kcompr_29854: adecompr zstd(10) took 341 us (2 MB/s) [ 310.806931] lustre_kcompr_29854: test_acomp_compress_decompress(zstd,10) ret 0 [ 311.924346] lustre_kcompr_29854: compr zstd(15) in 64kB chunks took 1095893 us (3 MB/s), compress ratio: 168.36 [ 312.833861] lustre_kcompr_29854: compr zstd(15) in 128kB chunks took 896470 us (4 MB/s), compress ratio: 192.93 [ 313.699915] lustre_kcompr_29854: compr zstd(15) in 256kB chunks took 857956 us (4 MB/s), compress ratio: 205.83 [ 314.206369] lustre_kcompr_29854: compr zstd(15) in 512kB chunks took 500942 us (7 MB/s), compress ratio: 213.87 [ 314.779564] lustre_kcompr_29854: compr zstd(15) in 1024kB chunks took 567012 us (7 MB/s), compress ratio: 216.07 [ 315.801855] lustre_kcompr_29854: compr zstd(15) in 2048kB chunks took 1016092 us (3 MB/s), compress ratio: 217.61 [ 317.006903] lustre_kcompr_29854: compr zstd(15) in 4096kB chunks took 1200026 us (3 MB/s), compress ratio: 217.71 [ 317.027937] lustre_kcompr_29854: decompr zstd(15) took 1965 us (9 MB/s) [ 317.033256] lustre_kcompr_29854: test_comp_compress_decompress(zstd,15) ret 0 [ 317.073348] lustre_kcompr_29854: acompr zstd(15) of 128kB chunks took 27290 us (4 MB/s), compress ratio: 173.83 [ 317.085900] lustre_kcompr_29854: adecompr zstd(15) took 772 us (0 MB/s) [ 317.103364] lustre_kcompr_29854: test_acomp_compress_decompress(zstd,15) ret 0 [ 317.122373] lustre_kcompr_29854: compr zstdfast(1) in 64kB chunks took 5030 us (795 MB/s), compress ratio: 156.50 [ 317.134304] lustre_kcompr_29854: compr zstdfast(1) in 128kB chunks took 4675 us (855 MB/s), compress ratio: 187.39 [ 317.147436] lustre_kcompr_29854: compr zstdfast(1) in 256kB chunks took 4906 us (815 MB/s), compress ratio: 199.44 [ 317.161595] lustre_kcompr_29854: compr zstdfast(1) in 512kB chunks took 4600 us (869 MB/s), compress ratio: 206.09 [ 317.175960] lustre_kcompr_29854: compr zstdfast(1) in 1024kB chunks took 2713 us (1474 MB/s), compress ratio: 207.55 [ 317.187636] lustre_kcompr_29854: compr zstdfast(1) in 2048kB chunks took 4396 us (909 MB/s), compress ratio: 209.17 [ 317.196782] lustre_kcompr_29854: compr zstdfast(1) in 4096kB chunks took 3426 us (1167 MB/s), compress ratio: 208.52 [ 317.224225] lustre_kcompr_29854: decompr zstdfast(1) took 2372 us (8 MB/s) [ 317.231824] lustre_kcompr_29854: test_comp_compress_decompress(zstdfast,1) ret 0 [ 317.238770] lustre_kcompr_29854: acompr zstdfast(1) of 128kB chunks took 149 us (838 MB/s), compress ratio: 175.22 [ 317.247112] lustre_kcompr_29854: adecompr zstdfast(1) took 117 us (6 MB/s) [ 317.254851] lustre_kcompr_29854: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 317.293482] lustre_kcompr_29854: compr zstdfast(5) in 64kB chunks took 4970 us (804 MB/s), compress ratio: 138.68 [ 317.304695] lustre_kcompr_29854: compr zstdfast(5) in 128kB chunks took 4318 us (926 MB/s), compress ratio: 163.29 [ 317.315858] lustre_kcompr_29854: compr zstdfast(5) in 256kB chunks took 4041 us (989 MB/s), compress ratio: 171.90 [ 317.326737] lustre_kcompr_29854: compr zstdfast(5) in 512kB chunks took 4064 us (984 MB/s), compress ratio: 176.87 [ 317.341100] lustre_kcompr_29854: compr zstdfast(5) in 1024kB chunks took 2116 us (1890 MB/s), compress ratio: 180.41 [ 317.353610] lustre_kcompr_29854: compr zstdfast(5) in 2048kB chunks took 5632 us (710 MB/s), compress ratio: 181.08 [ 317.373221] lustre_kcompr_29854: compr zstdfast(5) in 4096kB chunks took 5746 us (696 MB/s), compress ratio: 180.41 [ 317.398809] lustre_kcompr_29854: decompr zstdfast(5) took 2813 us (7 MB/s) [ 317.404776] lustre_kcompr_29854: test_comp_compress_decompress(zstdfast,5) ret 0 [ 317.410676] lustre_kcompr_29854: acompr zstdfast(5) of 128kB chunks took 141 us (886 MB/s), compress ratio: 152.94 [ 317.417652] lustre_kcompr_29854: adecompr zstdfast(5) took 169 us (4 MB/s) [ 317.424791] lustre_kcompr_29854: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 317.441953] lustre_kcompr_29854: compr zstdfast(12) in 64kB chunks took 5424 us (737 MB/s), compress ratio: 37.56 [ 317.451745] lustre_kcompr_29854: compr zstdfast(12) in 128kB chunks took 2368 us (1689 MB/s), compress ratio: 42.69 [ 317.461565] lustre_kcompr_29854: compr zstdfast(12) in 256kB chunks took 3354 us (1192 MB/s), compress ratio: 45.61 [ 317.472070] lustre_kcompr_29854: compr zstdfast(12) in 512kB chunks took 4372 us (914 MB/s), compress ratio: 49.80 [ 317.481911] lustre_kcompr_29854: compr zstdfast(12) in 1024kB chunks took 2612 us (1531 MB/s), compress ratio: 55.17 [ 317.489900] lustre_kcompr_29854: compr zstdfast(12) in 2048kB chunks took 2316 us (1727 MB/s), compress ratio: 59.24 [ 317.496284] lustre_kcompr_29854: compr zstdfast(12) in 4096kB chunks took 2136 us (1872 MB/s), compress ratio: 84.18 [ 317.520356] lustre_kcompr_29854: decompr zstdfast(12) took 4460 us (10 MB/s) [ 317.528945] lustre_kcompr_29854: test_comp_compress_decompress(zstdfast,12) ret 0 [ 317.539355] lustre_kcompr_29854: acompr zstdfast(12) of 128kB chunks took 161 us (776 MB/s), compress ratio: 55.02 [ 317.552598] lustre_kcompr_29854: adecompr zstdfast(12) took 162 us (14 MB/s) [ 317.582686] lustre_kcompr_29854: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 317.617534] lustre_kcompr_29854: compr zstdfast(15) in 64kB chunks took 2988 us (1338 MB/s), compress ratio: 18.77 [ 317.638157] lustre_kcompr_29854: compr zstdfast(15) in 128kB chunks took 8809 us (454 MB/s), compress ratio: 19.80 [ 317.651963] lustre_kcompr_29854: compr zstdfast(15) in 256kB chunks took 5643 us (708 MB/s), compress ratio: 20.63 [ 317.668709] lustre_kcompr_29854: compr zstdfast(15) in 512kB chunks took 2905 us (1376 MB/s), compress ratio: 20.91 [ 317.677595] lustre_kcompr_29854: compr zstdfast(15) in 1024kB chunks took 3511 us (1139 MB/s), compress ratio: 22.32 [ 317.685787] lustre_kcompr_29854: compr zstdfast(15) in 2048kB chunks took 2976 us (1344 MB/s), compress ratio: 24.97 [ 317.693546] lustre_kcompr_29854: compr zstdfast(15) in 4096kB chunks took 2891 us (1383 MB/s), compress ratio: 24.90 [ 317.707255] lustre_kcompr_29854: decompr zstdfast(15) took 2094 us (76 MB/s) [ 317.711916] lustre_kcompr_29854: test_comp_compress_decompress(zstdfast,15) ret 0 [ 317.716663] lustre_kcompr_29854: acompr zstdfast(15) of 128kB chunks took 429 us (291 MB/s), compress ratio: 16.58 [ 317.721684] lustre_kcompr_29854: adecompr zstdfast(15) took 130 us (57 MB/s) [ 317.731530] lustre_kcompr_29854: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 317.736767] lustre_kcompr_29854: SUCCESS [ 323.787707] lustre_kcompr_13249: ***** [ 323.791197] lustre_kcompr_13249: (de)compression test on provided file /tmp/f84.sanity [ 323.799290] lustre_kcompr_13249: ***** [ 323.835733] lustre_kcompr_13249: compr lz4(1) in 64kB chunks took 24029 us (166 MB/s), compress ratio: 2.93 [ 323.871807] lustre_kcompr_13249: compr lz4(1) in 128kB chunks took 26218 us (152 MB/s), compress ratio: 3.04 [ 323.913901] lustre_kcompr_13249: compr lz4(1) in 256kB chunks took 35852 us (111 MB/s), compress ratio: 3.08 [ 323.989842] lustre_kcompr_13249: compr lz4(1) in 512kB chunks took 66858 us (59 MB/s), compress ratio: 3.10 [ 324.046848] lustre_kcompr_13249: compr lz4(1) in 1024kB chunks took 39122 us (102 MB/s), compress ratio: 3.11 [ 324.091621] lustre_kcompr_13249: compr lz4(1) in 2048kB chunks took 35216 us (113 MB/s), compress ratio: 3.11 [ 324.122955] lustre_kcompr_13249: compr lz4(1) in 4096kB chunks took 24510 us (163 MB/s), compress ratio: 3.12 [ 324.147879] lustre_kcompr_13249: decompr lz4(1) took 9166 us (139 MB/s) [ 324.152967] lustre_kcompr_13249: test_comp_compress_decompress(lz4,1) ret 0 [ 324.159949] lustre_kcompr_13249: acompr lz4(1) of 128kB chunks took 797 us (156 MB/s), compress ratio: 2.68 [ 324.165534] lustre_kcompr_13249: adecompr lz4(1) took 359 us (129 MB/s) [ 324.175672] lustre_kcompr_13249: test_acomp_compress_decompress(lz4,1) ret 0 [ 324.212572] lustre_kcompr_13249: compr lz4(4) in 64kB chunks took 21812 us (183 MB/s), compress ratio: 2.67 [ 324.244870] lustre_kcompr_13249: compr lz4(4) in 128kB chunks took 25770 us (155 MB/s), compress ratio: 2.63 [ 324.278313] lustre_kcompr_13249: compr lz4(4) in 256kB chunks took 28611 us (139 MB/s), compress ratio: 2.68 [ 324.316399] lustre_kcompr_13249: compr lz4(4) in 512kB chunks took 26227 us (152 MB/s), compress ratio: 2.71 [ 324.354984] lustre_kcompr_13249: compr lz4(4) in 1024kB chunks took 28306 us (141 MB/s), compress ratio: 2.72 [ 324.389789] lustre_kcompr_13249: compr lz4(4) in 2048kB chunks took 28114 us (142 MB/s), compress ratio: 2.72 [ 324.413140] lustre_kcompr_13249: compr lz4(4) in 4096kB chunks took 18511 us (216 MB/s), compress ratio: 2.73 [ 324.432288] lustre_kcompr_13249: decompr lz4(4) took 6944 us (210 MB/s) [ 324.437107] lustre_kcompr_13249: test_comp_compress_decompress(lz4,4) ret 0 [ 324.442892] lustre_kcompr_13249: acompr lz4(4) of 128kB chunks took 647 us (193 MB/s), compress ratio: 2.30 [ 324.448532] lustre_kcompr_13249: adecompr lz4(4) took 263 us (206 MB/s) [ 324.454126] lustre_kcompr_13249: test_acomp_compress_decompress(lz4,4) ret 0 [ 324.486752] lustre_kcompr_13249: compr lz4(9) in 64kB chunks took 22012 us (181 MB/s), compress ratio: 2.30 [ 324.532020] lustre_kcompr_13249: compr lz4(9) in 128kB chunks took 32237 us (124 MB/s), compress ratio: 2.15 [ 324.559461] lustre_kcompr_13249: compr lz4(9) in 256kB chunks took 21871 us (182 MB/s), compress ratio: 2.20 [ 324.595262] lustre_kcompr_13249: compr lz4(9) in 512kB chunks took 27112 us (147 MB/s), compress ratio: 2.23 [ 324.621809] lustre_kcompr_13249: compr lz4(9) in 1024kB chunks took 21156 us (189 MB/s), compress ratio: 2.25 [ 324.646446] lustre_kcompr_13249: compr lz4(9) in 2048kB chunks took 19481 us (205 MB/s), compress ratio: 2.25 [ 324.687504] lustre_kcompr_13249: compr lz4(9) in 4096kB chunks took 35019 us (114 MB/s), compress ratio: 2.26 [ 324.723461] lustre_kcompr_13249: decompr lz4(9) took 11181 us (158 MB/s) [ 324.736462] lustre_kcompr_13249: test_comp_compress_decompress(lz4,9) ret 0 [ 324.744714] lustre_kcompr_13249: acompr lz4(9) of 128kB chunks took 1577 us (79 MB/s), compress ratio: 1.87 [ 324.754746] lustre_kcompr_13249: adecompr lz4(9) took 251 us (265 MB/s) [ 324.763501] lustre_kcompr_13249: test_acomp_compress_decompress(lz4,9) ret 0 [ 324.792027] lustre_kcompr_13249: compr lz4(15) in 64kB chunks took 13345 us (299 MB/s), compress ratio: 1.63 [ 324.817760] lustre_kcompr_13249: compr lz4(15) in 128kB chunks took 17556 us (227 MB/s), compress ratio: 1.52 [ 324.834299] lustre_kcompr_13249: compr lz4(15) in 256kB chunks took 12244 us (326 MB/s), compress ratio: 1.56 [ 324.862869] lustre_kcompr_13249: compr lz4(15) in 512kB chunks took 23872 us (167 MB/s), compress ratio: 1.58 [ 324.878272] lustre_kcompr_13249: compr lz4(15) in 1024kB chunks took 11046 us (362 MB/s), compress ratio: 1.60 [ 324.893906] lustre_kcompr_13249: compr lz4(15) in 2048kB chunks took 11295 us (354 MB/s), compress ratio: 1.60 [ 324.912944] lustre_kcompr_13249: compr lz4(15) in 4096kB chunks took 14575 us (274 MB/s), compress ratio: 1.60 [ 324.927485] lustre_kcompr_13249: decompr lz4(15) took 4143 us (600 MB/s) [ 324.931584] lustre_kcompr_13249: test_comp_compress_decompress(lz4,15) ret 0 [ 324.935244] lustre_kcompr_13249: acompr lz4(15) of 128kB chunks took 431 us (290 MB/s), compress ratio: 1.33 [ 324.944843] lustre_kcompr_13249: adecompr lz4(15) took 173 us (543 MB/s) [ 324.952605] lustre_kcompr_13249: test_acomp_compress_decompress(lz4,15) ret 0 [ 325.138996] lustre_kcompr_13249: compr lz4hc(1) in 64kB chunks took 166736 us (23 MB/s), compress ratio: 3.58 [ 325.302582] lustre_kcompr_13249: compr lz4hc(1) in 128kB chunks took 149253 us (26 MB/s), compress ratio: 3.77 [ 325.559229] lustre_kcompr_13249: compr lz4hc(1) in 256kB chunks took 249619 us (16 MB/s), compress ratio: 3.88 [ 325.759724] lustre_kcompr_13249: compr lz4hc(1) in 512kB chunks took 189558 us (21 MB/s), compress ratio: 3.93 [ 325.985249] lustre_kcompr_13249: compr lz4hc(1) in 1024kB chunks took 220517 us (18 MB/s), compress ratio: 3.96 [ 326.154834] lustre_kcompr_13249: compr lz4hc(1) in 2048kB chunks took 160043 us (24 MB/s), compress ratio: 3.97 [ 326.404505] lustre_kcompr_13249: compr lz4hc(1) in 4096kB chunks took 242354 us (16 MB/s), compress ratio: 3.98 [ 326.440643] lustre_kcompr_13249: decompr lz4hc(1) took 12467 us (80 MB/s) [ 326.446244] lustre_kcompr_13249: test_comp_compress_decompress(lz4hc,1) ret 0 [ 326.469142] lustre_kcompr_13249: acompr lz4hc(1) of 128kB chunks took 7249 us (17 MB/s), compress ratio: 3.27 [ 326.482601] lustre_kcompr_13249: adecompr lz4hc(1) took 4830 us (7 MB/s) [ 326.493097] lustre_kcompr_13249: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 326.757653] lustre_kcompr_13249: compr lz4hc(3) in 64kB chunks took 250035 us (15 MB/s), compress ratio: 3.68 [ 326.975923] lustre_kcompr_13249: compr lz4hc(3) in 128kB chunks took 206338 us (19 MB/s), compress ratio: 3.91 [ 327.288869] lustre_kcompr_13249: compr lz4hc(3) in 256kB chunks took 297336 us (13 MB/s), compress ratio: 4.04 [ 327.549066] lustre_kcompr_13249: compr lz4hc(3) in 512kB chunks took 250153 us (15 MB/s), compress ratio: 4.10 [ 327.886917] lustre_kcompr_13249: compr lz4hc(3) in 1024kB chunks took 328920 us (12 MB/s), compress ratio: 4.13 [ 328.096778] lustre_kcompr_13249: compr lz4hc(3) in 2048kB chunks took 202005 us (19 MB/s), compress ratio: 4.15 [ 328.291259] lustre_kcompr_13249: compr lz4hc(3) in 4096kB chunks took 188787 us (21 MB/s), compress ratio: 4.16 [ 328.327770] lustre_kcompr_13249: decompr lz4hc(3) took 9423 us (102 MB/s) [ 328.334168] lustre_kcompr_13249: test_comp_compress_decompress(lz4hc,3) ret 0 [ 328.354431] lustre_kcompr_13249: acompr lz4hc(3) of 128kB chunks took 12637 us (9 MB/s), compress ratio: 3.38 [ 328.361375] lustre_kcompr_13249: adecompr lz4hc(3) took 158 us (233 MB/s) [ 328.373890] lustre_kcompr_13249: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 328.716094] lustre_kcompr_13249: compr lz4hc(8) in 64kB chunks took 320173 us (12 MB/s), compress ratio: 3.72 [ 329.191298] lustre_kcompr_13249: compr lz4hc(8) in 128kB chunks took 471212 us (8 MB/s), compress ratio: 3.96 [ 329.794593] lustre_kcompr_13249: compr lz4hc(8) in 256kB chunks took 589431 us (6 MB/s), compress ratio: 4.10 [ 330.359245] lustre_kcompr_13249: compr lz4hc(8) in 512kB chunks took 554103 us (7 MB/s), compress ratio: 4.17 [ 330.862231] lustre_kcompr_13249: compr lz4hc(8) in 1024kB chunks took 496578 us (8 MB/s), compress ratio: 4.21 [ 331.324426] lustre_kcompr_13249: compr lz4hc(8) in 2048kB chunks took 453382 us (8 MB/s), compress ratio: 4.22 [ 331.916795] lustre_kcompr_13249: compr lz4hc(8) in 4096kB chunks took 583207 us (6 MB/s), compress ratio: 4.23 [ 331.938773] lustre_kcompr_13249: decompr lz4hc(8) took 9442 us (100 MB/s) [ 331.945360] lustre_kcompr_13249: test_comp_compress_decompress(lz4hc,8) ret 0 [ 331.966785] lustre_kcompr_13249: acompr lz4hc(8) of 128kB chunks took 15662 us (7 MB/s), compress ratio: 3.42 [ 331.974334] lustre_kcompr_13249: adecompr lz4hc(8) took 311 us (117 MB/s) [ 331.980517] lustre_kcompr_13249: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 332.270846] lustre_kcompr_13249: compr lz4hc(15) in 64kB chunks took 274342 us (14 MB/s), compress ratio: 3.72 [ 332.672858] lustre_kcompr_13249: compr lz4hc(15) in 128kB chunks took 396239 us (10 MB/s), compress ratio: 3.96 [ 333.063143] lustre_kcompr_13249: compr lz4hc(15) in 256kB chunks took 386902 us (10 MB/s), compress ratio: 4.10 [ 333.696420] lustre_kcompr_13249: compr lz4hc(15) in 512kB chunks took 623973 us (6 MB/s), compress ratio: 4.17 [ 334.365323] lustre_kcompr_13249: compr lz4hc(15) in 1024kB chunks took 661966 us (6 MB/s), compress ratio: 4.21 [ 334.932954] lustre_kcompr_13249: compr lz4hc(15) in 2048kB chunks took 561826 us (7 MB/s), compress ratio: 4.22 [ 335.362320] lustre_kcompr_13249: compr lz4hc(15) in 4096kB chunks took 420844 us (9 MB/s), compress ratio: 4.23 [ 335.379666] lustre_kcompr_13249: decompr lz4hc(15) took 6414 us (147 MB/s) [ 335.384951] lustre_kcompr_13249: test_comp_compress_decompress(lz4hc,15) ret 0 [ 335.401768] lustre_kcompr_13249: acompr lz4hc(15) of 128kB chunks took 11791 us (10 MB/s), compress ratio: 3.42 [ 335.406604] lustre_kcompr_13249: adecompr lz4hc(15) took 513 us (71 MB/s) [ 335.412330] lustre_kcompr_13249: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 335.438969] lustre_kcompr_13249: compr lzo(-1) in 64kB chunks took 21526 us (185 MB/s), compress ratio: 2.90 [ 335.470952] lustre_kcompr_13249: compr lzo(-1) in 128kB chunks took 26324 us (151 MB/s), compress ratio: 2.95 [ 335.508818] lustre_kcompr_13249: compr lzo(-1) in 256kB chunks took 31338 us (127 MB/s), compress ratio: 2.96 [ 335.555727] lustre_kcompr_13249: compr lzo(-1) in 512kB chunks took 36107 us (110 MB/s), compress ratio: 2.98 [ 335.599407] lustre_kcompr_13249: compr lzo(-1) in 1024kB chunks took 34484 us (115 MB/s), compress ratio: 2.97 [ 335.636557] lustre_kcompr_13249: compr lzo(-1) in 2048kB chunks took 25969 us (154 MB/s), compress ratio: 2.97 [ 335.669919] lustre_kcompr_13249: compr lzo(-1) in 4096kB chunks took 27462 us (145 MB/s), compress ratio: 2.96 [ 335.692584] lustre_kcompr_13249: decompr lzo(-1) took 9443 us (142 MB/s) [ 335.697720] lustre_kcompr_13249: test_comp_compress_decompress(lzo,-1) ret 0 [ 335.704430] lustre_kcompr_13249: acompr lzo(-1) of 128kB chunks took 880 us (142 MB/s), compress ratio: 2.62 [ 335.712609] lustre_kcompr_13249: adecompr lzo(-1) took 708 us (67 MB/s) [ 335.720622] lustre_kcompr_13249: test_acomp_compress_decompress(lzo,-1) ret 0 [ 336.333894] lustre_kcompr_13249: compr deflate(1) in 64kB chunks took 599889 us (6 MB/s), compress ratio: 3.51 [ 336.942166] lustre_kcompr_13249: compr deflate(1) in 128kB chunks took 594400 us (6 MB/s), compress ratio: 3.53 [ 337.560485] lustre_kcompr_13249: compr deflate(1) in 256kB chunks took 609615 us (6 MB/s), compress ratio: 3.53 [ 338.289611] lustre_kcompr_13249: compr deflate(1) in 512kB chunks took 719402 us (5 MB/s), compress ratio: 3.54 [ 338.884661] lustre_kcompr_13249: compr deflate(1) in 1024kB chunks took 584158 us (6 MB/s), compress ratio: 3.54 [ 339.563117] lustre_kcompr_13249: compr deflate(1) in 2048kB chunks took 674154 us (5 MB/s), compress ratio: 3.54 [ 340.209556] lustre_kcompr_13249: compr deflate(1) in 4096kB chunks took 628854 us (6 MB/s), compress ratio: 3.54 [ 340.287407] lustre_kcompr_13249: decompr deflate(1) took 62681 us (17 MB/s) [ 340.295338] lustre_kcompr_13249: test_comp_compress_decompress(deflate,1) ret 0 [ 340.335461] lustre_kcompr_13249: acompr deflate(1) of 128kB chunks took 33199 us (3 MB/s), compress ratio: 3.09 [ 340.354145] lustre_kcompr_13249: adecompr deflate(1) took 3425 us (11 MB/s) [ 340.374577] lustre_kcompr_13249: test_acomp_compress_decompress(deflate,1) ret 0 [ 341.061232] lustre_kcompr_13249: compr deflate(6) in 64kB chunks took 660991 us (6 MB/s), compress ratio: 3.51 [ 341.589208] lustre_kcompr_13249: compr deflate(6) in 128kB chunks took 522569 us (7 MB/s), compress ratio: 3.53 [ 342.250668] lustre_kcompr_13249: compr deflate(6) in 256kB chunks took 650552 us (6 MB/s), compress ratio: 3.53 [ 342.957502] lustre_kcompr_13249: compr deflate(6) in 512kB chunks took 695309 us (5 MB/s), compress ratio: 3.54 [ 343.846344] lustre_kcompr_13249: compr deflate(6) in 1024kB chunks took 882877 us (4 MB/s), compress ratio: 3.54 [ 344.551031] lustre_kcompr_13249: compr deflate(6) in 2048kB chunks took 685289 us (5 MB/s), compress ratio: 3.54 [ 345.329925] lustre_kcompr_13249: compr deflate(6) in 4096kB chunks took 770206 us (5 MB/s), compress ratio: 3.54 [ 345.422659] lustre_kcompr_13249: decompr deflate(6) took 77326 us (14 MB/s) [ 345.442641] lustre_kcompr_13249: test_comp_compress_decompress(deflate,6) ret 0 [ 345.468059] lustre_kcompr_13249: acompr deflate(6) of 128kB chunks took 18335 us (6 MB/s), compress ratio: 3.09 [ 345.482450] lustre_kcompr_13249: adecompr deflate(6) took 4770 us (8 MB/s) [ 345.507251] lustre_kcompr_13249: test_acomp_compress_decompress(deflate,6) ret 0 [ 346.327280] lustre_kcompr_13249: compr deflate(9) in 64kB chunks took 774449 us (5 MB/s), compress ratio: 3.51 [ 347.036868] lustre_kcompr_13249: compr deflate(9) in 128kB chunks took 704383 us (5 MB/s), compress ratio: 3.53 [ 347.736821] lustre_kcompr_13249: compr deflate(9) in 256kB chunks took 693755 us (5 MB/s), compress ratio: 3.53 [ 348.349180] lustre_kcompr_13249: compr deflate(9) in 512kB chunks took 604284 us (6 MB/s), compress ratio: 3.54 [ 349.046903] lustre_kcompr_13249: compr deflate(9) in 1024kB chunks took 690455 us (5 MB/s), compress ratio: 3.54 [ 349.555537] lustre_kcompr_13249: compr deflate(9) in 2048kB chunks took 502056 us (7 MB/s), compress ratio: 3.54 [ 350.191162] lustre_kcompr_13249: compr deflate(9) in 4096kB chunks took 626717 us (6 MB/s), compress ratio: 3.54 [ 350.282751] lustre_kcompr_13249: decompr deflate(9) took 73934 us (15 MB/s) [ 350.291479] lustre_kcompr_13249: test_comp_compress_decompress(deflate,9) ret 0 [ 350.318205] lustre_kcompr_13249: acompr deflate(9) of 128kB chunks took 21338 us (5 MB/s), compress ratio: 3.09 [ 350.326750] lustre_kcompr_13249: adecompr deflate(9) took 1953 us (20 MB/s) [ 350.334571] lustre_kcompr_13249: test_acomp_compress_decompress(deflate,9) ret 0 [ 350.480493] lustre_kcompr_13249: compr zstd(0) in 64kB chunks took 132887 us (30 MB/s), compress ratio: 4.28 [ 350.587195] lustre_kcompr_13249: compr zstd(0) in 128kB chunks took 101102 us (39 MB/s), compress ratio: 4.46 [ 350.786591] lustre_kcompr_13249: compr zstd(0) in 256kB chunks took 188222 us (21 MB/s), compress ratio: 4.61 [ 351.071597] lustre_kcompr_13249: compr zstd(0) in 512kB chunks took 272224 us (14 MB/s), compress ratio: 4.72 [ 351.216001] lustre_kcompr_13249: compr zstd(0) in 1024kB chunks took 137779 us (29 MB/s), compress ratio: 4.80 [ 351.398187] lustre_kcompr_13249: compr zstd(0) in 2048kB chunks took 177702 us (22 MB/s), compress ratio: 4.85 [ 351.693628] lustre_kcompr_13249: compr zstd(0) in 4096kB chunks took 282860 us (14 MB/s), compress ratio: 4.88 [ 351.757022] lustre_kcompr_13249: decompr zstd(0) took 35236 us (23 MB/s) [ 351.779099] lustre_kcompr_13249: test_comp_compress_decompress(zstd,0) ret 0 [ 351.793729] lustre_kcompr_13249: acompr zstd(0) of 128kB chunks took 2875 us (43 MB/s), compress ratio: 3.98 [ 351.805674] lustre_kcompr_13249: adecompr zstd(0) took 1052 us (29 MB/s) [ 351.842347] lustre_kcompr_13249: test_acomp_compress_decompress(zstd,0) ret 0 [ 351.967427] lustre_kcompr_13249: compr zstd(1) in 64kB chunks took 110916 us (36 MB/s), compress ratio: 4.06 [ 352.058346] lustre_kcompr_13249: compr zstd(1) in 128kB chunks took 84380 us (47 MB/s), compress ratio: 4.20 [ 352.165564] lustre_kcompr_13249: compr zstd(1) in 256kB chunks took 89572 us (44 MB/s), compress ratio: 4.34 [ 352.263976] lustre_kcompr_13249: compr zstd(1) in 512kB chunks took 93567 us (42 MB/s), compress ratio: 4.34 [ 352.363625] lustre_kcompr_13249: compr zstd(1) in 1024kB chunks took 94435 us (42 MB/s), compress ratio: 4.37 [ 352.477134] lustre_kcompr_13249: compr zstd(1) in 2048kB chunks took 107545 us (37 MB/s), compress ratio: 4.39 [ 352.610841] lustre_kcompr_13249: compr zstd(1) in 4096kB chunks took 126482 us (31 MB/s), compress ratio: 4.40 [ 352.671395] lustre_kcompr_13249: decompr zstd(1) took 43311 us (20 MB/s) [ 352.684231] lustre_kcompr_13249: test_comp_compress_decompress(zstd,1) ret 0 [ 352.691868] lustre_kcompr_13249: acompr zstd(1) of 128kB chunks took 1885 us (66 MB/s), compress ratio: 3.73 [ 352.715672] lustre_kcompr_13249: adecompr zstd(1) took 665 us (50 MB/s) [ 352.752627] lustre_kcompr_13249: test_acomp_compress_decompress(zstd,1) ret 0 [ 353.951655] lustre_kcompr_13249: compr zstd(10) in 64kB chunks took 1177831 us (3 MB/s), compress ratio: 4.80 [ 355.445645] lustre_kcompr_13249: compr zstd(10) in 128kB chunks took 1489813 us (2 MB/s), compress ratio: 5.09 [ 356.986597] lustre_kcompr_13249: compr zstd(10) in 256kB chunks took 1531849 us (2 MB/s), compress ratio: 5.34 [ 358.275767] lustre_kcompr_13249: compr zstd(10) in 512kB chunks took 1276416 us (3 MB/s), compress ratio: 5.45 [ 360.006749] lustre_kcompr_13249: compr zstd(10) in 1024kB chunks took 1717508 us (2 MB/s), compress ratio: 5.62 [ 361.733963] lustre_kcompr_13249: compr zstd(10) in 2048kB chunks took 1707314 us (2 MB/s), compress ratio: 5.76 [ 363.290079] lustre_kcompr_13249: compr zstd(10) in 4096kB chunks took 1548550 us (2 MB/s), compress ratio: 5.89 [ 363.353444] lustre_kcompr_13249: decompr zstd(10) took 40905 us (16 MB/s) [ 363.361503] lustre_kcompr_13249: test_comp_compress_decompress(zstd,10) ret 0 [ 363.410661] lustre_kcompr_13249: acompr zstd(10) of 128kB chunks took 43907 us (2 MB/s), compress ratio: 4.46 [ 363.418569] lustre_kcompr_13249: adecompr zstd(10) took 539 us (51 MB/s) [ 363.428455] lustre_kcompr_13249: test_acomp_compress_decompress(zstd,10) ret 0 [ 376.961166] lustre_kcompr_13249: compr zstd(15) in 64kB chunks took 13504443 us (0 MB/s), compress ratio: 4.96 [ 390.154443] lustre_kcompr_13249: compr zstd(15) in 128kB chunks took 13188823 us (0 MB/s), compress ratio: 5.28 [ 401.976493] lustre_kcompr_13249: compr zstd(15) in 256kB chunks took 11811020 us (0 MB/s), compress ratio: 5.57 [ 412.804389] lustre_kcompr_13249: compr zstd(15) in 512kB chunks took 10814604 us (0 MB/s), compress ratio: 5.83 [ 419.905976] lustre_kcompr_13249: compr zstd(15) in 1024kB chunks took 7093650 us (0 MB/s), compress ratio: 6.06 [ 427.095231] lustre_kcompr_13249: compr zstd(15) in 2048kB chunks took 7185450 us (0 MB/s), compress ratio: 6.26 [ 441.723389] lustre_kcompr_13249: compr zstd(15) in 4096kB chunks took 14623524 us (0 MB/s), compress ratio: 6.46 [ 441.946797] lustre_kcompr_13249: decompr zstd(15) took 132570 us (4 MB/s) [ 441.969066] lustre_kcompr_13249: test_comp_compress_decompress(zstd,15) ret 0 [ 442.612375] lustre_kcompr_13249: acompr zstd(15) of 128kB chunks took 619198 us (0 MB/s), compress ratio: 4.64 [ 442.639179] lustre_kcompr_13249: adecompr zstd(15) took 584 us (46 MB/s) [ 442.662937] lustre_kcompr_13249: test_acomp_compress_decompress(zstd,15) ret 0 [ 442.813462] lustre_kcompr_13249: compr zstdfast(1) in 64kB chunks took 121694 us (32 MB/s), compress ratio: 3.49 [ 442.909437] lustre_kcompr_13249: compr zstdfast(1) in 128kB chunks took 81376 us (49 MB/s), compress ratio: 3.62 [ 442.973926] lustre_kcompr_13249: compr zstdfast(1) in 256kB chunks took 57058 us (70 MB/s), compress ratio: 3.84 [ 443.025261] lustre_kcompr_13249: compr zstdfast(1) in 512kB chunks took 44681 us (89 MB/s), compress ratio: 3.73 [ 443.064587] lustre_kcompr_13249: compr zstdfast(1) in 1024kB chunks took 32969 us (121 MB/s), compress ratio: 3.76 [ 443.119527] lustre_kcompr_13249: compr zstdfast(1) in 2048kB chunks took 49979 us (80 MB/s), compress ratio: 3.77 [ 443.182600] lustre_kcompr_13249: compr zstdfast(1) in 4096kB chunks took 54855 us (72 MB/s), compress ratio: 3.78 [ 443.233227] lustre_kcompr_13249: decompr zstdfast(1) took 24538 us (43 MB/s) [ 443.250941] lustre_kcompr_13249: test_comp_compress_decompress(zstdfast,1) ret 0 [ 443.268309] lustre_kcompr_13249: acompr zstdfast(1) of 128kB chunks took 2168 us (57 MB/s), compress ratio: 3.19 [ 443.285790] lustre_kcompr_13249: adecompr zstdfast(1) took 1515 us (25 MB/s) [ 443.302869] lustre_kcompr_13249: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 443.458874] lustre_kcompr_13249: compr zstdfast(5) in 64kB chunks took 118434 us (33 MB/s), compress ratio: 2.81 [ 443.563368] lustre_kcompr_13249: compr zstdfast(5) in 128kB chunks took 92570 us (43 MB/s), compress ratio: 2.93 [ 443.661936] lustre_kcompr_13249: compr zstdfast(5) in 256kB chunks took 89553 us (44 MB/s), compress ratio: 3.16 [ 443.725738] lustre_kcompr_13249: compr zstdfast(5) in 512kB chunks took 52306 us (76 MB/s), compress ratio: 3.04 [ 443.804335] lustre_kcompr_13249: compr zstdfast(5) in 1024kB chunks took 66990 us (59 MB/s), compress ratio: 3.07 [ 443.881522] lustre_kcompr_13249: compr zstdfast(5) in 2048kB chunks took 66159 us (60 MB/s), compress ratio: 3.08 [ 443.955603] lustre_kcompr_13249: compr zstdfast(5) in 4096kB chunks took 66046 us (60 MB/s), compress ratio: 3.09 [ 444.005672] lustre_kcompr_13249: decompr zstdfast(5) took 28304 us (45 MB/s) [ 444.015835] lustre_kcompr_13249: test_comp_compress_decompress(zstdfast,5) ret 0 [ 444.027856] lustre_kcompr_13249: acompr zstdfast(5) of 128kB chunks took 2160 us (57 MB/s), compress ratio: 2.56 [ 444.041746] lustre_kcompr_13249: adecompr zstdfast(5) took 1164 us (41 MB/s) [ 444.050368] lustre_kcompr_13249: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 444.131847] lustre_kcompr_13249: compr zstdfast(12) in 64kB chunks took 49945 us (80 MB/s), compress ratio: 1.43 [ 444.190449] lustre_kcompr_13249: compr zstdfast(12) in 128kB chunks took 50532 us (79 MB/s), compress ratio: 1.50 [ 444.251921] lustre_kcompr_13249: compr zstdfast(12) in 256kB chunks took 48171 us (83 MB/s), compress ratio: 1.62 [ 444.307294] lustre_kcompr_13249: compr zstdfast(12) in 512kB chunks took 48617 us (82 MB/s), compress ratio: 1.55 [ 444.367819] lustre_kcompr_13249: compr zstdfast(12) in 1024kB chunks took 50201 us (79 MB/s), compress ratio: 1.58 [ 444.460922] lustre_kcompr_13249: compr zstdfast(12) in 2048kB chunks took 74822 us (53 MB/s), compress ratio: 1.60 [ 444.541265] lustre_kcompr_13249: compr zstdfast(12) in 4096kB chunks took 73298 us (54 MB/s), compress ratio: 1.60 [ 444.602285] lustre_kcompr_13249: decompr zstdfast(12) took 31432 us (79 MB/s) [ 444.625187] lustre_kcompr_13249: test_comp_compress_decompress(zstdfast,12) ret 0 [ 444.649786] lustre_kcompr_13249: acompr zstdfast(12) of 128kB chunks took 16171 us (7 MB/s), compress ratio: 1.37 [ 444.664754] lustre_kcompr_13249: adecompr zstdfast(12) took 416 us (219 MB/s) [ 444.690359] lustre_kcompr_13249: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 444.740977] lustre_kcompr_13249: compr zstdfast(15) in 64kB chunks took 26240 us (152 MB/s), compress ratio: 1.12 [ 444.804831] lustre_kcompr_13249: compr zstdfast(15) in 128kB chunks took 49119 us (81 MB/s), compress ratio: 1.16 [ 444.871114] lustre_kcompr_13249: compr zstdfast(15) in 256kB chunks took 56756 us (70 MB/s), compress ratio: 1.22 [ 444.919640] lustre_kcompr_13249: compr zstdfast(15) in 512kB chunks took 35397 us (113 MB/s), compress ratio: 1.20 [ 445.001462] lustre_kcompr_13249: compr zstdfast(15) in 1024kB chunks took 53399 us (74 MB/s), compress ratio: 1.22 [ 445.035311] lustre_kcompr_13249: compr zstdfast(15) in 2048kB chunks took 21988 us (181 MB/s), compress ratio: 1.23 [ 445.076684] lustre_kcompr_13249: compr zstdfast(15) in 4096kB chunks took 30019 us (133 MB/s), compress ratio: 1.23 [ 445.137333] lustre_kcompr_13249: decompr zstdfast(15) took 31174 us (103 MB/s) [ 445.153945] lustre_kcompr_13249: test_comp_compress_decompress(zstdfast,15) ret 0 [ 445.160980] lustre_kcompr_13249: acompr zstdfast(15) of 128kB chunks took 859 us (145 MB/s), compress ratio: 1.08 [ 445.171138] lustre_kcompr_13249: adecompr zstdfast(15) took 532 us (217 MB/s) [ 445.195628] lustre_kcompr_13249: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 445.200898] lustre_kcompr_13249: SUCCESS [ 449.568536] lustre_kcompr_17697: ***** [ 449.580147] lustre_kcompr_17697: (de)compression test on provided file /tmp/f84.sanity [ 449.594701] lustre_kcompr_17697: ***** [ 449.682418] lustre_kcompr_17697: compr lz4(1) in 64kB chunks took 55916 us (71 MB/s), compress ratio: 2.45 [ 449.736564] lustre_kcompr_17697: compr lz4(1) in 128kB chunks took 41445 us (96 MB/s), compress ratio: 2.39 [ 449.782270] lustre_kcompr_17697: compr lz4(1) in 256kB chunks took 32968 us (121 MB/s), compress ratio: 2.39 [ 449.836357] lustre_kcompr_17697: compr lz4(1) in 512kB chunks took 40794 us (98 MB/s), compress ratio: 2.39 [ 449.889096] lustre_kcompr_17697: compr lz4(1) in 1024kB chunks took 42064 us (95 MB/s), compress ratio: 2.39 [ 449.951655] lustre_kcompr_17697: compr lz4(1) in 2048kB chunks took 55989 us (71 MB/s), compress ratio: 2.39 [ 450.029089] lustre_kcompr_17697: compr lz4(1) in 4096kB chunks took 63205 us (63 MB/s), compress ratio: 2.39 [ 450.065699] lustre_kcompr_17697: decompr lz4(1) took 9212 us (181 MB/s) [ 450.071947] lustre_kcompr_17697: test_comp_compress_decompress(lz4,1) ret 0 [ 450.087209] lustre_kcompr_17697: acompr lz4(1) of 128kB chunks took 564 us (221 MB/s), compress ratio: 15.67 [ 450.092709] lustre_kcompr_17697: adecompr lz4(1) took 96 us (83 MB/s) [ 450.097853] lustre_kcompr_17697: test_acomp_compress_decompress(lz4,1) ret 0 [ 450.132802] lustre_kcompr_17697: compr lz4(4) in 64kB chunks took 17588 us (227 MB/s), compress ratio: 2.36 [ 450.155598] lustre_kcompr_17697: compr lz4(4) in 128kB chunks took 16860 us (237 MB/s), compress ratio: 2.35 [ 450.179973] lustre_kcompr_17697: compr lz4(4) in 256kB chunks took 17556 us (227 MB/s), compress ratio: 2.35 [ 450.223660] lustre_kcompr_17697: compr lz4(4) in 512kB chunks took 29400 us (136 MB/s), compress ratio: 2.35 [ 450.283624] lustre_kcompr_17697: compr lz4(4) in 1024kB chunks took 41823 us (95 MB/s), compress ratio: 2.35 [ 450.335162] lustre_kcompr_17697: compr lz4(4) in 2048kB chunks took 33347 us (119 MB/s), compress ratio: 2.35 [ 450.359655] lustre_kcompr_17697: compr lz4(4) in 4096kB chunks took 14864 us (269 MB/s), compress ratio: 2.35 [ 450.376397] lustre_kcompr_17697: decompr lz4(4) took 2360 us (720 MB/s) [ 450.380297] lustre_kcompr_17697: test_comp_compress_decompress(lz4,4) ret 0 [ 450.384995] lustre_kcompr_17697: acompr lz4(4) of 128kB chunks took 146 us (856 MB/s), compress ratio: 15.30 [ 450.389975] lustre_kcompr_17697: adecompr lz4(4) took 103 us (79 MB/s) [ 450.396939] lustre_kcompr_17697: test_acomp_compress_decompress(lz4,4) ret 0 [ 450.416195] lustre_kcompr_17697: compr lz4(9) in 64kB chunks took 8333 us (480 MB/s), compress ratio: 2.32 [ 450.438249] lustre_kcompr_17697: compr lz4(9) in 128kB chunks took 16660 us (240 MB/s), compress ratio: 2.31 [ 450.453916] lustre_kcompr_17697: compr lz4(9) in 256kB chunks took 9924 us (403 MB/s), compress ratio: 2.31 [ 450.466823] lustre_kcompr_17697: compr lz4(9) in 512kB chunks took 7238 us (552 MB/s), compress ratio: 2.31 [ 450.491291] lustre_kcompr_17697: compr lz4(9) in 1024kB chunks took 17682 us (226 MB/s), compress ratio: 2.31 [ 450.517835] lustre_kcompr_17697: compr lz4(9) in 2048kB chunks took 15785 us (253 MB/s), compress ratio: 2.32 [ 450.546776] lustre_kcompr_17697: compr lz4(9) in 4096kB chunks took 17208 us (232 MB/s), compress ratio: 2.32 [ 450.574864] lustre_kcompr_17697: decompr lz4(9) took 8804 us (195 MB/s) [ 450.583880] lustre_kcompr_17697: test_comp_compress_decompress(lz4,9) ret 0 [ 450.588991] lustre_kcompr_17697: acompr lz4(9) of 128kB chunks took 113 us (1106 MB/s), compress ratio: 14.81 [ 450.595402] lustre_kcompr_17697: adecompr lz4(9) took 121 us (69 MB/s) [ 450.622610] lustre_kcompr_17697: test_acomp_compress_decompress(lz4,9) ret 0 [ 450.680550] lustre_kcompr_17697: compr lz4(15) in 64kB chunks took 13895 us (287 MB/s), compress ratio: 2.23 [ 450.707165] lustre_kcompr_17697: compr lz4(15) in 128kB chunks took 15364 us (260 MB/s), compress ratio: 2.23 [ 450.749446] lustre_kcompr_17697: compr lz4(15) in 256kB chunks took 24196 us (165 MB/s), compress ratio: 2.23 [ 450.782245] lustre_kcompr_17697: compr lz4(15) in 512kB chunks took 19252 us (207 MB/s), compress ratio: 2.23 [ 450.801886] lustre_kcompr_17697: compr lz4(15) in 1024kB chunks took 8216 us (486 MB/s), compress ratio: 2.23 [ 450.817985] lustre_kcompr_17697: compr lz4(15) in 2048kB chunks took 11216 us (356 MB/s), compress ratio: 2.23 [ 450.830269] lustre_kcompr_17697: compr lz4(15) in 4096kB chunks took 7582 us (527 MB/s), compress ratio: 2.23 [ 450.849173] lustre_kcompr_17697: decompr lz4(15) took 5589 us (320 MB/s) [ 450.853959] lustre_kcompr_17697: test_comp_compress_decompress(lz4,15) ret 0 [ 450.858780] lustre_kcompr_17697: acompr lz4(15) of 128kB chunks took 119 us (1050 MB/s), compress ratio: 14.18 [ 450.865819] lustre_kcompr_17697: adecompr lz4(15) took 113 us (77 MB/s) [ 450.902789] lustre_kcompr_17697: test_acomp_compress_decompress(lz4,15) ret 0 [ 451.127716] lustre_kcompr_17697: compr lz4hc(1) in 64kB chunks took 199009 us (20 MB/s), compress ratio: 2.54 [ 451.260147] lustre_kcompr_17697: compr lz4hc(1) in 128kB chunks took 119759 us (33 MB/s), compress ratio: 2.61 [ 451.450858] lustre_kcompr_17697: compr lz4hc(1) in 256kB chunks took 181528 us (22 MB/s), compress ratio: 2.64 [ 451.571331] lustre_kcompr_17697: compr lz4hc(1) in 512kB chunks took 109170 us (36 MB/s), compress ratio: 2.66 [ 451.687568] lustre_kcompr_17697: compr lz4hc(1) in 1024kB chunks took 112350 us (35 MB/s), compress ratio: 2.67 [ 451.873852] lustre_kcompr_17697: compr lz4hc(1) in 2048kB chunks took 178938 us (22 MB/s), compress ratio: 2.67 [ 451.982795] lustre_kcompr_17697: compr lz4hc(1) in 4096kB chunks took 104322 us (38 MB/s), compress ratio: 2.67 [ 452.003617] lustre_kcompr_17697: decompr lz4hc(1) took 4697 us (318 MB/s) [ 452.007676] lustre_kcompr_17697: test_comp_compress_decompress(lz4hc,1) ret 0 [ 452.012453] lustre_kcompr_17697: acompr lz4hc(1) of 128kB chunks took 841 us (148 MB/s), compress ratio: 15.97 [ 452.025307] lustre_kcompr_17697: adecompr lz4hc(1) took 128 us (61 MB/s) [ 452.037337] lustre_kcompr_17697: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 452.179248] lustre_kcompr_17697: compr lz4hc(3) in 64kB chunks took 123074 us (32 MB/s), compress ratio: 2.57 [ 452.558386] lustre_kcompr_17697: compr lz4hc(3) in 128kB chunks took 369991 us (10 MB/s), compress ratio: 2.64 [ 452.917471] lustre_kcompr_17697: compr lz4hc(3) in 256kB chunks took 345281 us (11 MB/s), compress ratio: 2.68 [ 453.123644] lustre_kcompr_17697: compr lz4hc(3) in 512kB chunks took 198257 us (20 MB/s), compress ratio: 2.69 [ 453.336235] lustre_kcompr_17697: compr lz4hc(3) in 1024kB chunks took 205588 us (19 MB/s), compress ratio: 2.70 [ 453.604244] lustre_kcompr_17697: compr lz4hc(3) in 2048kB chunks took 262248 us (15 MB/s), compress ratio: 2.71 [ 453.846627] lustre_kcompr_17697: compr lz4hc(3) in 4096kB chunks took 233863 us (17 MB/s), compress ratio: 2.71 [ 453.876635] lustre_kcompr_17697: decompr lz4hc(3) took 9440 us (155 MB/s) [ 453.881795] lustre_kcompr_17697: test_comp_compress_decompress(lz4hc,3) ret 0 [ 453.900840] lustre_kcompr_17697: acompr lz4hc(3) of 128kB chunks took 4089 us (30 MB/s), compress ratio: 16.00 [ 453.908867] lustre_kcompr_17697: adecompr lz4hc(3) took 137 us (57 MB/s) [ 453.921619] lustre_kcompr_17697: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 454.524605] lustre_kcompr_17697: compr lz4hc(8) in 64kB chunks took 581810 us (6 MB/s), compress ratio: 2.60 [ 455.080986] lustre_kcompr_17697: compr lz4hc(8) in 128kB chunks took 549839 us (7 MB/s), compress ratio: 2.66 [ 455.727178] lustre_kcompr_17697: compr lz4hc(8) in 256kB chunks took 630861 us (6 MB/s), compress ratio: 2.70 [ 456.514696] lustre_kcompr_17697: compr lz4hc(8) in 512kB chunks took 775073 us (5 MB/s), compress ratio: 2.71 [ 457.421747] lustre_kcompr_17697: compr lz4hc(8) in 1024kB chunks took 899470 us (4 MB/s), compress ratio: 2.72 [ 457.880819] lustre_kcompr_17697: compr lz4hc(8) in 2048kB chunks took 452446 us (8 MB/s), compress ratio: 2.73 [ 458.531601] lustre_kcompr_17697: compr lz4hc(8) in 4096kB chunks took 645444 us (6 MB/s), compress ratio: 2.73 [ 458.564282] lustre_kcompr_17697: decompr lz4hc(8) took 6161 us (237 MB/s) [ 458.572855] lustre_kcompr_17697: test_comp_compress_decompress(lz4hc,8) ret 0 [ 458.605193] lustre_kcompr_17697: acompr lz4hc(8) of 128kB chunks took 14264 us (8 MB/s), compress ratio: 16.17 [ 458.618037] lustre_kcompr_17697: adecompr lz4hc(8) took 519 us (14 MB/s) [ 458.651316] lustre_kcompr_17697: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 466.890671] lustre_kcompr_17697: compr lz4hc(15) in 64kB chunks took 8208444 us (0 MB/s), compress ratio: 2.61 [ 477.936909] lustre_kcompr_17697: compr lz4hc(15) in 128kB chunks took 11039509 us (0 MB/s), compress ratio: 2.67 [ 487.856547] lustre_kcompr_17697: compr lz4hc(15) in 256kB chunks took 9910140 us (0 MB/s), compress ratio: 2.71 [ 500.457351] lustre_kcompr_17697: compr lz4hc(15) in 512kB chunks took 12596448 us (0 MB/s), compress ratio: 2.72 [ 513.636206] lustre_kcompr_17697: compr lz4hc(15) in 1024kB chunks took 13171339 us (0 MB/s), compress ratio: 2.73 [ 525.664490] lustre_kcompr_17697: compr lz4hc(15) in 2048kB chunks took 12018220 us (0 MB/s), compress ratio: 2.74 [ 539.817475] lustre_kcompr_17697: compr lz4hc(15) in 4096kB chunks took 14131135 us (0 MB/s), compress ratio: 2.74 [ 539.836338] lustre_kcompr_17697: decompr lz4hc(15) took 6993 us (208 MB/s) [ 539.846778] lustre_kcompr_17697: test_comp_compress_decompress(lz4hc,15) ret 0 [ 539.882690] lustre_kcompr_17697: acompr lz4hc(15) of 128kB chunks took 28050 us (4 MB/s), compress ratio: 16.30 [ 539.889237] lustre_kcompr_17697: adecompr lz4hc(15) took 193 us (39 MB/s) [ 539.900966] lustre_kcompr_17697: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 539.928142] lustre_kcompr_17697: compr lzo(-1) in 64kB chunks took 20173 us (198 MB/s), compress ratio: 2.35 [ 539.960379] lustre_kcompr_17697: compr lzo(-1) in 128kB chunks took 25417 us (157 MB/s), compress ratio: 2.35 [ 539.986327] lustre_kcompr_17697: compr lzo(-1) in 256kB chunks took 19360 us (206 MB/s), compress ratio: 2.35 [ 540.026509] lustre_kcompr_17697: compr lzo(-1) in 512kB chunks took 25803 us (155 MB/s), compress ratio: 2.36 [ 540.064512] lustre_kcompr_17697: compr lzo(-1) in 1024kB chunks took 30686 us (130 MB/s), compress ratio: 2.36 [ 540.111800] lustre_kcompr_17697: compr lzo(-1) in 2048kB chunks took 40284 us (99 MB/s), compress ratio: 2.36 [ 540.143137] lustre_kcompr_17697: compr lzo(-1) in 4096kB chunks took 24863 us (160 MB/s), compress ratio: 2.36 [ 540.160263] lustre_kcompr_17697: decompr lzo(-1) took 5992 us (282 MB/s) [ 540.163500] lustre_kcompr_17697: test_comp_compress_decompress(lzo,-1) ret 0 [ 540.168799] lustre_kcompr_17697: acompr lzo(-1) of 128kB chunks took 608 us (205 MB/s), compress ratio: 15.45 [ 540.190393] lustre_kcompr_17697: adecompr lzo(-1) took 6849 us (1 MB/s) [ 540.204411] lustre_kcompr_17697: test_acomp_compress_decompress(lzo,-1) ret 0 [ 540.650706] lustre_kcompr_17697: compr deflate(1) in 64kB chunks took 433278 us (9 MB/s), compress ratio: 3.27 [ 541.286604] lustre_kcompr_17697: compr deflate(1) in 128kB chunks took 632086 us (6 MB/s), compress ratio: 3.28 [ 542.176501] lustre_kcompr_17697: compr deflate(1) in 256kB chunks took 876190 us (4 MB/s), compress ratio: 3.28 [ 543.005425] lustre_kcompr_17697: compr deflate(1) in 512kB chunks took 818029 us (4 MB/s), compress ratio: 3.28 [ 543.706224] lustre_kcompr_17697: compr deflate(1) in 1024kB chunks took 689685 us (5 MB/s), compress ratio: 3.28 [ 544.456489] lustre_kcompr_17697: compr deflate(1) in 2048kB chunks took 739997 us (5 MB/s), compress ratio: 3.28 [ 545.094958] lustre_kcompr_17697: compr deflate(1) in 4096kB chunks took 633552 us (6 MB/s), compress ratio: 3.28 [ 545.188910] lustre_kcompr_17697: decompr deflate(1) took 66991 us (18 MB/s) [ 545.210710] lustre_kcompr_17697: test_comp_compress_decompress(deflate,1) ret 0 [ 545.255403] lustre_kcompr_17697: acompr deflate(1) of 128kB chunks took 35554 us (3 MB/s), compress ratio: 21.43 [ 545.274620] lustre_kcompr_17697: adecompr deflate(1) took 306 us (19 MB/s) [ 545.293509] lustre_kcompr_17697: test_acomp_compress_decompress(deflate,1) ret 0 [ 546.089789] lustre_kcompr_17697: compr deflate(6) in 64kB chunks took 777255 us (5 MB/s), compress ratio: 3.27 [ 546.487768] lustre_kcompr_17697: compr deflate(6) in 128kB chunks took 393437 us (10 MB/s), compress ratio: 3.28 [ 547.163392] lustre_kcompr_17697: compr deflate(6) in 256kB chunks took 671020 us (5 MB/s), compress ratio: 3.28 [ 547.815232] lustre_kcompr_17697: compr deflate(6) in 512kB chunks took 643171 us (6 MB/s), compress ratio: 3.28 [ 548.503639] lustre_kcompr_17697: compr deflate(6) in 1024kB chunks took 678859 us (5 MB/s), compress ratio: 3.28 [ 549.106857] lustre_kcompr_17697: compr deflate(6) in 2048kB chunks took 585872 us (6 MB/s), compress ratio: 3.28 [ 549.851605] lustre_kcompr_17697: compr deflate(6) in 4096kB chunks took 738538 us (5 MB/s), compress ratio: 3.28 [ 549.943668] lustre_kcompr_17697: decompr deflate(6) took 71064 us (17 MB/s) [ 549.956920] lustre_kcompr_17697: test_comp_compress_decompress(deflate,6) ret 0 [ 549.983352] lustre_kcompr_17697: acompr deflate(6) of 128kB chunks took 12206 us (10 MB/s), compress ratio: 21.43 [ 549.993312] lustre_kcompr_17697: adecompr deflate(6) took 488 us (11 MB/s) [ 550.003270] lustre_kcompr_17697: test_acomp_compress_decompress(deflate,6) ret 0 [ 550.552048] lustre_kcompr_17697: compr deflate(9) in 64kB chunks took 525212 us (7 MB/s), compress ratio: 3.27 [ 551.211377] lustre_kcompr_17697: compr deflate(9) in 128kB chunks took 643391 us (6 MB/s), compress ratio: 3.28 [ 551.884634] lustre_kcompr_17697: compr deflate(9) in 256kB chunks took 659267 us (6 MB/s), compress ratio: 3.28 [ 552.680352] lustre_kcompr_17697: compr deflate(9) in 512kB chunks took 790959 us (5 MB/s), compress ratio: 3.28 [ 553.298819] lustre_kcompr_17697: compr deflate(9) in 1024kB chunks took 611685 us (6 MB/s), compress ratio: 3.28 [ 554.034208] lustre_kcompr_17697: compr deflate(9) in 2048kB chunks took 726657 us (5 MB/s), compress ratio: 3.28 [ 554.810273] lustre_kcompr_17697: compr deflate(9) in 4096kB chunks took 767203 us (5 MB/s), compress ratio: 3.28 [ 554.880491] lustre_kcompr_17697: decompr deflate(9) took 53177 us (22 MB/s) [ 554.892704] lustre_kcompr_17697: test_comp_compress_decompress(deflate,9) ret 0 [ 554.914397] lustre_kcompr_17697: acompr deflate(9) of 128kB chunks took 14559 us (8 MB/s), compress ratio: 21.43 [ 554.923859] lustre_kcompr_17697: adecompr deflate(9) took 316 us (18 MB/s) [ 554.943562] lustre_kcompr_17697: test_acomp_compress_decompress(deflate,9) ret 0 [ 555.134987] lustre_kcompr_17697: compr zstd(0) in 64kB chunks took 145775 us (27 MB/s), compress ratio: 3.28 [ 555.291405] lustre_kcompr_17697: compr zstd(0) in 128kB chunks took 149077 us (26 MB/s), compress ratio: 3.26 [ 555.390862] lustre_kcompr_17697: compr zstd(0) in 256kB chunks took 90404 us (44 MB/s), compress ratio: 3.31 [ 555.530767] lustre_kcompr_17697: compr zstd(0) in 512kB chunks took 135313 us (29 MB/s), compress ratio: 3.32 [ 555.716801] lustre_kcompr_17697: compr zstd(0) in 1024kB chunks took 176600 us (22 MB/s), compress ratio: 3.32 [ 555.923281] lustre_kcompr_17697: compr zstd(0) in 2048kB chunks took 198799 us (20 MB/s), compress ratio: 3.33 [ 556.215762] lustre_kcompr_17697: compr zstd(0) in 4096kB chunks took 286493 us (13 MB/s), compress ratio: 3.33 [ 556.280226] lustre_kcompr_17697: decompr zstd(0) took 40856 us (29 MB/s) [ 556.290172] lustre_kcompr_17697: test_comp_compress_decompress(zstd,0) ret 0 [ 556.298603] lustre_kcompr_17697: acompr zstd(0) of 128kB chunks took 437 us (286 MB/s), compress ratio: 22.64 [ 556.312130] lustre_kcompr_17697: adecompr zstd(0) took 166 us (33 MB/s) [ 556.355183] lustre_kcompr_17697: test_acomp_compress_decompress(zstd,0) ret 0 [ 556.449880] lustre_kcompr_17697: compr zstd(1) in 64kB chunks took 65526 us (61 MB/s), compress ratio: 3.22 [ 556.518667] lustre_kcompr_17697: compr zstd(1) in 128kB chunks took 54174 us (73 MB/s), compress ratio: 3.18 [ 556.604592] lustre_kcompr_17697: compr zstd(1) in 256kB chunks took 73734 us (54 MB/s), compress ratio: 3.19 [ 556.685916] lustre_kcompr_17697: compr zstd(1) in 512kB chunks took 68950 us (58 MB/s), compress ratio: 3.19 [ 556.788160] lustre_kcompr_17697: compr zstd(1) in 1024kB chunks took 92654 us (43 MB/s), compress ratio: 3.19 [ 556.840956] lustre_kcompr_17697: compr zstd(1) in 2048kB chunks took 46802 us (85 MB/s), compress ratio: 3.19 [ 556.909107] lustre_kcompr_17697: compr zstd(1) in 4096kB chunks took 62709 us (63 MB/s), compress ratio: 3.19 [ 556.964940] lustre_kcompr_17697: decompr zstd(1) took 35812 us (35 MB/s) [ 556.971377] lustre_kcompr_17697: test_comp_compress_decompress(zstd,1) ret 0 [ 556.978658] lustre_kcompr_17697: acompr zstd(1) of 128kB chunks took 271 us (461 MB/s), compress ratio: 22.79 [ 556.984635] lustre_kcompr_17697: adecompr zstd(1) took 201 us (27 MB/s) [ 556.991037] lustre_kcompr_17697: test_acomp_compress_decompress(zstd,1) ret 0 [ 557.813144] lustre_kcompr_17697: compr zstd(10) in 64kB chunks took 810718 us (4 MB/s), compress ratio: 3.33 [ 558.768677] lustre_kcompr_17697: compr zstd(10) in 128kB chunks took 949468 us (4 MB/s), compress ratio: 3.33 [ 559.845729] lustre_kcompr_17697: compr zstd(10) in 256kB chunks took 1068658 us (3 MB/s), compress ratio: 3.37 [ 560.912322] lustre_kcompr_17697: compr zstd(10) in 512kB chunks took 1056396 us (3 MB/s), compress ratio: 3.40 [ 562.097803] lustre_kcompr_17697: compr zstd(10) in 1024kB chunks took 1168384 us (3 MB/s), compress ratio: 3.42 [ 562.959054] lustre_kcompr_17697: compr zstd(10) in 2048kB chunks took 848338 us (4 MB/s), compress ratio: 3.46 [ 563.681814] lustre_kcompr_17697: compr zstd(10) in 4096kB chunks took 718655 us (5 MB/s), compress ratio: 3.50 [ 563.747980] lustre_kcompr_17697: decompr zstd(10) took 46975 us (24 MB/s) [ 563.753838] lustre_kcompr_17697: test_comp_compress_decompress(zstd,10) ret 0 [ 563.760904] lustre_kcompr_17697: acompr zstd(10) of 128kB chunks took 2361 us (52 MB/s), compress ratio: 22.78 [ 563.769977] lustre_kcompr_17697: adecompr zstd(10) took 667 us (8 MB/s) [ 563.776605] lustre_kcompr_17697: test_acomp_compress_decompress(zstd,10) ret 0 [ 573.086107] lustre_kcompr_17697: compr zstd(15) in 64kB chunks took 9292451 us (0 MB/s), compress ratio: 3.36 [ 579.366125] lustre_kcompr_17697: compr zstd(15) in 128kB chunks took 6263039 us (0 MB/s), compress ratio: 3.39 [ 587.138355] lustre_kcompr_17697: compr zstd(15) in 256kB chunks took 7763258 us (0 MB/s), compress ratio: 3.40 [ 594.125191] lustre_kcompr_17697: compr zstd(15) in 512kB chunks took 6960589 us (0 MB/s), compress ratio: 3.42 [ 599.330986] lustre_kcompr_17697: compr zstd(15) in 1024kB chunks took 5194141 us (0 MB/s), compress ratio: 3.43 [ 603.612547] lustre_kcompr_17697: compr zstd(15) in 2048kB chunks took 4275983 us (0 MB/s), compress ratio: 3.48 [ 607.518758] lustre_kcompr_17697: compr zstd(15) in 4096kB chunks took 3900851 us (1 MB/s), compress ratio: 3.56 [ 607.608181] lustre_kcompr_17697: decompr zstd(15) took 71863 us (15 MB/s) [ 607.613972] lustre_kcompr_17697: test_comp_compress_decompress(zstd,15) ret 0 [ 607.687396] lustre_kcompr_17697: acompr zstd(15) of 128kB chunks took 68489 us (1 MB/s), compress ratio: 23.92 [ 607.702711] lustre_kcompr_17697: adecompr zstd(15) took 184 us (28 MB/s) [ 607.726144] lustre_kcompr_17697: test_acomp_compress_decompress(zstd,15) ret 0 [ 607.793733] lustre_kcompr_17697: compr zstdfast(1) in 64kB chunks took 41430 us (96 MB/s), compress ratio: 2.47 [ 607.858938] lustre_kcompr_17697: compr zstdfast(1) in 128kB chunks took 54672 us (73 MB/s), compress ratio: 2.48 [ 607.914293] lustre_kcompr_17697: compr zstdfast(1) in 256kB chunks took 43751 us (91 MB/s), compress ratio: 2.53 [ 607.979757] lustre_kcompr_17697: compr zstdfast(1) in 512kB chunks took 55624 us (71 MB/s), compress ratio: 2.42 [ 608.034639] lustre_kcompr_17697: compr zstdfast(1) in 1024kB chunks took 40408 us (98 MB/s), compress ratio: 2.42 [ 608.096577] lustre_kcompr_17697: compr zstdfast(1) in 2048kB chunks took 54068 us (73 MB/s), compress ratio: 2.42 [ 608.143677] lustre_kcompr_17697: compr zstdfast(1) in 4096kB chunks took 39880 us (100 MB/s), compress ratio: 2.42 [ 608.164674] lustre_kcompr_17697: decompr zstdfast(1) took 6151 us (268 MB/s) [ 608.170297] lustre_kcompr_17697: test_comp_compress_decompress(zstdfast,1) ret 0 [ 608.175028] lustre_kcompr_17697: acompr zstdfast(1) of 128kB chunks took 419 us (298 MB/s), compress ratio: 17.28 [ 608.183675] lustre_kcompr_17697: adecompr zstdfast(1) took 127 us (56 MB/s) [ 608.190519] lustre_kcompr_17697: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 608.222948] lustre_kcompr_17697: compr zstdfast(5) in 64kB chunks took 22976 us (174 MB/s), compress ratio: 2.38 [ 608.250679] lustre_kcompr_17697: compr zstdfast(5) in 128kB chunks took 20141 us (198 MB/s), compress ratio: 2.38 [ 608.284445] lustre_kcompr_17697: compr zstdfast(5) in 256kB chunks took 27831 us (143 MB/s), compress ratio: 2.40 [ 608.309604] lustre_kcompr_17697: compr zstdfast(5) in 512kB chunks took 18350 us (217 MB/s), compress ratio: 2.36 [ 608.332565] lustre_kcompr_17697: compr zstdfast(5) in 1024kB chunks took 15611 us (256 MB/s), compress ratio: 2.36 [ 608.361113] lustre_kcompr_17697: compr zstdfast(5) in 2048kB chunks took 23193 us (172 MB/s), compress ratio: 2.36 [ 608.382143] lustre_kcompr_17697: compr zstdfast(5) in 4096kB chunks took 14448 us (276 MB/s), compress ratio: 2.36 [ 608.424620] lustre_kcompr_17697: decompr zstdfast(5) took 14199 us (118 MB/s) [ 608.429640] lustre_kcompr_17697: test_comp_compress_decompress(zstdfast,5) ret 0 [ 608.437940] lustre_kcompr_17697: acompr zstdfast(5) of 128kB chunks took 187 us (668 MB/s), compress ratio: 16.12 [ 608.443069] lustre_kcompr_17697: adecompr zstdfast(5) took 175 us (44 MB/s) [ 608.449247] lustre_kcompr_17697: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 608.471216] lustre_kcompr_17697: compr zstdfast(12) in 64kB chunks took 5903 us (677 MB/s), compress ratio: 2.07 [ 608.486920] lustre_kcompr_17697: compr zstdfast(12) in 128kB chunks took 10922 us (366 MB/s), compress ratio: 2.07 [ 608.521742] lustre_kcompr_17697: compr zstdfast(12) in 256kB chunks took 27158 us (147 MB/s), compress ratio: 2.08 [ 608.537485] lustre_kcompr_17697: compr zstdfast(12) in 512kB chunks took 6495 us (615 MB/s), compress ratio: 2.07 [ 608.556519] lustre_kcompr_17697: compr zstdfast(12) in 1024kB chunks took 13202 us (302 MB/s), compress ratio: 2.07 [ 608.576236] lustre_kcompr_17697: compr zstdfast(12) in 2048kB chunks took 10855 us (368 MB/s), compress ratio: 2.07 [ 608.588436] lustre_kcompr_17697: compr zstdfast(12) in 4096kB chunks took 6876 us (581 MB/s), compress ratio: 2.08 [ 608.606156] lustre_kcompr_17697: decompr zstdfast(12) took 3200 us (600 MB/s) [ 608.618171] lustre_kcompr_17697: test_comp_compress_decompress(zstdfast,12) ret 0 [ 608.623572] lustre_kcompr_17697: acompr zstdfast(12) of 128kB chunks took 139 us (899 MB/s), compress ratio: 13.13 [ 608.630384] lustre_kcompr_17697: adecompr zstdfast(12) took 110 us (86 MB/s) [ 608.640141] lustre_kcompr_17697: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 608.663531] lustre_kcompr_17697: compr zstdfast(15) in 64kB chunks took 8051 us (496 MB/s), compress ratio: 1.82 [ 608.679311] lustre_kcompr_17697: compr zstdfast(15) in 128kB chunks took 7318 us (546 MB/s), compress ratio: 1.83 [ 608.689942] lustre_kcompr_17697: compr zstdfast(15) in 256kB chunks took 5498 us (727 MB/s), compress ratio: 1.83 [ 608.704639] lustre_kcompr_17697: compr zstdfast(15) in 512kB chunks took 8838 us (452 MB/s), compress ratio: 1.83 [ 608.713147] lustre_kcompr_17697: compr zstdfast(15) in 1024kB chunks took 4391 us (910 MB/s), compress ratio: 1.83 [ 608.722851] lustre_kcompr_17697: compr zstdfast(15) in 2048kB chunks took 5328 us (750 MB/s), compress ratio: 1.83 [ 608.739616] lustre_kcompr_17697: compr zstdfast(15) in 4096kB chunks took 8916 us (448 MB/s), compress ratio: 1.84 [ 608.759215] lustre_kcompr_17697: decompr zstdfast(15) took 2306 us (942 MB/s) [ 608.770452] lustre_kcompr_17697: test_comp_compress_decompress(zstdfast,15) ret 0 [ 608.776656] lustre_kcompr_17697: acompr zstdfast(15) of 128kB chunks took 140 us (892 MB/s), compress ratio: 10.73 [ 608.784440] lustre_kcompr_17697: adecompr zstdfast(15) took 124 us (93 MB/s) [ 608.790645] lustre_kcompr_17697: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 608.794075] lustre_kcompr_17697: SUCCESS [ 627.193810] Lustre: DEBUG MARKER: == sanity test complete, duration 418 sec ================ 12:41:44 (1789058504) [ 628.886785] Lustre: DEBUG MARKER: === sanity: start cleanup 12:41:46 (1789058506) === [ 631.912109] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:41:49 (1789058509) === [ 633.817992] LustreError: 13356:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff93ecc6909800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 633.863356] Lustre: Unmounted lustre-client [ 653.404245] Key type lgssc unregistered [ 653.805167] LNet: 13836:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 653.815836] LNetError: 13836:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 653.850531] LNet: Removed LNI 192.168.203.25@tcp [ 654.712286] Key type .llcrypt unregistered [ 654.715258] Key type ._llcrypt unregistered