[ 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 501704034 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2592MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002323] x2apic enabled [ 0.003006] Switched APIC routing to physical x2apic. [ 0.004009] kvm-guest: setup PV IPIs [ 0.006923] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.007019] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.008011] pid_max: default: 32768 minimum: 301 [ 0.009123] LSM: Security Framework initializing [ 0.010047] Yama: becoming mindful. [ 0.011034] SELinux: Initializing. [ 0.012067] *** VALIDATE selinux *** [ 0.020322] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024871] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027107] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028099] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029102] *** VALIDATE tmpfs *** [ 0.030415] *** VALIDATE proc *** [ 0.032209] *** VALIDATE cgroup *** [ 0.033021] *** VALIDATE cgroup2 *** [ 0.034242] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035141] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037028] Spectre V2 : User space: Vulnerable [ 0.038008] Speculative Store Bypass: Vulnerable [ 0.041510] debug: unmapping init [mem 0xffffffff9e859000-0xffffffff9e860fff] [ 0.043168] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044661] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045023] ... version: 2 [ 0.046011] ... bit width: 48 [ 0.047013] ... generic registers: 4 [ 0.048012] ... value mask: 0000ffffffffffff [ 0.049013] ... max period: 00007fffffffffff [ 0.050013] ... fixed-purpose events: 3 [ 0.051007] ... event mask: 000000070000000f [ 0.052316] rcu: Hierarchical SRCU implementation. [ 0.054329] smp: Bringing up secondary CPUs ... [ 0.055524] x86: Booting SMP configuration: [ 0.056021] .... node #0, CPUs: #1 #2 #3 [ 0.065102] smp: Brought up 1 node, 4 CPUs [ 0.067012] smpboot: Max logical packages: 1 [ 0.068127] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.121054] node 0 deferred pages initialised in 51ms [ 0.124096] devtmpfs: initialized [ 0.125225] x86/mm: Memory block size: 128MB [ 0.127925] gcov: version magic: 0x41383552 [ 0.129164] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.130194] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.131258] pinctrl core: initialized pinctrl subsystem [ 0.132174] [ 0.132695] ************************************************************* [ 0.133013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.134022] ** ** [ 0.135010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.136011] ** ** [ 0.137010] ** This means that this kernel is built to expose internal ** [ 0.138012] ** IOMMU data structures, which may compromise security on ** [ 0.139016] ** your system. ** [ 0.140011] ** ** [ 0.141008] ** If you see this message and you are not debugging the ** [ 0.142012] ** kernel, report this immediately to your vendor! ** [ 0.143011] ** ** [ 0.144015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.145017] ************************************************************* [ 0.146899] NET: Registered protocol family 16 [ 0.147609] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.148064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.149058] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.150632] cpuidle: using governor menu [ 0.154390] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.156437] PCI: Using configuration type 1 for base access [ 0.157131] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.164176] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.165043] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.166329] cryptd: max_cpu_qlen set to 1000 [ 0.168325] ACPI: Added _OSI(Module Device) [ 0.169013] ACPI: Added _OSI(Processor Device) [ 0.170010] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.171009] ACPI: Added _OSI(Processor Aggregator Device) [ 0.175454] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.177716] ACPI: Interpreter enabled [ 0.178051] ACPI: PM: (supports S0 S3 S4 S5) [ 0.179010] ACPI: Using IOAPIC for interrupt routing [ 0.180088] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.181381] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.192127] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.193036] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.194015] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.195128] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.197356] acpiphp: Slot [2] registered [ 0.198115] acpiphp: Slot [5] registered [ 0.199116] acpiphp: Slot [6] registered [ 0.200108] acpiphp: Slot [3] registered [ 0.201096] acpiphp: Slot [4] registered [ 0.202080] acpiphp: Slot [7] registered [ 0.203067] acpiphp: Slot [8] registered [ 0.204068] acpiphp: Slot [9] registered [ 0.205063] acpiphp: Slot [10] registered [ 0.206087] acpiphp: Slot [11] registered [ 0.207074] acpiphp: Slot [12] registered [ 0.208096] acpiphp: Slot [13] registered [ 0.209091] acpiphp: Slot [14] registered [ 0.210077] acpiphp: Slot [15] registered [ 0.211070] acpiphp: Slot [16] registered [ 0.212070] acpiphp: Slot [17] registered [ 0.213071] acpiphp: Slot [18] registered [ 0.214114] acpiphp: Slot [19] registered [ 0.215085] acpiphp: Slot [20] registered [ 0.216077] acpiphp: Slot [21] registered [ 0.217096] acpiphp: Slot [22] registered [ 0.218072] acpiphp: Slot [23] registered [ 0.219071] acpiphp: Slot [24] registered [ 0.220066] acpiphp: Slot [25] registered [ 0.221089] acpiphp: Slot [26] registered [ 0.222088] acpiphp: Slot [27] registered [ 0.223071] acpiphp: Slot [28] registered [ 0.224147] acpiphp: Slot [29] registered [ 0.225074] acpiphp: Slot [30] registered [ 0.226069] acpiphp: Slot [31] registered [ 0.227050] PCI host bridge to bus 0000:00 [ 0.228012] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.229015] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.230030] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.231021] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.232017] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.233020] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.234152] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.235932] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.237249] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.241866] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.244067] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.245015] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.246023] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.247024] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.248719] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.249884] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.250046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.251916] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.253940] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.260015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.263015] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.272245] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.280015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.287016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.303030] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.312602] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.320014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.325015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.338016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.351152] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.353486] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.356723] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.359533] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.361401] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.367042] iommu: Default domain type: Passthrough [ 0.368502] SCSI subsystem initialized [ 0.371142] ACPI: bus type USB registered [ 0.373140] usbcore: registered new interface driver usbfs [ 0.377115] usbcore: registered new interface driver hub [ 0.381122] usbcore: registered new device driver usb [ 0.383178] pps_core: LinuxPPS API ver. 1 registered [ 0.386011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.389070] PTP clock support registered [ 0.391320] EDAC MC: Ver: 3.0.0 [ 0.393222] PCI: Using ACPI for IRQ routing [ 0.395898] NetLabel: Initializing [ 0.397011] NetLabel: domain hash size = 128 [ 0.398010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.400072] NetLabel: unlabeled traffic allowed by default [ 0.402353] vgaarb: loaded [ 0.404008] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.406013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.414235] clocksource: Switched to clocksource kvm-clock [ 0.532645] VFS: Disk quotas dquot_6.6.0 [ 0.534229] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.536743] *** VALIDATE ramfs *** [ 0.538176] *** VALIDATE hugetlbfs *** [ 0.539668] pnp: PnP ACPI init [ 0.542166] pnp: PnP ACPI: found 6 devices [ 0.559116] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.563381] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.565239] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.566732] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.569063] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.571612] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.574600] NET: Registered protocol family 2 [ 0.577741] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.585121] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.588043] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.593339] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.597771] TCP: Hash tables configured (established 65536 bind 65536) [ 0.603776] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.606714] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.609710] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.612386] NET: Registered protocol family 1 [ 0.614262] RPC: Registered named UNIX socket transport module. [ 0.616501] RPC: Registered udp transport module. [ 0.617508] RPC: Registered tcp transport module. [ 0.618463] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.619859] NET: Registered protocol family 44 [ 0.620977] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.622309] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.624109] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.626294] PCI: CLS 0 bytes, default 64 [ 0.627951] Unpacking initramfs... [ 2.222138] debug: unmapping init [mem 0xffff9bc5fcc64000-0xffff9bc5fffcffff] [ 2.229240] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.231596] software IO TLB: mapped [mem 0x00000000b8c64000-0x00000000bcc64000] (64MB) [ 2.234749] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 2.747222] Initialise system trusted keyrings [ 2.748597] Key type blacklist registered [ 2.750490] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.759941] zbud: loaded [ 2.763067] *** VALIDATE nfs *** [ 2.764584] *** VALIDATE nfs4 *** [ 2.766360] pstore: using deflate compression [ 2.770277] Platform Keyring initialized [ 2.879796] NET: Registered protocol family 38 [ 2.880949] Key type asymmetric registered [ 2.881796] Asymmetric key parser 'x509' registered [ 2.882813] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.884593] io scheduler mq-deadline registered [ 2.885467] io scheduler kyber registered [ 2.886533] io scheduler bfq registered [ 2.887733] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.889364] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.890985] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.892758] ACPI: Power Button [PWRF] [ 2.896719] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.900777] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.916562] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.949892] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.981795] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.986440] Non-volatile memory driver v1.3 [ 2.988234] Linux agpgart interface v0.103 [ 3.019256] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 3.022031] vda: detected capacity change from 0 to 73097216 [ 3.206348] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.209931] vdb: detected capacity change from 0 to 1073741824 [ 3.217316] libphy: Fixed MDIO Bus: probed [ 3.251653] usbcore: registered new interface driver usbserial_generic [ 3.255264] usbserial: USB Serial support registered for generic [ 3.258447] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.263822] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.266253] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.269348] mousedev: PS/2 mouse device common for all mice [ 3.273181] rtc_cmos 00:05: RTC can wake from S4 [ 3.277763] rtc_cmos 00:05: registered as rtc0 [ 3.279887] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.282165] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.285452] intel_pstate: CPU model not supported [ 3.293626] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.297365] hid: raw HID events driver (C) Jiri Kosina [ 3.300242] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.301669] usbcore: registered new interface driver usbhid [ 3.308708] usbhid: USB HID core driver [ 3.310407] drop_monitor: Initializing network drop monitor service [ 3.312657] Initializing XFRM netlink socket [ 3.314740] NET: Registered protocol family 10 [ 3.317681] Segment Routing with IPv6 [ 3.319246] NET: Registered protocol family 17 [ 3.321117] mpls_gso: MPLS GSO support [ 3.327276] RAS: Correctable Errors collector initialized. [ 3.328872] AVX version of gcm_enc/dec engaged. [ 3.330493] AES CTR mode by8 optimization enabled [ 3.432613] sched_clock: Marking stable (3432491232, 0)->(4431904388, -999413156) [ 3.443389] registered taskstats version 1 [ 3.447277] Loading compiled-in X.509 certificates [ 3.451467] zswap: loaded using pool lzo/zbud [ 3.579768] Key type big_key registered [ 3.593859] Key type encrypted registered [ 3.595931] ima: No TPM chip found, activating TPM-bypass! [ 3.598509] ima: Allocated hash algorithm: sha1 [ 3.600396] ima: No architecture policies found [ 3.601583] evm: Initialising EVM extended attributes: [ 3.602819] evm: security.selinux [ 3.603584] evm: security.ima [ 3.604353] evm: security.capability [ 3.605179] evm: HMAC attrs: 0x1 [ 3.609138] rtc_cmos 00:05: setting system clock to 2026-09-10 16:23:54 UTC (1789057434) [ 3.613077] debug: unmapping init [mem 0xffffffff9f803000-0xffffffff9f9fffff] [ 3.615057] debug: unmapping init [mem 0xffffffff9e582000-0xffffffff9e858fff] [ 3.623187] Write protecting the kernel read-only data: 28672k [ 3.626715] debug: unmapping init [mem 0xffffffff9cc03000-0xffffffff9cdfffff] [ 3.629771] debug: unmapping init [mem 0xffffffff9d514000-0xffffffff9d5fffff] [ 3.674932] 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.683293] systemd[1]: Detected virtualization kvm. [ 3.685432] systemd[1]: Detected architecture x86-64. [ 3.687474] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.719079] systemd[1]: No hostname configured. [ 3.720302] systemd[1]: Set hostname to . [ 3.721787] random: systemd: uninitialized urandom read (16 bytes read) [ 3.723729] systemd[1]: Initializing machine ID from random generator. [ 3.802135] random: ln: uninitialized urandom read (6 bytes read) [ 3.956948] random: systemd: uninitialized urandom read (16 bytes read) [ 3.961610] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.966690] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.988386] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Swap. Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Reached target Initrd Root Device. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 5.447317] device-mapper: uevent: version 1.0.3 [ 5.458775] 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. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 8.006557] virtio_net virtio0 ens2: renamed from eth0 [ 8.500291] scsi host0: ata_piix [ 8.595771] scsi host1: ata_piix [ 8.598055] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 8.607506] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 14.120638] random: crng init done [ 14.134328] random: 7 urandom warning(s) missed due to ratelimiting [ 15.184914] dracut-initqueue[590]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ 17.422917] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Reached target Remote File Systems. [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ 18.056881] hrtimer: interrupt took 12962297 ns [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 21.932271] printk: systemd: 26 output lines suppressed due to ratelimiting [ 23.394225] SELinux: Disabled at runtime. [ 23.613051] 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) [ 23.649383] systemd[1]: Detected virtualization kvm. [ 23.651179] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 25.833869] systemd[1]: initrd-switch-root.service: Succeeded. [ 25.855416] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 25.884096] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 25.893782] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 25.908702] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 25.931610] systemd[1]: Starting Journal Service... Starting Journal Service... [ 25.948491] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice User and Session Slice. Mounting POSIX Message Queue File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. Starting Apply Kernel Variables... [ OK ] Created slice system-getty.slice. Starting Remount Root and Kernel[ 26.236129] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS File Systems... [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Huge Pages File System... [ OK ] Reached target rpc_pipefs.target. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... [ OK ] Reached target Paths. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. 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 udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 27.899754] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 30.147660] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 30.318912] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 31.451279] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 31.664974] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 35.684133] Key type dns_resolver registered [ *** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (10s / no limit)[ 36.691152] NFS: Registering the id_resolver key type [ 36.694046] Key type id_resolver registered [ 36.697018] Key type id_legacy registered [ ***] A start job is running for Configur…only root support (11s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg142-client login: [ 119.920167] libcfs: loading out-of-tree module taints kernel. [ 120.024509] Key type ._llcrypt registered [ 120.075418] Key type .llcrypt registered [ 120.685349] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 120.699970] alg: No test for adler32 (adler32-zlib) [ 122.562197] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 123.588302] LNet: Added LNI 192.168.201.42@tcp [8/256/0/180] [ 125.480098] Key type lgssc registered [ 127.080985] Lustre: Echo OBD driver; http://www.lustre.org/ [ 132.284264] alg: No test for zstdfast (zstdfast-lustre-generic) [ 132.293893] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 294.519556] Lustre: Mounted lustre-client [ 299.472299] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 310.702940] Lustre: DEBUG MARKER: oleg142-client.virtnet: executing check_logdir /tmp/testlogs/ [ 315.284594] Lustre: DEBUG MARKER: oleg142-client.virtnet: executing yml_node [ 319.896858] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 319.976842] Lustre: lustre-OST0000-osc-ffff9bc64b2c1800: disconnect after 23s idle [ 322.507709] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 324.859857] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 326.767596] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:29:15 EDT 2026 [ 348.456500] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 351.017949] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 353.513517] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a 130b 130c 130d 130e 130f 130g [ 356.753756] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51b 51c 51e 834 [ 359.250786] Lustre: DEBUG MARKER: === sanity: start setup 12:29:47 (1789057787) === [ 365.866782] Lustre: DEBUG MARKER: oleg142-client.virtnet: executing check_config_client /mnt/lustre [ 388.392653] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 405.833416] Lustre: DEBUG MARKER: === sanity: finish setup 12:30:34 (1789057834) === [ 413.477807] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:30:42 (1789057842) [ 414.117949] lustre_kcompr_23282: ***** [ 414.122592] lustre_kcompr_23282: (de)compression test on random binary data [ 414.126778] lustre_kcompr_23282: ***** [ 414.141618] lustre_kcompr_23282: compr lz4(1) in 64kB chunks took 5796 us (690 MB/s), compress ratio: 96.78 [ 414.150798] lustre_kcompr_23282: compr lz4(1) in 128kB chunks took 1697 us (2357 MB/s), compress ratio: 100.56 [ 414.160227] lustre_kcompr_23282: compr lz4(1) in 256kB chunks took 2961 us (1350 MB/s), compress ratio: 103.78 [ 414.167656] lustre_kcompr_23282: compr lz4(1) in 512kB chunks took 1500 us (2666 MB/s), compress ratio: 105.30 [ 414.179843] lustre_kcompr_23282: compr lz4(1) in 1024kB chunks took 7592 us (526 MB/s), compress ratio: 105.37 [ 414.190402] lustre_kcompr_23282: compr lz4(1) in 2048kB chunks took 1209 us (3308 MB/s), compress ratio: 105.66 [ 414.200619] lustre_kcompr_23282: compr lz4(1) in 4096kB chunks took 2811 us (1422 MB/s), compress ratio: 106.16 [ 414.217168] lustre_kcompr_23282: decompr lz4(1) took 4891 us (7 MB/s) [ 414.220973] lustre_kcompr_23282: test_comp_compress_decompress(lz4,1) ret 0 [ 414.225297] lustre_kcompr_23282: acompr lz4(1) of 128kB chunks took 89 us (1404 MB/s), compress ratio: 90.14 [ 414.229665] lustre_kcompr_23282: adecompr lz4(1) took 98 us (14 MB/s) [ 414.234846] lustre_kcompr_23282: test_acomp_compress_decompress(lz4,1) ret 0 [ 414.249831] lustre_kcompr_23282: compr lz4(4) in 64kB chunks took 2066 us (1936 MB/s), compress ratio: 82.38 [ 414.259733] lustre_kcompr_23282: compr lz4(4) in 128kB chunks took 2906 us (1376 MB/s), compress ratio: 91.34 [ 414.272931] lustre_kcompr_23282: compr lz4(4) in 256kB chunks took 1664 us (2403 MB/s), compress ratio: 97.49 [ 414.282593] lustre_kcompr_23282: compr lz4(4) in 512kB chunks took 2310 us (1731 MB/s), compress ratio: 100.67 [ 414.295992] lustre_kcompr_23282: compr lz4(4) in 1024kB chunks took 1509 us (2650 MB/s), compress ratio: 102.19 [ 414.304810] lustre_kcompr_23282: compr lz4(4) in 2048kB chunks took 2079 us (1924 MB/s), compress ratio: 103.31 [ 414.313793] lustre_kcompr_23282: compr lz4(4) in 4096kB chunks took 1965 us (2035 MB/s), compress ratio: 103.93 [ 414.339425] lustre_kcompr_23282: decompr lz4(4) took 5012 us (7 MB/s) [ 414.355626] lustre_kcompr_23282: test_comp_compress_decompress(lz4,4) ret 0 [ 414.369799] lustre_kcompr_23282: acompr lz4(4) of 128kB chunks took 83 us (1506 MB/s), compress ratio: 80.95 [ 414.382652] lustre_kcompr_23282: adecompr lz4(4) took 1271 us (1 MB/s) [ 414.440877] lustre_kcompr_23282: test_acomp_compress_decompress(lz4,4) ret 0 [ 414.480802] lustre_kcompr_23282: compr lz4(9) in 64kB chunks took 2062 us (1939 MB/s), compress ratio: 60.65 [ 414.503356] lustre_kcompr_23282: compr lz4(9) in 128kB chunks took 10503 us (380 MB/s), compress ratio: 75.29 [ 414.527982] lustre_kcompr_23282: compr lz4(9) in 256kB chunks took 3383 us (1182 MB/s), compress ratio: 86.86 [ 414.544767] lustre_kcompr_23282: compr lz4(9) in 512kB chunks took 1290 us (3100 MB/s), compress ratio: 92.70 [ 414.565688] lustre_kcompr_23282: compr lz4(9) in 1024kB chunks took 2292 us (1745 MB/s), compress ratio: 96.57 [ 414.576301] lustre_kcompr_23282: compr lz4(9) in 2048kB chunks took 5934 us (674 MB/s), compress ratio: 99.09 [ 414.591875] lustre_kcompr_23282: compr lz4(9) in 4096kB chunks took 2097 us (1907 MB/s), compress ratio: 99.61 [ 414.613587] lustre_kcompr_23282: decompr lz4(9) took 2511 us (15 MB/s) [ 414.620623] lustre_kcompr_23282: test_comp_compress_decompress(lz4,9) ret 0 [ 414.626837] lustre_kcompr_23282: acompr lz4(9) of 128kB chunks took 87 us (1436 MB/s), compress ratio: 66.66 [ 414.632612] lustre_kcompr_23282: adecompr lz4(9) took 99 us (18 MB/s) [ 414.637459] lustre_kcompr_23282: test_acomp_compress_decompress(lz4,9) ret 0 [ 414.654792] lustre_kcompr_23282: compr lz4(15) in 64kB chunks took 2363 us (1692 MB/s), compress ratio: 29.35 [ 414.673096] lustre_kcompr_23282: compr lz4(15) in 128kB chunks took 7136 us (560 MB/s), compress ratio: 43.04 [ 414.697515] lustre_kcompr_23282: compr lz4(15) in 256kB chunks took 3233 us (1237 MB/s), compress ratio: 58.55 [ 414.724079] lustre_kcompr_23282: compr lz4(15) in 512kB chunks took 9699 us (412 MB/s), compress ratio: 70.87 [ 414.739047] lustre_kcompr_23282: compr lz4(15) in 1024kB chunks took 1507 us (2654 MB/s), compress ratio: 79.25 [ 414.746821] lustre_kcompr_23282: compr lz4(15) in 2048kB chunks took 1909 us (2095 MB/s), compress ratio: 83.57 [ 414.764244] lustre_kcompr_23282: compr lz4(15) in 4096kB chunks took 2777 us (1440 MB/s), compress ratio: 84.89 [ 414.795658] lustre_kcompr_23282: decompr lz4(15) took 3979 us (11 MB/s) [ 414.806536] lustre_kcompr_23282: test_comp_compress_decompress(lz4,15) ret 0 [ 414.813122] lustre_kcompr_23282: acompr lz4(15) of 128kB chunks took 89 us (1404 MB/s), compress ratio: 40.99 [ 414.825895] lustre_kcompr_23282: adecompr lz4(15) took 115 us (26 MB/s) [ 414.847872] lustre_kcompr_23282: test_acomp_compress_decompress(lz4,15) ret 0 [ 414.921633] lustre_kcompr_23282: compr lz4hc(1) in 64kB chunks took 55655 us (71 MB/s), compress ratio: 96.64 [ 414.980867] lustre_kcompr_23282: compr lz4hc(1) in 128kB chunks took 52263 us (76 MB/s), compress ratio: 102.40 [ 415.065140] lustre_kcompr_23282: compr lz4hc(1) in 256kB chunks took 64154 us (62 MB/s), compress ratio: 105.55 [ 415.125556] lustre_kcompr_23282: compr lz4hc(1) in 512kB chunks took 51466 us (77 MB/s), compress ratio: 107.19 [ 415.194153] lustre_kcompr_23282: compr lz4hc(1) in 1024kB chunks took 52211 us (76 MB/s), compress ratio: 108.04 [ 415.256872] lustre_kcompr_23282: compr lz4hc(1) in 2048kB chunks took 50838 us (78 MB/s), compress ratio: 108.47 [ 415.328314] lustre_kcompr_23282: compr lz4hc(1) in 4096kB chunks took 52756 us (75 MB/s), compress ratio: 108.69 [ 415.368790] lustre_kcompr_23282: decompr lz4hc(1) took 8208 us (4 MB/s) [ 415.375717] lustre_kcompr_23282: test_comp_compress_decompress(lz4hc,1) ret 0 [ 415.389740] lustre_kcompr_23282: acompr lz4hc(1) of 128kB chunks took 1047 us (119 MB/s), compress ratio: 90.58 [ 415.412725] lustre_kcompr_23282: adecompr lz4hc(1) took 3398 us (0 MB/s) [ 415.487313] lustre_kcompr_23282: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 415.626570] lustre_kcompr_23282: compr lz4hc(3) in 64kB chunks took 97286 us (41 MB/s), compress ratio: 97.18 [ 415.728728] lustre_kcompr_23282: compr lz4hc(3) in 128kB chunks took 91568 us (43 MB/s), compress ratio: 102.95 [ 415.869996] lustre_kcompr_23282: compr lz4hc(3) in 256kB chunks took 105470 us (37 MB/s), compress ratio: 106.11 [ 415.991717] lustre_kcompr_23282: compr lz4hc(3) in 512kB chunks took 108610 us (36 MB/s), compress ratio: 107.77 [ 416.117397] lustre_kcompr_23282: compr lz4hc(3) in 1024kB chunks took 112017 us (35 MB/s), compress ratio: 108.61 [ 416.215698] lustre_kcompr_23282: compr lz4hc(3) in 2048kB chunks took 83666 us (47 MB/s), compress ratio: 109.05 [ 416.317553] lustre_kcompr_23282: compr lz4hc(3) in 4096kB chunks took 80588 us (49 MB/s), compress ratio: 109.27 [ 416.358730] lustre_kcompr_23282: decompr lz4hc(3) took 2841 us (12 MB/s) [ 416.366557] lustre_kcompr_23282: test_comp_compress_decompress(lz4hc,3) ret 0 [ 416.383809] lustre_kcompr_23282: acompr lz4hc(3) of 128kB chunks took 5106 us (24 MB/s), compress ratio: 91.40 [ 416.400066] lustre_kcompr_23282: adecompr lz4hc(3) took 95 us (14 MB/s) [ 416.423248] lustre_kcompr_23282: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 417.246200] lustre_kcompr_23282: compr lz4hc(8) in 64kB chunks took 776289 us (5 MB/s), compress ratio: 103.61 [ 417.854932] lustre_kcompr_23282: compr lz4hc(8) in 128kB chunks took 596568 us (6 MB/s), compress ratio: 110.56 [ 419.030048] lustre_kcompr_23282: compr lz4hc(8) in 256kB chunks took 1171249 us (3 MB/s), compress ratio: 114.39 [ 420.100791] lustre_kcompr_23282: compr lz4hc(8) in 512kB chunks took 1066374 us (3 MB/s), compress ratio: 116.41 [ 421.631797] lustre_kcompr_23282: compr lz4hc(8) in 1024kB chunks took 1524873 us (2 MB/s), compress ratio: 117.42 [ 422.607201] lustre_kcompr_23282: compr lz4hc(8) in 2048kB chunks took 966744 us (4 MB/s), compress ratio: 117.94 [ 423.458316] lustre_kcompr_23282: compr lz4hc(8) in 4096kB chunks took 833844 us (4 MB/s), compress ratio: 118.19 [ 423.476229] lustre_kcompr_23282: decompr lz4hc(8) took 5771 us (5 MB/s) [ 423.480831] lustre_kcompr_23282: test_comp_compress_decompress(lz4hc,8) ret 0 [ 423.522843] lustre_kcompr_23282: acompr lz4hc(8) of 128kB chunks took 32350 us (3 MB/s), compress ratio: 98.84 [ 423.531685] lustre_kcompr_23282: adecompr lz4hc(8) took 96 us (13 MB/s) [ 423.572699] lustre_kcompr_23282: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 424.462819] lustre_kcompr_23282: compr lz4hc(15) in 64kB chunks took 863334 us (4 MB/s), compress ratio: 104.20 [ 425.694548] lustre_kcompr_23282: compr lz4hc(15) in 128kB chunks took 1224686 us (3 MB/s), compress ratio: 111.53 [ 427.465265] lustre_kcompr_23282: compr lz4hc(15) in 256kB chunks took 1765547 us (2 MB/s), compress ratio: 115.66 [ 427.494993] Lustre: lustre-OST0000-osc-ffff9bc64b2c1800: disconnect after 21s idle [ 427.500280] Lustre: Skipped 1 previous similar message [ 428.837867] lustre_kcompr_23282: compr lz4hc(15) in 512kB chunks took 1366560 us (2 MB/s), compress ratio: 117.82 [ 430.282587] lustre_kcompr_23282: compr lz4hc(15) in 1024kB chunks took 1433842 us (2 MB/s), compress ratio: 118.90 [ 431.744282] lustre_kcompr_23282: compr lz4hc(15) in 2048kB chunks took 1447578 us (2 MB/s), compress ratio: 119.45 [ 433.004228] lustre_kcompr_23282: compr lz4hc(15) in 4096kB chunks took 1249153 us (3 MB/s), compress ratio: 119.74 [ 433.018299] lustre_kcompr_23282: decompr lz4hc(15) took 2262 us (14 MB/s) [ 433.021980] lustre_kcompr_23282: test_comp_compress_decompress(lz4hc,15) ret 0 [ 433.121743] lustre_kcompr_23282: acompr lz4hc(15) of 128kB chunks took 95406 us (1 MB/s), compress ratio: 99.44 [ 433.135637] lustre_kcompr_23282: adecompr lz4hc(15) took 739 us (1 MB/s) [ 433.147372] lustre_kcompr_23282: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 433.162449] lustre_kcompr_23282: compr lzo(-1) in 64kB chunks took 6603 us (605 MB/s), compress ratio: 81.48 [ 433.174719] lustre_kcompr_23282: compr lzo(-1) in 128kB chunks took 5020 us (796 MB/s), compress ratio: 85.62 [ 433.184766] lustre_kcompr_23282: compr lzo(-1) in 256kB chunks took 3439 us (1163 MB/s), compress ratio: 86.40 [ 433.196259] lustre_kcompr_23282: compr lzo(-1) in 512kB chunks took 2733 us (1463 MB/s), compress ratio: 87.38 [ 433.207372] lustre_kcompr_23282: compr lzo(-1) in 1024kB chunks took 2634 us (1518 MB/s), compress ratio: 87.37 [ 433.216621] lustre_kcompr_23282: compr lzo(-1) in 2048kB chunks took 3062 us (1306 MB/s), compress ratio: 88.08 [ 433.226789] lustre_kcompr_23282: compr lzo(-1) in 4096kB chunks took 4701 us (850 MB/s), compress ratio: 88.12 [ 433.242547] lustre_kcompr_23282: decompr lzo(-1) took 2190 us (20 MB/s) [ 433.247385] lustre_kcompr_23282: test_comp_compress_decompress(lzo,-1) ret 0 [ 433.251977] lustre_kcompr_23282: acompr lzo(-1) of 128kB chunks took 144 us (868 MB/s), compress ratio: 79.24 [ 433.258644] lustre_kcompr_23282: adecompr lzo(-1) took 730 us (2 MB/s) [ 433.265622] lustre_kcompr_23282: test_acomp_compress_decompress(lzo,-1) ret 0 [ 433.611204] lustre_kcompr_23282: compr deflate(1) in 64kB chunks took 333220 us (12 MB/s), compress ratio: 97.09 [ 434.115516] lustre_kcompr_23282: compr deflate(1) in 128kB chunks took 488987 us (8 MB/s), compress ratio: 106.95 [ 434.642063] lustre_kcompr_23282: compr deflate(1) in 256kB chunks took 519251 us (7 MB/s), compress ratio: 113.13 [ 435.091950] lustre_kcompr_23282: compr deflate(1) in 512kB chunks took 442487 us (9 MB/s), compress ratio: 116.93 [ 435.570230] lustre_kcompr_23282: compr deflate(1) in 1024kB chunks took 467001 us (8 MB/s), compress ratio: 118.89 [ 435.967368] lustre_kcompr_23282: compr deflate(1) in 2048kB chunks took 392106 us (10 MB/s), compress ratio: 119.82 [ 436.266872] lustre_kcompr_23282: compr deflate(1) in 4096kB chunks took 296275 us (13 MB/s), compress ratio: 120.09 [ 436.319708] lustre_kcompr_23282: decompr deflate(1) took 11973 us (2 MB/s) [ 436.350742] lustre_kcompr_23282: test_comp_compress_decompress(deflate,1) ret 0 [ 436.387041] lustre_kcompr_23282: acompr deflate(1) of 128kB chunks took 24227 us (5 MB/s), compress ratio: 95.18 [ 436.399712] lustre_kcompr_23282: adecompr deflate(1) took 198 us (6 MB/s) [ 436.430652] lustre_kcompr_23282: test_acomp_compress_decompress(deflate,1) ret 0 [ 436.925606] lustre_kcompr_23282: compr deflate(6) in 64kB chunks took 457146 us (8 MB/s), compress ratio: 97.09 [ 437.459879] lustre_kcompr_23282: compr deflate(6) in 128kB chunks took 523818 us (7 MB/s), compress ratio: 106.95 [ 437.987484] lustre_kcompr_23282: compr deflate(6) in 256kB chunks took 520637 us (7 MB/s), compress ratio: 113.13 [ 438.432653] lustre_kcompr_23282: compr deflate(6) in 512kB chunks took 437868 us (9 MB/s), compress ratio: 116.93 [ 438.703842] lustre_kcompr_23282: compr deflate(6) in 1024kB chunks took 263593 us (15 MB/s), compress ratio: 118.89 [ 439.155608] lustre_kcompr_23282: compr deflate(6) in 2048kB chunks took 431366 us (9 MB/s), compress ratio: 119.82 [ 439.743346] lustre_kcompr_23282: compr deflate(6) in 4096kB chunks took 580437 us (6 MB/s), compress ratio: 120.09 [ 439.781840] lustre_kcompr_23282: decompr deflate(6) took 12143 us (2 MB/s) [ 439.802884] lustre_kcompr_23282: test_comp_compress_decompress(deflate,6) ret 0 [ 439.835420] lustre_kcompr_23282: acompr deflate(6) of 128kB chunks took 19980 us (6 MB/s), compress ratio: 95.18 [ 439.847607] lustre_kcompr_23282: adecompr deflate(6) took 179 us (7 MB/s) [ 439.874257] lustre_kcompr_23282: test_acomp_compress_decompress(deflate,6) ret 0 [ 440.534340] lustre_kcompr_23282: compr deflate(9) in 64kB chunks took 618675 us (6 MB/s), compress ratio: 97.09 [ 440.853729] lustre_kcompr_23282: compr deflate(9) in 128kB chunks took 312426 us (12 MB/s), compress ratio: 106.95 [ 441.165099] lustre_kcompr_23282: compr deflate(9) in 256kB chunks took 306623 us (13 MB/s), compress ratio: 113.13 [ 441.650868] lustre_kcompr_23282: compr deflate(9) in 512kB chunks took 476617 us (8 MB/s), compress ratio: 116.93 [ 442.029767] lustre_kcompr_23282: compr deflate(9) in 1024kB chunks took 372300 us (10 MB/s), compress ratio: 118.89 [ 442.542629] lustre_kcompr_23282: compr deflate(9) in 2048kB chunks took 504933 us (7 MB/s), compress ratio: 119.82 [ 443.031735] lustre_kcompr_23282: compr deflate(9) in 4096kB chunks took 472945 us (8 MB/s), compress ratio: 120.09 [ 443.065752] lustre_kcompr_23282: decompr deflate(9) took 7517 us (4 MB/s) [ 443.081131] lustre_kcompr_23282: test_comp_compress_decompress(deflate,9) ret 0 [ 443.110192] lustre_kcompr_23282: acompr deflate(9) of 128kB chunks took 15840 us (7 MB/s), compress ratio: 95.18 [ 443.120782] lustre_kcompr_23282: adecompr deflate(9) took 385 us (3 MB/s) [ 443.132605] lustre_kcompr_23282: test_acomp_compress_decompress(deflate,9) ret 0 [ 443.189163] lustre_kcompr_23282: compr zstd(0) in 64kB chunks took 17361 us (230 MB/s), compress ratio: 156.90 [ 443.235860] lustre_kcompr_23282: compr zstd(0) in 128kB chunks took 30393 us (131 MB/s), compress ratio: 188.07 [ 443.278560] lustre_kcompr_23282: compr zstd(0) in 256kB chunks took 33862 us (118 MB/s), compress ratio: 198.95 [ 443.299350] lustre_kcompr_23282: compr zstd(0) in 512kB chunks took 14626 us (273 MB/s), compress ratio: 204.80 [ 443.314099] lustre_kcompr_23282: compr zstd(0) in 1024kB chunks took 9591 us (417 MB/s), compress ratio: 207.12 [ 443.334434] lustre_kcompr_23282: compr zstd(0) in 2048kB chunks took 12882 us (310 MB/s), compress ratio: 208.34 [ 443.354769] lustre_kcompr_23282: compr zstd(0) in 4096kB chunks took 6572 us (608 MB/s), compress ratio: 208.98 [ 443.372622] lustre_kcompr_23282: decompr zstd(0) took 3525 us (5 MB/s) [ 443.377698] lustre_kcompr_23282: test_comp_compress_decompress(zstd,0) ret 0 [ 443.390657] lustre_kcompr_23282: acompr zstd(0) of 128kB chunks took 905 us (138 MB/s), compress ratio: 153.12 [ 443.412173] lustre_kcompr_23282: adecompr zstd(0) took 312 us (2 MB/s) [ 443.436786] lustre_kcompr_23282: test_acomp_compress_decompress(zstd,0) ret 0 [ 443.474048] lustre_kcompr_23282: compr zstd(1) in 64kB chunks took 2796 us (1430 MB/s), compress ratio: 155.99 [ 443.488485] lustre_kcompr_23282: compr zstd(1) in 128kB chunks took 2321 us (1723 MB/s), compress ratio: 187.55 [ 443.501444] lustre_kcompr_23282: compr zstd(1) in 256kB chunks took 4020 us (995 MB/s), compress ratio: 198.33 [ 443.511305] lustre_kcompr_23282: compr zstd(1) in 512kB chunks took 4751 us (841 MB/s), compress ratio: 204.31 [ 443.520645] lustre_kcompr_23282: compr zstd(1) in 1024kB chunks took 4137 us (966 MB/s), compress ratio: 206.84 [ 443.544735] lustre_kcompr_23282: compr zstd(1) in 2048kB chunks took 8129 us (492 MB/s), compress ratio: 208.12 [ 443.559975] lustre_kcompr_23282: compr zstd(1) in 4096kB chunks took 2512 us (1592 MB/s), compress ratio: 207.28 [ 443.581233] lustre_kcompr_23282: decompr zstd(1) took 2037 us (9 MB/s) [ 443.588780] lustre_kcompr_23282: test_comp_compress_decompress(zstd,1) ret 0 [ 443.604680] lustre_kcompr_23282: acompr zstd(1) of 128kB chunks took 1414 us (88 MB/s), compress ratio: 158.29 [ 443.616497] lustre_kcompr_23282: adecompr zstd(1) took 104 us (7 MB/s) [ 443.632659] lustre_kcompr_23282: test_acomp_compress_decompress(zstd,1) ret 0 [ 443.859328] lustre_kcompr_23282: compr zstd(10) in 64kB chunks took 212923 us (18 MB/s), compress ratio: 158.62 [ 444.082326] lustre_kcompr_23282: compr zstd(10) in 128kB chunks took 212532 us (18 MB/s), compress ratio: 180.47 [ 444.330933] lustre_kcompr_23282: compr zstd(10) in 256kB chunks took 244060 us (16 MB/s), compress ratio: 191.63 [ 444.554989] lustre_kcompr_23282: compr zstd(10) in 512kB chunks took 216512 us (18 MB/s), compress ratio: 212.27 [ 444.866780] lustre_kcompr_23282: compr zstd(10) in 1024kB chunks took 297582 us (13 MB/s), compress ratio: 216.41 [ 445.377340] lustre_kcompr_23282: compr zstd(10) in 2048kB chunks took 497572 us (8 MB/s), compress ratio: 218.40 [ 445.503562] lustre_kcompr_23282: compr zstd(10) in 4096kB chunks took 116465 us (34 MB/s), compress ratio: 219.35 [ 445.541457] lustre_kcompr_23282: decompr zstd(10) took 9561 us (1 MB/s) [ 445.556825] lustre_kcompr_23282: test_comp_compress_decompress(zstd,10) ret 0 [ 445.586579] lustre_kcompr_23282: acompr zstd(10) of 128kB chunks took 15590 us (8 MB/s), compress ratio: 151.17 [ 445.599399] lustre_kcompr_23282: adecompr zstd(10) took 110 us (7 MB/s) [ 445.621250] lustre_kcompr_23282: test_acomp_compress_decompress(zstd,10) ret 0 [ 446.794884] lustre_kcompr_23282: compr zstd(15) in 64kB chunks took 1147558 us (3 MB/s), compress ratio: 167.53 [ 447.489298] lustre_kcompr_23282: compr zstd(15) in 128kB chunks took 688536 us (5 MB/s), compress ratio: 192.17 [ 447.986830] lustre_kcompr_23282: compr zstd(15) in 256kB chunks took 491270 us (8 MB/s), compress ratio: 205.84 [ 448.789480] lustre_kcompr_23282: compr zstd(15) in 512kB chunks took 796128 us (5 MB/s), compress ratio: 212.16 [ 449.602682] lustre_kcompr_23282: compr zstd(15) in 1024kB chunks took 800148 us (4 MB/s), compress ratio: 214.99 [ 451.432437] lustre_kcompr_23282: compr zstd(15) in 2048kB chunks took 1809652 us (2 MB/s), compress ratio: 215.18 [ 454.077600] lustre_kcompr_23282: compr zstd(15) in 4096kB chunks took 2640546 us (1 MB/s), compress ratio: 215.01 [ 454.140330] lustre_kcompr_23282: decompr zstd(15) took 13109 us (1 MB/s) [ 454.167313] lustre_kcompr_23282: test_comp_compress_decompress(zstd,15) ret 0 [ 454.244788] lustre_kcompr_23282: acompr zstd(15) of 128kB chunks took 59515 us (2 MB/s), compress ratio: 160.43 [ 454.258181] lustre_kcompr_23282: adecompr zstd(15) took 3430 us (0 MB/s) [ 454.291150] lustre_kcompr_23282: test_acomp_compress_decompress(zstd,15) ret 0 [ 454.351404] lustre_kcompr_23282: compr zstdfast(1) in 64kB chunks took 11957 us (334 MB/s), compress ratio: 156.00 [ 454.373543] lustre_kcompr_23282: compr zstdfast(1) in 128kB chunks took 11887 us (336 MB/s), compress ratio: 187.58 [ 454.410577] lustre_kcompr_23282: compr zstdfast(1) in 256kB chunks took 7798 us (512 MB/s), compress ratio: 198.31 [ 454.434610] lustre_kcompr_23282: compr zstdfast(1) in 512kB chunks took 8153 us (490 MB/s), compress ratio: 204.31 [ 454.469176] lustre_kcompr_23282: compr zstdfast(1) in 1024kB chunks took 7709 us (518 MB/s), compress ratio: 206.84 [ 454.488521] lustre_kcompr_23282: compr zstdfast(1) in 2048kB chunks took 8600 us (465 MB/s), compress ratio: 208.12 [ 454.511777] lustre_kcompr_23282: compr zstdfast(1) in 4096kB chunks took 10723 us (373 MB/s), compress ratio: 207.28 [ 454.545349] lustre_kcompr_23282: decompr zstdfast(1) took 3312 us (5 MB/s) [ 454.558640] lustre_kcompr_23282: test_comp_compress_decompress(zstdfast,1) ret 0 [ 454.572394] lustre_kcompr_23282: acompr zstdfast(1) of 128kB chunks took 148 us (844 MB/s), compress ratio: 158.29 [ 454.599567] lustre_kcompr_23282: adecompr zstdfast(1) took 2162 us (0 MB/s) [ 454.716456] lustre_kcompr_23282: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 454.763569] lustre_kcompr_23282: compr zstdfast(5) in 64kB chunks took 9880 us (404 MB/s), compress ratio: 137.52 [ 454.800679] lustre_kcompr_23282: compr zstdfast(5) in 128kB chunks took 4925 us (812 MB/s), compress ratio: 162.51 [ 454.822055] lustre_kcompr_23282: compr zstdfast(5) in 256kB chunks took 1909 us (2095 MB/s), compress ratio: 171.92 [ 454.845186] lustre_kcompr_23282: compr zstdfast(5) in 512kB chunks took 4830 us (828 MB/s), compress ratio: 176.41 [ 454.875621] lustre_kcompr_23282: compr zstdfast(5) in 1024kB chunks took 6516 us (613 MB/s), compress ratio: 177.43 [ 454.891983] lustre_kcompr_23282: compr zstdfast(5) in 2048kB chunks took 4431 us (902 MB/s), compress ratio: 179.09 [ 454.929111] lustre_kcompr_23282: compr zstdfast(5) in 4096kB chunks took 13668 us (292 MB/s), compress ratio: 178.35 [ 454.971796] lustre_kcompr_23282: decompr zstdfast(5) took 6424 us (3 MB/s) [ 455.000089] lustre_kcompr_23282: test_comp_compress_decompress(zstdfast,5) ret 0 [ 455.016529] lustre_kcompr_23282: acompr zstdfast(5) of 128kB chunks took 136 us (919 MB/s), compress ratio: 136.53 [ 455.031333] lustre_kcompr_23282: adecompr zstdfast(5) took 1422 us (0 MB/s) [ 455.067980] lustre_kcompr_23282: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 455.110346] lustre_kcompr_23282: compr zstdfast(12) in 64kB chunks took 2472 us (1618 MB/s), compress ratio: 37.20 [ 455.147695] lustre_kcompr_23282: compr zstdfast(12) in 128kB chunks took 2280 us (1754 MB/s), compress ratio: 41.91 [ 455.165928] lustre_kcompr_23282: compr zstdfast(12) in 256kB chunks took 4376 us (914 MB/s), compress ratio: 44.28 [ 455.182526] lustre_kcompr_23282: compr zstdfast(12) in 512kB chunks took 5382 us (743 MB/s), compress ratio: 46.75 [ 455.202371] lustre_kcompr_23282: compr zstdfast(12) in 1024kB chunks took 8217 us (486 MB/s), compress ratio: 50.27 [ 455.215870] lustre_kcompr_23282: compr zstdfast(12) in 2048kB chunks took 1983 us (2017 MB/s), compress ratio: 57.53 [ 455.271217] lustre_kcompr_23282: compr zstdfast(12) in 4096kB chunks took 26811 us (149 MB/s), compress ratio: 57.81 [ 455.304981] lustre_kcompr_23282: decompr zstdfast(12) took 7153 us (9 MB/s) [ 455.323574] lustre_kcompr_23282: test_comp_compress_decompress(zstdfast,12) ret 0 [ 455.338232] lustre_kcompr_23282: acompr zstdfast(12) of 128kB chunks took 163 us (766 MB/s), compress ratio: 35.49 [ 455.358587] lustre_kcompr_23282: adecompr zstdfast(12) took 205 us (17 MB/s) [ 455.423472] lustre_kcompr_23282: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 455.453865] lustre_kcompr_23282: compr zstdfast(15) in 64kB chunks took 17154 us (233 MB/s), compress ratio: 18.59 [ 455.471554] lustre_kcompr_23282: compr zstdfast(15) in 128kB chunks took 1908 us (2096 MB/s), compress ratio: 19.53 [ 455.492644] lustre_kcompr_23282: compr zstdfast(15) in 256kB chunks took 5100 us (784 MB/s), compress ratio: 20.34 [ 455.504412] lustre_kcompr_23282: compr zstdfast(15) in 512kB chunks took 1934 us (2068 MB/s), compress ratio: 21.75 [ 455.524547] lustre_kcompr_23282: compr zstdfast(15) in 1024kB chunks took 3797 us (1053 MB/s), compress ratio: 22.53 [ 455.552991] lustre_kcompr_23282: compr zstdfast(15) in 2048kB chunks took 2441 us (1638 MB/s), compress ratio: 22.63 [ 455.576511] lustre_kcompr_23282: compr zstdfast(15) in 4096kB chunks took 5024 us (796 MB/s), compress ratio: 26.28 [ 455.620459] lustre_kcompr_23282: decompr zstdfast(15) took 8723 us (17 MB/s) [ 455.644323] lustre_kcompr_23282: test_comp_compress_decompress(zstdfast,15) ret 0 [ 455.658667] lustre_kcompr_23282: acompr zstdfast(15) of 128kB chunks took 421 us (296 MB/s), compress ratio: 14.99 [ 455.676809] lustre_kcompr_23282: adecompr zstdfast(15) took 114 us (73 MB/s) [ 455.726306] lustre_kcompr_23282: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 455.740391] lustre_kcompr_23282: SUCCESS [ 465.842964] lustre_kcompr_25197: ***** [ 465.861338] lustre_kcompr_25197: (de)compression test on provided file /tmp/f84.sanity [ 465.882877] lustre_kcompr_25197: ***** [ 465.976517] lustre_kcompr_25197: compr lz4(1) in 64kB chunks took 62118 us (64 MB/s), compress ratio: 2.93 [ 466.041147] lustre_kcompr_25197: compr lz4(1) in 128kB chunks took 44319 us (90 MB/s), compress ratio: 3.04 [ 466.086572] lustre_kcompr_25197: compr lz4(1) in 256kB chunks took 31345 us (127 MB/s), compress ratio: 3.08 [ 466.141213] lustre_kcompr_25197: compr lz4(1) in 512kB chunks took 49708 us (80 MB/s), compress ratio: 3.10 [ 466.214425] lustre_kcompr_25197: compr lz4(1) in 1024kB chunks took 65997 us (60 MB/s), compress ratio: 3.11 [ 466.274963] lustre_kcompr_25197: compr lz4(1) in 2048kB chunks took 48128 us (83 MB/s), compress ratio: 3.11 [ 466.330029] lustre_kcompr_25197: compr lz4(1) in 4096kB chunks took 41894 us (95 MB/s), compress ratio: 3.12 [ 466.372444] lustre_kcompr_25197: decompr lz4(1) took 27744 us (46 MB/s) [ 466.379251] lustre_kcompr_25197: test_comp_compress_decompress(lz4,1) ret 0 [ 466.391815] lustre_kcompr_25197: acompr lz4(1) of 128kB chunks took 1898 us (65 MB/s), compress ratio: 2.68 [ 466.414152] lustre_kcompr_25197: adecompr lz4(1) took 2036 us (22 MB/s) [ 466.448391] lustre_kcompr_25197: test_acomp_compress_decompress(lz4,1) ret 0 [ 466.550320] lustre_kcompr_25197: compr lz4(4) in 64kB chunks took 67423 us (59 MB/s), compress ratio: 2.67 [ 466.625308] lustre_kcompr_25197: compr lz4(4) in 128kB chunks took 55360 us (72 MB/s), compress ratio: 2.63 [ 466.681158] lustre_kcompr_25197: compr lz4(4) in 256kB chunks took 34866 us (114 MB/s), compress ratio: 2.68 [ 466.751261] lustre_kcompr_25197: compr lz4(4) in 512kB chunks took 56859 us (70 MB/s), compress ratio: 2.71 [ 466.785906] lustre_kcompr_25197: compr lz4(4) in 1024kB chunks took 27215 us (146 MB/s), compress ratio: 2.72 [ 466.821894] lustre_kcompr_25197: compr lz4(4) in 2048kB chunks took 29940 us (133 MB/s), compress ratio: 2.72 [ 466.856270] lustre_kcompr_25197: compr lz4(4) in 4096kB chunks took 27938 us (143 MB/s), compress ratio: 2.73 [ 466.884371] lustre_kcompr_25197: decompr lz4(4) took 8138 us (179 MB/s) [ 466.895643] lustre_kcompr_25197: test_comp_compress_decompress(lz4,4) ret 0 [ 466.906418] lustre_kcompr_25197: acompr lz4(4) of 128kB chunks took 560 us (223 MB/s), compress ratio: 2.30 [ 466.920752] lustre_kcompr_25197: adecompr lz4(4) took 166 us (326 MB/s) [ 466.938788] lustre_kcompr_25197: test_acomp_compress_decompress(lz4,4) ret 0 [ 467.020831] lustre_kcompr_25197: compr lz4(9) in 64kB chunks took 45823 us (87 MB/s), compress ratio: 2.30 [ 467.096951] lustre_kcompr_25197: compr lz4(9) in 128kB chunks took 64937 us (61 MB/s), compress ratio: 2.15 [ 467.154277] lustre_kcompr_25197: compr lz4(9) in 256kB chunks took 40922 us (97 MB/s), compress ratio: 2.20 [ 467.227502] lustre_kcompr_25197: compr lz4(9) in 512kB chunks took 42583 us (93 MB/s), compress ratio: 2.23 [ 467.307982] lustre_kcompr_25197: compr lz4(9) in 1024kB chunks took 62763 us (63 MB/s), compress ratio: 2.25 [ 467.388108] lustre_kcompr_25197: compr lz4(9) in 2048kB chunks took 66803 us (59 MB/s), compress ratio: 2.25 [ 467.493226] lustre_kcompr_25197: compr lz4(9) in 4096kB chunks took 78227 us (51 MB/s), compress ratio: 2.26 [ 467.564443] lustre_kcompr_25197: decompr lz4(9) took 39030 us (45 MB/s) [ 467.569700] lustre_kcompr_25197: test_comp_compress_decompress(lz4,9) ret 0 [ 467.581565] lustre_kcompr_25197: acompr lz4(9) of 128kB chunks took 494 us (253 MB/s), compress ratio: 1.87 [ 467.607679] lustre_kcompr_25197: adecompr lz4(9) took 6961 us (9 MB/s) [ 467.654607] lustre_kcompr_25197: test_acomp_compress_decompress(lz4,9) ret 0 [ 467.763508] lustre_kcompr_25197: compr lz4(15) in 64kB chunks took 59433 us (67 MB/s), compress ratio: 1.63 [ 467.822688] lustre_kcompr_25197: compr lz4(15) in 128kB chunks took 39389 us (101 MB/s), compress ratio: 1.52 [ 467.890287] lustre_kcompr_25197: compr lz4(15) in 256kB chunks took 46730 us (85 MB/s), compress ratio: 1.56 [ 467.974056] lustre_kcompr_25197: compr lz4(15) in 512kB chunks took 65077 us (61 MB/s), compress ratio: 1.58 [ 468.030882] lustre_kcompr_25197: compr lz4(15) in 1024kB chunks took 38459 us (104 MB/s), compress ratio: 1.60 [ 468.118033] lustre_kcompr_25197: compr lz4(15) in 2048kB chunks took 55679 us (71 MB/s), compress ratio: 1.60 [ 468.180252] lustre_kcompr_25197: compr lz4(15) in 4096kB chunks took 47876 us (83 MB/s), compress ratio: 1.60 [ 468.229984] lustre_kcompr_25197: decompr lz4(15) took 22864 us (108 MB/s) [ 468.244808] lustre_kcompr_25197: test_comp_compress_decompress(lz4,15) ret 0 [ 468.268074] lustre_kcompr_25197: acompr lz4(15) of 128kB chunks took 905 us (138 MB/s), compress ratio: 1.33 [ 468.280387] lustre_kcompr_25197: adecompr lz4(15) took 259 us (362 MB/s) [ 468.289064] lustre_kcompr_25197: test_acomp_compress_decompress(lz4,15) ret 0 [ 468.692656] lustre_kcompr_25197: compr lz4hc(1) in 64kB chunks took 323662 us (12 MB/s), compress ratio: 3.58 [ 469.012294] lustre_kcompr_25197: compr lz4hc(1) in 128kB chunks took 306062 us (13 MB/s), compress ratio: 3.77 [ 469.302789] lustre_kcompr_25197: compr lz4hc(1) in 256kB chunks took 283322 us (14 MB/s), compress ratio: 3.88 [ 469.415783] lustre_kcompr_25197: compr lz4hc(1) in 512kB chunks took 100576 us (39 MB/s), compress ratio: 3.93 [ 469.598268] lustre_kcompr_25197: compr lz4hc(1) in 1024kB chunks took 179187 us (22 MB/s), compress ratio: 3.96 [ 469.746468] lustre_kcompr_25197: compr lz4hc(1) in 2048kB chunks took 140980 us (28 MB/s), compress ratio: 3.97 [ 470.086850] lustre_kcompr_25197: compr lz4hc(1) in 4096kB chunks took 321566 us (12 MB/s), compress ratio: 3.98 [ 470.128308] lustre_kcompr_25197: decompr lz4hc(1) took 3245 us (309 MB/s) [ 470.138236] lustre_kcompr_25197: test_comp_compress_decompress(lz4hc,1) ret 0 [ 470.145444] lustre_kcompr_25197: acompr lz4hc(1) of 128kB chunks took 2909 us (42 MB/s), compress ratio: 3.27 [ 470.159261] lustre_kcompr_25197: adecompr lz4hc(1) took 321 us (119 MB/s) [ 470.168747] lustre_kcompr_25197: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 470.326892] lustre_kcompr_25197: compr lz4hc(3) in 64kB chunks took 140934 us (28 MB/s), compress ratio: 3.68 [ 470.527864] lustre_kcompr_25197: compr lz4hc(3) in 128kB chunks took 193927 us (20 MB/s), compress ratio: 3.91 [ 470.705390] lustre_kcompr_25197: compr lz4hc(3) in 256kB chunks took 169949 us (23 MB/s), compress ratio: 4.04 [ 470.833420] lustre_kcompr_25197: compr lz4hc(3) in 512kB chunks took 124570 us (32 MB/s), compress ratio: 4.10 [ 470.982565] lustre_kcompr_25197: compr lz4hc(3) in 1024kB chunks took 144603 us (27 MB/s), compress ratio: 4.13 [ 471.142565] lustre_kcompr_25197: compr lz4hc(3) in 2048kB chunks took 155163 us (25 MB/s), compress ratio: 4.15 [ 471.454057] lustre_kcompr_25197: compr lz4hc(3) in 4096kB chunks took 303619 us (13 MB/s), compress ratio: 4.16 [ 471.483953] lustre_kcompr_25197: decompr lz4hc(3) took 13921 us (69 MB/s) [ 471.489934] lustre_kcompr_25197: test_comp_compress_decompress(lz4hc,3) ret 0 [ 471.503240] lustre_kcompr_25197: acompr lz4hc(3) of 128kB chunks took 8010 us (15 MB/s), compress ratio: 3.38 [ 471.512357] lustre_kcompr_25197: adecompr lz4hc(3) took 309 us (119 MB/s) [ 471.519635] lustre_kcompr_25197: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 472.021375] lustre_kcompr_25197: compr lz4hc(8) in 64kB chunks took 484490 us (8 MB/s), compress ratio: 3.72 [ 472.914831] lustre_kcompr_25197: compr lz4hc(8) in 128kB chunks took 878630 us (4 MB/s), compress ratio: 3.96 [ 473.725685] lustre_kcompr_25197: compr lz4hc(8) in 256kB chunks took 796505 us (5 MB/s), compress ratio: 4.10 [ 474.038454] lustre_kcompr_25197: compr lz4hc(8) in 512kB chunks took 293796 us (13 MB/s), compress ratio: 4.17 [ 474.479861] lustre_kcompr_25197: compr lz4hc(8) in 1024kB chunks took 435305 us (9 MB/s), compress ratio: 4.21 [ 475.274887] lustre_kcompr_25197: compr lz4hc(8) in 2048kB chunks took 790614 us (5 MB/s), compress ratio: 4.22 [ 476.395613] lustre_kcompr_25197: compr lz4hc(8) in 4096kB chunks took 1112640 us (3 MB/s), compress ratio: 4.23 [ 476.485187] lustre_kcompr_25197: decompr lz4hc(8) took 36767 us (25 MB/s) [ 476.503341] lustre_kcompr_25197: test_comp_compress_decompress(lz4hc,8) ret 0 [ 476.593162] lustre_kcompr_25197: acompr lz4hc(8) of 128kB chunks took 68443 us (1 MB/s), compress ratio: 3.42 [ 476.606284] lustre_kcompr_25197: adecompr lz4hc(8) took 213 us (171 MB/s) [ 476.698807] lustre_kcompr_25197: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 477.428602] lustre_kcompr_25197: compr lz4hc(15) in 64kB chunks took 686413 us (5 MB/s), compress ratio: 3.72 [ 478.449410] lustre_kcompr_25197: compr lz4hc(15) in 128kB chunks took 1011048 us (3 MB/s), compress ratio: 3.96 [ 479.552897] lustre_kcompr_25197: compr lz4hc(15) in 256kB chunks took 1088541 us (3 MB/s), compress ratio: 4.10 [ 480.300307] lustre_kcompr_25197: compr lz4hc(15) in 512kB chunks took 737013 us (5 MB/s), compress ratio: 4.17 [ 481.185498] lustre_kcompr_25197: compr lz4hc(15) in 1024kB chunks took 861020 us (4 MB/s), compress ratio: 4.21 [ 482.145823] lustre_kcompr_25197: compr lz4hc(15) in 2048kB chunks took 957283 us (4 MB/s), compress ratio: 4.22 [ 483.042426] lustre_kcompr_25197: compr lz4hc(15) in 4096kB chunks took 880426 us (4 MB/s), compress ratio: 4.23 [ 483.065990] lustre_kcompr_25197: decompr lz4hc(15) took 4285 us (220 MB/s) [ 483.069696] lustre_kcompr_25197: test_comp_compress_decompress(lz4hc,15) ret 0 [ 483.112233] lustre_kcompr_25197: acompr lz4hc(15) of 128kB chunks took 32269 us (3 MB/s), compress ratio: 3.42 [ 483.118468] lustre_kcompr_25197: adecompr lz4hc(15) took 406 us (89 MB/s) [ 483.124796] lustre_kcompr_25197: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 483.148686] lustre_kcompr_25197: compr lzo(-1) in 64kB chunks took 19824 us (201 MB/s), compress ratio: 2.90 [ 483.207481] lustre_kcompr_25197: compr lzo(-1) in 128kB chunks took 54556 us (73 MB/s), compress ratio: 2.95 [ 483.251843] lustre_kcompr_25197: compr lzo(-1) in 256kB chunks took 33530 us (119 MB/s), compress ratio: 2.96 [ 483.271626] lustre_kcompr_25197: compr lzo(-1) in 512kB chunks took 17035 us (234 MB/s), compress ratio: 2.98 [ 483.314393] lustre_kcompr_25197: compr lzo(-1) in 1024kB chunks took 39524 us (101 MB/s), compress ratio: 2.97 [ 483.336363] lustre_kcompr_25197: compr lzo(-1) in 2048kB chunks took 18520 us (215 MB/s), compress ratio: 2.97 [ 483.361889] lustre_kcompr_25197: compr lzo(-1) in 4096kB chunks took 19030 us (210 MB/s), compress ratio: 2.96 [ 483.378160] lustre_kcompr_25197: decompr lzo(-1) took 8828 us (152 MB/s) [ 483.381831] lustre_kcompr_25197: test_comp_compress_decompress(lzo,-1) ret 0 [ 483.386670] lustre_kcompr_25197: acompr lzo(-1) of 128kB chunks took 692 us (180 MB/s), compress ratio: 2.62 [ 483.391178] lustre_kcompr_25197: adecompr lzo(-1) took 336 us (141 MB/s) [ 483.395849] lustre_kcompr_25197: test_acomp_compress_decompress(lzo,-1) ret 0 [ 483.817631] lustre_kcompr_25197: compr deflate(1) in 64kB chunks took 412789 us (9 MB/s), compress ratio: 3.51 [ 484.475727] lustre_kcompr_25197: compr deflate(1) in 128kB chunks took 652062 us (6 MB/s), compress ratio: 3.53 [ 485.060652] lustre_kcompr_25197: compr deflate(1) in 256kB chunks took 580482 us (6 MB/s), compress ratio: 3.53 [ 485.652103] lustre_kcompr_25197: compr deflate(1) in 512kB chunks took 585251 us (6 MB/s), compress ratio: 3.54 [ 487.018019] lustre_kcompr_25197: compr deflate(1) in 1024kB chunks took 1358964 us (2 MB/s), compress ratio: 3.54 [ 488.271143] lustre_kcompr_25197: compr deflate(1) in 2048kB chunks took 1241369 us (3 MB/s), compress ratio: 3.54 [ 488.985744] lustre_kcompr_25197: compr deflate(1) in 4096kB chunks took 698981 us (5 MB/s), compress ratio: 3.54 [ 489.024729] lustre_kcompr_25197: decompr deflate(1) took 29575 us (38 MB/s) [ 489.028492] lustre_kcompr_25197: test_comp_compress_decompress(deflate,1) ret 0 [ 489.054480] lustre_kcompr_25197: acompr deflate(1) of 128kB chunks took 18686 us (6 MB/s), compress ratio: 3.09 [ 489.060130] lustre_kcompr_25197: adecompr deflate(1) took 1067 us (37 MB/s) [ 489.066083] lustre_kcompr_25197: test_acomp_compress_decompress(deflate,1) ret 0 [ 489.430249] lustre_kcompr_25197: compr deflate(6) in 64kB chunks took 355273 us (11 MB/s), compress ratio: 3.51 [ 490.164780] lustre_kcompr_25197: compr deflate(6) in 128kB chunks took 728898 us (5 MB/s), compress ratio: 3.53 [ 490.942301] lustre_kcompr_25197: compr deflate(6) in 256kB chunks took 762869 us (5 MB/s), compress ratio: 3.53 [ 491.818905] lustre_kcompr_25197: compr deflate(6) in 512kB chunks took 856077 us (4 MB/s), compress ratio: 3.54 [ 492.844187] lustre_kcompr_25197: compr deflate(6) in 1024kB chunks took 1011750 us (3 MB/s), compress ratio: 3.54 [ 493.757540] lustre_kcompr_25197: compr deflate(6) in 2048kB chunks took 902719 us (4 MB/s), compress ratio: 3.54 [ 494.727820] lustre_kcompr_25197: compr deflate(6) in 4096kB chunks took 958617 us (4 MB/s), compress ratio: 3.54 [ 494.809568] lustre_kcompr_25197: decompr deflate(6) took 62354 us (18 MB/s) [ 494.829966] lustre_kcompr_25197: test_comp_compress_decompress(deflate,6) ret 0 [ 494.866393] lustre_kcompr_25197: acompr deflate(6) of 128kB chunks took 26750 us (4 MB/s), compress ratio: 3.09 [ 494.882256] lustre_kcompr_25197: adecompr deflate(6) took 4432 us (9 MB/s) [ 494.901028] lustre_kcompr_25197: test_acomp_compress_decompress(deflate,6) ret 0 [ 495.729647] lustre_kcompr_25197: compr deflate(9) in 64kB chunks took 800986 us (4 MB/s), compress ratio: 3.51 [ 497.050478] lustre_kcompr_25197: compr deflate(9) in 128kB chunks took 1289628 us (3 MB/s), compress ratio: 3.53 [ 498.426322] lustre_kcompr_25197: compr deflate(9) in 256kB chunks took 1352149 us (2 MB/s), compress ratio: 3.53 [ 499.530290] lustre_kcompr_25197: compr deflate(9) in 512kB chunks took 1078916 us (3 MB/s), compress ratio: 3.54 [ 500.403843] lustre_kcompr_25197: compr deflate(9) in 1024kB chunks took 858698 us (4 MB/s), compress ratio: 3.54 [ 501.472702] lustre_kcompr_25197: compr deflate(9) in 2048kB chunks took 1052442 us (3 MB/s), compress ratio: 3.54 [ 502.182807] lustre_kcompr_25197: compr deflate(9) in 4096kB chunks took 688154 us (5 MB/s), compress ratio: 3.54 [ 502.289510] lustre_kcompr_25197: decompr deflate(9) took 79711 us (14 MB/s) [ 502.309927] lustre_kcompr_25197: test_comp_compress_decompress(deflate,9) ret 0 [ 502.352693] lustre_kcompr_25197: acompr deflate(9) of 128kB chunks took 31837 us (3 MB/s), compress ratio: 3.09 [ 502.370470] lustre_kcompr_25197: adecompr deflate(9) took 1257 us (32 MB/s) [ 502.425091] lustre_kcompr_25197: test_acomp_compress_decompress(deflate,9) ret 0 [ 502.755814] lustre_kcompr_25197: compr zstd(0) in 64kB chunks took 280943 us (14 MB/s), compress ratio: 4.28 [ 503.087892] lustre_kcompr_25197: compr zstd(0) in 128kB chunks took 291065 us (13 MB/s), compress ratio: 4.46 [ 503.400934] lustre_kcompr_25197: compr zstd(0) in 256kB chunks took 294246 us (13 MB/s), compress ratio: 4.61 [ 503.739516] lustre_kcompr_25197: compr zstd(0) in 512kB chunks took 328065 us (12 MB/s), compress ratio: 4.72 [ 504.110784] lustre_kcompr_25197: compr zstd(0) in 1024kB chunks took 352451 us (11 MB/s), compress ratio: 4.80 [ 504.424837] lustre_kcompr_25197: compr zstd(0) in 2048kB chunks took 285874 us (13 MB/s), compress ratio: 4.85 [ 504.597097] lustre_kcompr_25197: compr zstd(0) in 4096kB chunks took 164144 us (24 MB/s), compress ratio: 4.88 [ 504.654320] lustre_kcompr_25197: decompr zstd(0) took 39277 us (20 MB/s) [ 504.659849] lustre_kcompr_25197: test_comp_compress_decompress(zstd,0) ret 0 [ 504.667428] lustre_kcompr_25197: acompr zstd(0) of 128kB chunks took 3315 us (37 MB/s), compress ratio: 3.98 [ 504.673212] lustre_kcompr_25197: adecompr zstd(0) took 931 us (33 MB/s) [ 504.680192] lustre_kcompr_25197: test_acomp_compress_decompress(zstd,0) ret 0 [ 504.755137] lustre_kcompr_25197: compr zstd(1) in 64kB chunks took 57709 us (69 MB/s), compress ratio: 4.06 [ 504.804501] lustre_kcompr_25197: compr zstd(1) in 128kB chunks took 45971 us (87 MB/s), compress ratio: 4.20 [ 504.951567] lustre_kcompr_25197: compr zstd(1) in 256kB chunks took 138230 us (28 MB/s), compress ratio: 4.34 [ 505.155395] lustre_kcompr_25197: compr zstd(1) in 512kB chunks took 193611 us (20 MB/s), compress ratio: 4.34 [ 505.300744] lustre_kcompr_25197: compr zstd(1) in 1024kB chunks took 122689 us (32 MB/s), compress ratio: 4.37 [ 505.394937] lustre_kcompr_25197: compr zstd(1) in 2048kB chunks took 88609 us (45 MB/s), compress ratio: 4.39 [ 505.558915] lustre_kcompr_25197: compr zstd(1) in 4096kB chunks took 156661 us (25 MB/s), compress ratio: 4.40 [ 505.581724] lustre_kcompr_25197: decompr zstd(1) took 16146 us (56 MB/s) [ 505.585199] lustre_kcompr_25197: test_comp_compress_decompress(zstd,1) ret 0 [ 505.589693] lustre_kcompr_25197: acompr zstd(1) of 128kB chunks took 1193 us (104 MB/s), compress ratio: 3.73 [ 505.592492] lustre_kcompr_25197: adecompr zstd(1) took 596 us (56 MB/s) [ 505.601895] lustre_kcompr_25197: test_acomp_compress_decompress(zstd,1) ret 0 [ 507.606448] lustre_kcompr_25197: compr zstd(10) in 64kB chunks took 1996084 us (2 MB/s), compress ratio: 4.80 [ 510.779752] lustre_kcompr_25197: compr zstd(10) in 128kB chunks took 3163017 us (1 MB/s), compress ratio: 5.09 [ 513.103991] lustre_kcompr_25197: compr zstd(10) in 256kB chunks took 2300400 us (1 MB/s), compress ratio: 5.34 [ 515.609656] lustre_kcompr_25197: compr zstd(10) in 512kB chunks took 2497568 us (1 MB/s), compress ratio: 5.45 [ 517.241415] lustre_kcompr_25197: compr zstd(10) in 1024kB chunks took 1612831 us (2 MB/s), compress ratio: 5.62 [ 519.944577] lustre_kcompr_25197: compr zstd(10) in 2048kB chunks took 2680654 us (1 MB/s), compress ratio: 5.76 [ 522.574565] lustre_kcompr_25197: compr zstd(10) in 4096kB chunks took 2605674 us (1 MB/s), compress ratio: 5.89 [ 522.689821] lustre_kcompr_25197: decompr zstd(10) took 85741 us (7 MB/s) [ 522.706525] lustre_kcompr_25197: test_comp_compress_decompress(zstd,10) ret 0 [ 522.845146] lustre_kcompr_25197: acompr zstd(10) of 128kB chunks took 121006 us (1 MB/s), compress ratio: 4.46 [ 522.902578] lustre_kcompr_25197: adecompr zstd(10) took 467 us (60 MB/s) [ 522.970827] lustre_kcompr_25197: test_acomp_compress_decompress(zstd,10) ret 0 [ 536.234141] lustre_kcompr_25197: compr zstd(15) in 64kB chunks took 13228811 us (0 MB/s), compress ratio: 4.96 [ 551.577276] lustre_kcompr_25197: compr zstd(15) in 128kB chunks took 15338806 us (0 MB/s), compress ratio: 5.28 [ 562.321308] lustre_kcompr_25197: compr zstd(15) in 256kB chunks took 10739611 us (0 MB/s), compress ratio: 5.57 [ 574.629641] lustre_kcompr_25197: compr zstd(15) in 512kB chunks took 12304597 us (0 MB/s), compress ratio: 5.83 [ 585.287702] lustre_kcompr_25197: compr zstd(15) in 1024kB chunks took 10630244 us (0 MB/s), compress ratio: 6.06 [ 605.194329] lustre_kcompr_25197: compr zstd(15) in 2048kB chunks took 19898614 us (0 MB/s), compress ratio: 6.26 [ 619.392651] lustre_kcompr_25197: compr zstd(15) in 4096kB chunks took 14182328 us (0 MB/s), compress ratio: 6.46 [ 619.460366] lustre_kcompr_25197: decompr zstd(15) took 48657 us (12 MB/s) [ 619.473166] lustre_kcompr_25197: test_comp_compress_decompress(zstd,15) ret 0 [ 619.849741] lustre_kcompr_25197: acompr zstd(15) of 128kB chunks took 366629 us (0 MB/s), compress ratio: 4.64 [ 619.865105] lustre_kcompr_25197: adecompr zstd(15) took 1642 us (16 MB/s) [ 619.890596] lustre_kcompr_25197: test_acomp_compress_decompress(zstd,15) ret 0 [ 620.010291] lustre_kcompr_25197: compr zstdfast(1) in 64kB chunks took 85377 us (46 MB/s), compress ratio: 3.49 [ 620.077713] lustre_kcompr_25197: compr zstdfast(1) in 128kB chunks took 57626 us (69 MB/s), compress ratio: 3.62 [ 620.165435] lustre_kcompr_25197: compr zstdfast(1) in 256kB chunks took 78855 us (50 MB/s), compress ratio: 3.84 [ 620.240622] lustre_kcompr_25197: compr zstdfast(1) in 512kB chunks took 69038 us (57 MB/s), compress ratio: 3.73 [ 620.307318] lustre_kcompr_25197: compr zstdfast(1) in 1024kB chunks took 53744 us (74 MB/s), compress ratio: 3.76 [ 620.378624] lustre_kcompr_25197: compr zstdfast(1) in 2048kB chunks took 61659 us (64 MB/s), compress ratio: 3.77 [ 620.440170] lustre_kcompr_25197: compr zstdfast(1) in 4096kB chunks took 56738 us (70 MB/s), compress ratio: 3.78 [ 620.482746] lustre_kcompr_25197: decompr zstdfast(1) took 21278 us (49 MB/s) [ 620.493317] lustre_kcompr_25197: test_comp_compress_decompress(zstdfast,1) ret 0 [ 620.504527] lustre_kcompr_25197: acompr zstdfast(1) of 128kB chunks took 1203 us (103 MB/s), compress ratio: 3.19 [ 620.524080] lustre_kcompr_25197: adecompr zstdfast(1) took 426 us (91 MB/s) [ 620.573095] lustre_kcompr_25197: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 620.667272] lustre_kcompr_25197: compr zstdfast(5) in 64kB chunks took 61812 us (64 MB/s), compress ratio: 2.81 [ 620.737469] lustre_kcompr_25197: compr zstdfast(5) in 128kB chunks took 59076 us (67 MB/s), compress ratio: 2.93 [ 620.790290] lustre_kcompr_25197: compr zstdfast(5) in 256kB chunks took 48417 us (82 MB/s), compress ratio: 3.16 [ 620.848144] lustre_kcompr_25197: compr zstdfast(5) in 512kB chunks took 52934 us (75 MB/s), compress ratio: 3.04 [ 620.965687] lustre_kcompr_25197: compr zstdfast(5) in 1024kB chunks took 105471 us (37 MB/s), compress ratio: 3.07 [ 621.017309] lustre_kcompr_25197: compr zstdfast(5) in 2048kB chunks took 39721 us (100 MB/s), compress ratio: 3.08 [ 621.100958] lustre_kcompr_25197: compr zstdfast(5) in 4096kB chunks took 78761 us (50 MB/s), compress ratio: 3.09 [ 621.151538] lustre_kcompr_25197: decompr zstdfast(5) took 29664 us (43 MB/s) [ 621.165618] lustre_kcompr_25197: test_comp_compress_decompress(zstdfast,5) ret 0 [ 621.193049] lustre_kcompr_25197: acompr zstdfast(5) of 128kB chunks took 4659 us (26 MB/s), compress ratio: 2.56 [ 621.208512] lustre_kcompr_25197: adecompr zstdfast(5) took 489 us (99 MB/s) [ 621.221146] lustre_kcompr_25197: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 621.312242] lustre_kcompr_25197: compr zstdfast(12) in 64kB chunks took 53223 us (75 MB/s), compress ratio: 1.43 [ 621.386229] lustre_kcompr_25197: compr zstdfast(12) in 128kB chunks took 62957 us (63 MB/s), compress ratio: 1.50 [ 621.457393] lustre_kcompr_25197: compr zstdfast(12) in 256kB chunks took 55296 us (72 MB/s), compress ratio: 1.62 [ 621.524974] lustre_kcompr_25197: compr zstdfast(12) in 512kB chunks took 51585 us (77 MB/s), compress ratio: 1.55 [ 621.577307] lustre_kcompr_25197: compr zstdfast(12) in 1024kB chunks took 35619 us (112 MB/s), compress ratio: 1.58 [ 621.620389] lustre_kcompr_25197: compr zstdfast(12) in 2048kB chunks took 31918 us (125 MB/s), compress ratio: 1.60 [ 621.656821] lustre_kcompr_25197: compr zstdfast(12) in 4096kB chunks took 32621 us (122 MB/s), compress ratio: 1.60 [ 621.690886] lustre_kcompr_25197: decompr zstdfast(12) took 10502 us (237 MB/s) [ 621.704126] lustre_kcompr_25197: test_comp_compress_decompress(zstdfast,12) ret 0 [ 621.712989] lustre_kcompr_25197: acompr zstdfast(12) of 128kB chunks took 3902 us (32 MB/s), compress ratio: 1.37 [ 621.721771] lustre_kcompr_25197: adecompr zstdfast(12) took 312 us (292 MB/s) [ 621.755153] lustre_kcompr_25197: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 621.825943] lustre_kcompr_25197: compr zstdfast(15) in 64kB chunks took 25398 us (157 MB/s), compress ratio: 1.12 [ 621.874644] lustre_kcompr_25197: compr zstdfast(15) in 128kB chunks took 33642 us (118 MB/s), compress ratio: 1.16 [ 621.932994] lustre_kcompr_25197: compr zstdfast(15) in 256kB chunks took 40917 us (97 MB/s), compress ratio: 1.22 [ 621.982583] lustre_kcompr_25197: compr zstdfast(15) in 512kB chunks took 31126 us (128 MB/s), compress ratio: 1.20 [ 622.026771] lustre_kcompr_25197: compr zstdfast(15) in 1024kB chunks took 32381 us (123 MB/s), compress ratio: 1.22 [ 622.045349] lustre_kcompr_25197: compr zstdfast(15) in 2048kB chunks took 11625 us (344 MB/s), compress ratio: 1.23 [ 622.085457] lustre_kcompr_25197: compr zstdfast(15) in 4096kB chunks took 36035 us (111 MB/s), compress ratio: 1.23 [ 622.128931] lustre_kcompr_25197: decompr zstdfast(15) took 16616 us (194 MB/s) [ 622.148137] lustre_kcompr_25197: test_comp_compress_decompress(zstdfast,15) ret 0 [ 622.154937] lustre_kcompr_25197: acompr zstdfast(15) of 128kB chunks took 830 us (150 MB/s), compress ratio: 1.08 [ 622.159139] lustre_kcompr_25197: adecompr zstdfast(15) took 314 us (367 MB/s) [ 622.172425] lustre_kcompr_25197: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 622.177451] lustre_kcompr_25197: SUCCESS [ 627.393327] lustre_kcompr_4096: ***** [ 627.396070] lustre_kcompr_4096: (de)compression test on provided file /tmp/f84.sanity [ 627.398727] lustre_kcompr_4096: ***** [ 627.449458] lustre_kcompr_4096: compr lz4(1) in 64kB chunks took 27008 us (148 MB/s), compress ratio: 2.45 [ 627.486464] lustre_kcompr_4096: compr lz4(1) in 128kB chunks took 23101 us (173 MB/s), compress ratio: 2.39 [ 627.531462] lustre_kcompr_4096: compr lz4(1) in 256kB chunks took 40090 us (99 MB/s), compress ratio: 2.39 [ 627.552260] lustre_kcompr_4096: compr lz4(1) in 512kB chunks took 16456 us (243 MB/s), compress ratio: 2.39 [ 627.578991] lustre_kcompr_4096: compr lz4(1) in 1024kB chunks took 18957 us (211 MB/s), compress ratio: 2.39 [ 627.599799] lustre_kcompr_4096: compr lz4(1) in 2048kB chunks took 16342 us (244 MB/s), compress ratio: 2.39 [ 627.621171] lustre_kcompr_4096: compr lz4(1) in 4096kB chunks took 16894 us (236 MB/s), compress ratio: 2.39 [ 627.632780] lustre_kcompr_4096: decompr lz4(1) took 2553 us (653 MB/s) [ 627.636200] lustre_kcompr_4096: test_comp_compress_decompress(lz4,1) ret 0 [ 627.640071] lustre_kcompr_4096: acompr lz4(1) of 128kB chunks took 224 us (558 MB/s), compress ratio: 15.67 [ 627.644306] lustre_kcompr_4096: adecompr lz4(1) took 101 us (78 MB/s) [ 627.649386] lustre_kcompr_4096: test_acomp_compress_decompress(lz4,1) ret 0 [ 627.671734] lustre_kcompr_4096: compr lz4(4) in 64kB chunks took 13430 us (297 MB/s), compress ratio: 2.36 [ 627.698752] lustre_kcompr_4096: compr lz4(4) in 128kB chunks took 21006 us (190 MB/s), compress ratio: 2.35 [ 627.719618] lustre_kcompr_4096: compr lz4(4) in 256kB chunks took 14379 us (278 MB/s), compress ratio: 2.35 [ 627.751440] lustre_kcompr_4096: compr lz4(4) in 512kB chunks took 23769 us (168 MB/s), compress ratio: 2.35 [ 627.800280] lustre_kcompr_4096: compr lz4(4) in 1024kB chunks took 34479 us (116 MB/s), compress ratio: 2.35 [ 627.837791] lustre_kcompr_4096: compr lz4(4) in 2048kB chunks took 21954 us (182 MB/s), compress ratio: 2.35 [ 627.859650] lustre_kcompr_4096: compr lz4(4) in 4096kB chunks took 15178 us (263 MB/s), compress ratio: 2.35 [ 627.875031] lustre_kcompr_4096: decompr lz4(4) took 3429 us (495 MB/s) [ 627.880377] lustre_kcompr_4096: test_comp_compress_decompress(lz4,4) ret 0 [ 627.885983] lustre_kcompr_4096: acompr lz4(4) of 128kB chunks took 117 us (1068 MB/s), compress ratio: 15.30 [ 627.891689] lustre_kcompr_4096: adecompr lz4(4) took 111 us (73 MB/s) [ 627.900576] lustre_kcompr_4096: test_acomp_compress_decompress(lz4,4) ret 0 [ 627.918589] lustre_kcompr_4096: compr lz4(9) in 64kB chunks took 5460 us (732 MB/s), compress ratio: 2.32 [ 627.946801] lustre_kcompr_4096: compr lz4(9) in 128kB chunks took 15788 us (253 MB/s), compress ratio: 2.31 [ 627.973743] lustre_kcompr_4096: compr lz4(9) in 256kB chunks took 17839 us (224 MB/s), compress ratio: 2.31 [ 627.986647] lustre_kcompr_4096: compr lz4(9) in 512kB chunks took 9106 us (439 MB/s), compress ratio: 2.31 [ 627.999353] lustre_kcompr_4096: compr lz4(9) in 1024kB chunks took 8929 us (447 MB/s), compress ratio: 2.31 [ 628.011793] lustre_kcompr_4096: compr lz4(9) in 2048kB chunks took 8298 us (482 MB/s), compress ratio: 2.32 [ 628.023795] lustre_kcompr_4096: compr lz4(9) in 4096kB chunks took 7323 us (546 MB/s), compress ratio: 2.32 [ 628.033786] lustre_kcompr_4096: decompr lz4(9) took 2349 us (733 MB/s) [ 628.037221] lustre_kcompr_4096: test_comp_compress_decompress(lz4,9) ret 0 [ 628.040786] lustre_kcompr_4096: acompr lz4(9) of 128kB chunks took 182 us (686 MB/s), compress ratio: 14.81 [ 628.045389] lustre_kcompr_4096: adecompr lz4(9) took 94 us (89 MB/s) [ 628.050415] lustre_kcompr_4096: test_acomp_compress_decompress(lz4,9) ret 0 [ 628.073261] lustre_kcompr_4096: compr lz4(15) in 64kB chunks took 7081 us (564 MB/s), compress ratio: 2.23 [ 628.087351] lustre_kcompr_4096: compr lz4(15) in 128kB chunks took 7380 us (542 MB/s), compress ratio: 2.23 [ 628.105445] lustre_kcompr_4096: compr lz4(15) in 256kB chunks took 9457 us (422 MB/s), compress ratio: 2.23 [ 628.118651] lustre_kcompr_4096: compr lz4(15) in 512kB chunks took 7419 us (539 MB/s), compress ratio: 2.23 [ 628.143614] lustre_kcompr_4096: compr lz4(15) in 1024kB chunks took 18946 us (211 MB/s), compress ratio: 2.23 [ 628.177642] lustre_kcompr_4096: compr lz4(15) in 2048kB chunks took 16548 us (241 MB/s), compress ratio: 2.23 [ 628.190731] lustre_kcompr_4096: compr lz4(15) in 4096kB chunks took 7131 us (560 MB/s), compress ratio: 2.23 [ 628.223597] lustre_kcompr_4096: decompr lz4(15) took 4448 us (402 MB/s) [ 628.232243] lustre_kcompr_4096: test_comp_compress_decompress(lz4,15) ret 0 [ 628.251300] lustre_kcompr_4096: acompr lz4(15) of 128kB chunks took 112 us (1116 MB/s), compress ratio: 14.18 [ 628.266589] lustre_kcompr_4096: adecompr lz4(15) took 115 us (76 MB/s) [ 628.292887] lustre_kcompr_4096: test_acomp_compress_decompress(lz4,15) ret 0 [ 628.535186] lustre_kcompr_4096: compr lz4hc(1) in 64kB chunks took 216387 us (18 MB/s), compress ratio: 2.54 [ 628.747798] lustre_kcompr_4096: compr lz4hc(1) in 128kB chunks took 198993 us (20 MB/s), compress ratio: 2.61 [ 628.827543] lustre_kcompr_4096: compr lz4hc(1) in 256kB chunks took 76036 us (52 MB/s), compress ratio: 2.64 [ 628.934983] lustre_kcompr_4096: compr lz4hc(1) in 512kB chunks took 103650 us (38 MB/s), compress ratio: 2.66 [ 629.115966] lustre_kcompr_4096: compr lz4hc(1) in 1024kB chunks took 176745 us (22 MB/s), compress ratio: 2.67 [ 629.326120] lustre_kcompr_4096: compr lz4hc(1) in 2048kB chunks took 202283 us (19 MB/s), compress ratio: 2.67 [ 629.511520] lustre_kcompr_4096: compr lz4hc(1) in 4096kB chunks took 175925 us (22 MB/s), compress ratio: 2.67 [ 629.530423] lustre_kcompr_4096: decompr lz4hc(1) took 6034 us (247 MB/s) [ 629.537771] lustre_kcompr_4096: test_comp_compress_decompress(lz4hc,1) ret 0 [ 629.545390] lustre_kcompr_4096: acompr lz4hc(1) of 128kB chunks took 920 us (135 MB/s), compress ratio: 15.97 [ 629.552803] lustre_kcompr_4096: adecompr lz4hc(1) took 173 us (45 MB/s) [ 629.566361] lustre_kcompr_4096: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 629.713510] lustre_kcompr_4096: compr lz4hc(3) in 64kB chunks took 132156 us (30 MB/s), compress ratio: 2.57 [ 629.868537] lustre_kcompr_4096: compr lz4hc(3) in 128kB chunks took 150063 us (26 MB/s), compress ratio: 2.64 [ 630.016768] lustre_kcompr_4096: compr lz4hc(3) in 256kB chunks took 142018 us (28 MB/s), compress ratio: 2.68 [ 630.189298] lustre_kcompr_4096: compr lz4hc(3) in 512kB chunks took 165993 us (24 MB/s), compress ratio: 2.69 [ 630.410719] lustre_kcompr_4096: compr lz4hc(3) in 1024kB chunks took 216159 us (18 MB/s), compress ratio: 2.70 [ 630.663911] lustre_kcompr_4096: compr lz4hc(3) in 2048kB chunks took 249687 us (16 MB/s), compress ratio: 2.71 [ 631.035909] lustre_kcompr_4096: compr lz4hc(3) in 4096kB chunks took 352855 us (11 MB/s), compress ratio: 2.71 [ 631.078904] lustre_kcompr_4096: decompr lz4hc(3) took 12713 us (115 MB/s) [ 631.092390] lustre_kcompr_4096: test_comp_compress_decompress(lz4hc,3) ret 0 [ 631.113572] lustre_kcompr_4096: acompr lz4hc(3) of 128kB chunks took 1826 us (68 MB/s), compress ratio: 16.00 [ 631.119430] lustre_kcompr_4096: adecompr lz4hc(3) took 159 us (49 MB/s) [ 631.141816] lustre_kcompr_4096: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 631.977728] lustre_kcompr_4096: compr lz4hc(8) in 64kB chunks took 796363 us (5 MB/s), compress ratio: 2.60 [ 632.697810] lustre_kcompr_4096: compr lz4hc(8) in 128kB chunks took 709915 us (5 MB/s), compress ratio: 2.66 [ 633.561629] lustre_kcompr_4096: compr lz4hc(8) in 256kB chunks took 855362 us (4 MB/s), compress ratio: 2.70 [ 634.392292] lustre_kcompr_4096: compr lz4hc(8) in 512kB chunks took 819585 us (4 MB/s), compress ratio: 2.71 [ 635.188207] lustre_kcompr_4096: compr lz4hc(8) in 1024kB chunks took 787567 us (5 MB/s), compress ratio: 2.72 [ 635.839461] lustre_kcompr_4096: compr lz4hc(8) in 2048kB chunks took 638640 us (6 MB/s), compress ratio: 2.73 [ 636.902990] lustre_kcompr_4096: compr lz4hc(8) in 4096kB chunks took 1049269 us (3 MB/s), compress ratio: 2.73 [ 636.918557] lustre_kcompr_4096: decompr lz4hc(8) took 4895 us (298 MB/s) [ 636.923297] lustre_kcompr_4096: test_comp_compress_decompress(lz4hc,8) ret 0 [ 636.931585] lustre_kcompr_4096: acompr lz4hc(8) of 128kB chunks took 3123 us (40 MB/s), compress ratio: 16.17 [ 636.938253] lustre_kcompr_4096: adecompr lz4hc(8) took 101 us (76 MB/s) [ 636.946583] lustre_kcompr_4096: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 645.025945] lustre_kcompr_4096: compr lz4hc(15) in 64kB chunks took 8064669 us (0 MB/s), compress ratio: 2.61 [ 656.401269] lustre_kcompr_4096: compr lz4hc(15) in 128kB chunks took 11361630 us (0 MB/s), compress ratio: 2.67 [ 666.185921] lustre_kcompr_4096: compr lz4hc(15) in 256kB chunks took 9777820 us (0 MB/s), compress ratio: 2.71 [ 681.762226] lustre_kcompr_4096: compr lz4hc(15) in 512kB chunks took 15560942 us (0 MB/s), compress ratio: 2.72 [ 696.511818] lustre_kcompr_4096: compr lz4hc(15) in 1024kB chunks took 14742733 us (0 MB/s), compress ratio: 2.73 [ 710.747147] lustre_kcompr_4096: compr lz4hc(15) in 2048kB chunks took 14231250 us (0 MB/s), compress ratio: 2.74 [ 726.300251] lustre_kcompr_4096: compr lz4hc(15) in 4096kB chunks took 15535507 us (0 MB/s), compress ratio: 2.74 [ 726.323452] lustre_kcompr_4096: decompr lz4hc(15) took 8510 us (171 MB/s) [ 726.328462] lustre_kcompr_4096: test_comp_compress_decompress(lz4hc,15) ret 0 [ 726.388977] lustre_kcompr_4096: acompr lz4hc(15) of 128kB chunks took 52172 us (2 MB/s), compress ratio: 16.30 [ 726.399544] lustre_kcompr_4096: adecompr lz4hc(15) took 2530 us (3 MB/s) [ 726.406425] lustre_kcompr_4096: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 726.439718] lustre_kcompr_4096: compr lzo(-1) in 64kB chunks took 28456 us (140 MB/s), compress ratio: 2.35 [ 726.492151] lustre_kcompr_4096: compr lzo(-1) in 128kB chunks took 39906 us (100 MB/s), compress ratio: 2.35 [ 726.518784] lustre_kcompr_4096: compr lzo(-1) in 256kB chunks took 15049 us (265 MB/s), compress ratio: 2.35 [ 726.544941] lustre_kcompr_4096: compr lzo(-1) in 512kB chunks took 17429 us (229 MB/s), compress ratio: 2.36 [ 726.571744] lustre_kcompr_4096: compr lzo(-1) in 1024kB chunks took 21200 us (188 MB/s), compress ratio: 2.36 [ 726.617786] lustre_kcompr_4096: compr lzo(-1) in 2048kB chunks took 37582 us (106 MB/s), compress ratio: 2.36 [ 726.685596] lustre_kcompr_4096: compr lzo(-1) in 4096kB chunks took 39649 us (100 MB/s), compress ratio: 2.36 [ 726.741870] lustre_kcompr_4096: decompr lzo(-1) took 14935 us (113 MB/s) [ 726.746747] lustre_kcompr_4096: test_comp_compress_decompress(lzo,-1) ret 0 [ 726.758959] lustre_kcompr_4096: acompr lzo(-1) of 128kB chunks took 238 us (525 MB/s), compress ratio: 15.45 [ 726.774723] lustre_kcompr_4096: adecompr lzo(-1) took 1708 us (4 MB/s) [ 726.803824] lustre_kcompr_4096: test_acomp_compress_decompress(lzo,-1) ret 0 [ 727.569500] lustre_kcompr_4096: compr deflate(1) in 64kB chunks took 747162 us (5 MB/s), compress ratio: 3.27 [ 728.302614] lustre_kcompr_4096: compr deflate(1) in 128kB chunks took 727342 us (5 MB/s), compress ratio: 3.28 [ 729.060602] lustre_kcompr_4096: compr deflate(1) in 256kB chunks took 753744 us (5 MB/s), compress ratio: 3.28 [ 729.698124] lustre_kcompr_4096: compr deflate(1) in 512kB chunks took 627739 us (6 MB/s), compress ratio: 3.28 [ 730.384162] lustre_kcompr_4096: compr deflate(1) in 1024kB chunks took 682567 us (5 MB/s), compress ratio: 3.28 [ 731.120079] lustre_kcompr_4096: compr deflate(1) in 2048kB chunks took 726529 us (5 MB/s), compress ratio: 3.28 [ 731.591386] lustre_kcompr_4096: compr deflate(1) in 4096kB chunks took 466035 us (8 MB/s), compress ratio: 3.28 [ 731.672159] lustre_kcompr_4096: decompr deflate(1) took 57618 us (21 MB/s) [ 731.690408] lustre_kcompr_4096: test_comp_compress_decompress(deflate,1) ret 0 [ 731.715361] lustre_kcompr_4096: acompr deflate(1) of 128kB chunks took 15627 us (7 MB/s), compress ratio: 21.43 [ 731.726496] lustre_kcompr_4096: adecompr deflate(1) took 286 us (20 MB/s) [ 731.763389] lustre_kcompr_4096: test_acomp_compress_decompress(deflate,1) ret 0 [ 732.678357] lustre_kcompr_4096: compr deflate(6) in 64kB chunks took 882427 us (4 MB/s), compress ratio: 3.27 [ 733.692786] lustre_kcompr_4096: compr deflate(6) in 128kB chunks took 1003911 us (3 MB/s), compress ratio: 3.28 [ 734.454639] lustre_kcompr_4096: compr deflate(6) in 256kB chunks took 747712 us (5 MB/s), compress ratio: 3.28 [ 735.375679] lustre_kcompr_4096: compr deflate(6) in 512kB chunks took 915056 us (4 MB/s), compress ratio: 3.28 [ 735.976630] lustre_kcompr_4096: compr deflate(6) in 1024kB chunks took 596008 us (6 MB/s), compress ratio: 3.28 [ 736.820212] lustre_kcompr_4096: compr deflate(6) in 2048kB chunks took 835967 us (4 MB/s), compress ratio: 3.28 [ 737.543259] lustre_kcompr_4096: compr deflate(6) in 4096kB chunks took 717305 us (5 MB/s), compress ratio: 3.28 [ 737.580798] lustre_kcompr_4096: decompr deflate(6) took 26259 us (46 MB/s) [ 737.614648] lustre_kcompr_4096: test_comp_compress_decompress(deflate,6) ret 0 [ 737.654798] lustre_kcompr_4096: acompr deflate(6) of 128kB chunks took 28839 us (4 MB/s), compress ratio: 21.43 [ 737.667135] lustre_kcompr_4096: adecompr deflate(6) took 305 us (19 MB/s) [ 737.697564] lustre_kcompr_4096: test_acomp_compress_decompress(deflate,6) ret 0 [ 738.656944] lustre_kcompr_4096: compr deflate(9) in 64kB chunks took 909713 us (4 MB/s), compress ratio: 3.27 [ 739.525818] lustre_kcompr_4096: compr deflate(9) in 128kB chunks took 854239 us (4 MB/s), compress ratio: 3.28 [ 740.062453] lustre_kcompr_4096: compr deflate(9) in 256kB chunks took 519786 us (7 MB/s), compress ratio: 3.28 [ 740.795130] lustre_kcompr_4096: compr deflate(9) in 512kB chunks took 724869 us (5 MB/s), compress ratio: 3.28 [ 741.487391] lustre_kcompr_4096: compr deflate(9) in 1024kB chunks took 682721 us (5 MB/s), compress ratio: 3.28 [ 742.180167] lustre_kcompr_4096: compr deflate(9) in 2048kB chunks took 686022 us (5 MB/s), compress ratio: 3.28 [ 743.232414] lustre_kcompr_4096: compr deflate(9) in 4096kB chunks took 1041996 us (3 MB/s), compress ratio: 3.28 [ 743.268578] lustre_kcompr_4096: decompr deflate(9) took 24238 us (50 MB/s) [ 743.275188] lustre_kcompr_4096: test_comp_compress_decompress(deflate,9) ret 0 [ 743.290369] lustre_kcompr_4096: acompr deflate(9) of 128kB chunks took 8819 us (14 MB/s), compress ratio: 21.43 [ 743.294955] lustre_kcompr_4096: adecompr deflate(9) took 257 us (22 MB/s) [ 743.301744] lustre_kcompr_4096: test_acomp_compress_decompress(deflate,9) ret 0 [ 743.395978] lustre_kcompr_4096: compr zstd(0) in 64kB chunks took 82767 us (48 MB/s), compress ratio: 3.28 [ 743.490294] lustre_kcompr_4096: compr zstd(0) in 128kB chunks took 88896 us (44 MB/s), compress ratio: 3.26 [ 743.583938] lustre_kcompr_4096: compr zstd(0) in 256kB chunks took 89115 us (44 MB/s), compress ratio: 3.31 [ 743.696621] lustre_kcompr_4096: compr zstd(0) in 512kB chunks took 107137 us (37 MB/s), compress ratio: 3.32 [ 743.847262] lustre_kcompr_4096: compr zstd(0) in 1024kB chunks took 145482 us (27 MB/s), compress ratio: 3.32 [ 744.004904] lustre_kcompr_4096: compr zstd(0) in 2048kB chunks took 149686 us (26 MB/s), compress ratio: 3.33 [ 744.509850] lustre_kcompr_4096: compr zstd(0) in 4096kB chunks took 497448 us (8 MB/s), compress ratio: 3.33 [ 744.569261] lustre_kcompr_4096: decompr zstd(0) took 44737 us (26 MB/s) [ 744.575635] lustre_kcompr_4096: test_comp_compress_decompress(zstd,0) ret 0 [ 744.586820] lustre_kcompr_4096: acompr zstd(0) of 128kB chunks took 1524 us (82 MB/s), compress ratio: 22.64 [ 744.598159] lustre_kcompr_4096: adecompr zstd(0) took 201 us (27 MB/s) [ 744.625157] lustre_kcompr_4096: test_acomp_compress_decompress(zstd,0) ret 0 [ 744.698832] lustre_kcompr_4096: compr zstd(1) in 64kB chunks took 54381 us (73 MB/s), compress ratio: 3.22 [ 744.741456] lustre_kcompr_4096: compr zstd(1) in 128kB chunks took 37189 us (107 MB/s), compress ratio: 3.18 [ 744.804812] lustre_kcompr_4096: compr zstd(1) in 256kB chunks took 56954 us (70 MB/s), compress ratio: 3.19 [ 744.874523] lustre_kcompr_4096: compr zstd(1) in 512kB chunks took 63864 us (62 MB/s), compress ratio: 3.19 [ 744.938152] lustre_kcompr_4096: compr zstd(1) in 1024kB chunks took 56312 us (71 MB/s), compress ratio: 3.19 [ 745.003233] lustre_kcompr_4096: compr zstd(1) in 2048kB chunks took 58840 us (67 MB/s), compress ratio: 3.19 [ 745.083342] lustre_kcompr_4096: compr zstd(1) in 4096kB chunks took 64202 us (62 MB/s), compress ratio: 3.19 [ 745.129781] lustre_kcompr_4096: decompr zstd(1) took 29670 us (42 MB/s) [ 745.136381] lustre_kcompr_4096: test_comp_compress_decompress(zstd,1) ret 0 [ 745.140963] lustre_kcompr_4096: acompr zstd(1) of 128kB chunks took 264 us (473 MB/s), compress ratio: 22.79 [ 745.148334] lustre_kcompr_4096: adecompr zstd(1) took 173 us (31 MB/s) [ 745.162349] lustre_kcompr_4096: test_acomp_compress_decompress(zstd,1) ret 0 [ 745.895149] lustre_kcompr_4096: compr zstd(10) in 64kB chunks took 715489 us (5 MB/s), compress ratio: 3.33 [ 746.816299] lustre_kcompr_4096: compr zstd(10) in 128kB chunks took 912739 us (4 MB/s), compress ratio: 3.33 [ 747.685179] lustre_kcompr_4096: compr zstd(10) in 256kB chunks took 861741 us (4 MB/s), compress ratio: 3.37 [ 748.564920] lustre_kcompr_4096: compr zstd(10) in 512kB chunks took 867770 us (4 MB/s), compress ratio: 3.40 [ 749.264611] lustre_kcompr_4096: compr zstd(10) in 1024kB chunks took 694984 us (5 MB/s), compress ratio: 3.42 [ 750.474932] lustre_kcompr_4096: compr zstd(10) in 2048kB chunks took 1204641 us (3 MB/s), compress ratio: 3.46 [ 751.807451] lustre_kcompr_4096: compr zstd(10) in 4096kB chunks took 1322685 us (3 MB/s), compress ratio: 3.50 [ 751.882543] lustre_kcompr_4096: decompr zstd(10) took 51663 us (22 MB/s) [ 751.888941] lustre_kcompr_4096: test_comp_compress_decompress(zstd,10) ret 0 [ 751.894818] lustre_kcompr_4096: acompr zstd(10) of 128kB chunks took 1923 us (65 MB/s), compress ratio: 22.78 [ 751.899670] lustre_kcompr_4096: adecompr zstd(10) took 165 us (33 MB/s) [ 751.908459] lustre_kcompr_4096: test_acomp_compress_decompress(zstd,10) ret 0 [ 760.286708] lustre_kcompr_4096: compr zstd(15) in 64kB chunks took 8368214 us (0 MB/s), compress ratio: 3.36 [ 768.909797] lustre_kcompr_4096: compr zstd(15) in 128kB chunks took 8604223 us (0 MB/s), compress ratio: 3.39 [ 776.593110] lustre_kcompr_4096: compr zstd(15) in 256kB chunks took 7674570 us (0 MB/s), compress ratio: 3.40 [ 783.757584] lustre_kcompr_4096: compr zstd(15) in 512kB chunks took 7151148 us (0 MB/s), compress ratio: 3.42 [ 790.572317] lustre_kcompr_4096: compr zstd(15) in 1024kB chunks took 6805411 us (0 MB/s), compress ratio: 3.43 [ 795.508972] lustre_kcompr_4096: compr zstd(15) in 2048kB chunks took 4931695 us (0 MB/s), compress ratio: 3.48 [ 799.524567] lustre_kcompr_4096: compr zstd(15) in 4096kB chunks took 4006426 us (0 MB/s), compress ratio: 3.56 [ 799.582770] lustre_kcompr_4096: decompr zstd(15) took 38507 us (29 MB/s) [ 799.593188] lustre_kcompr_4096: test_comp_compress_decompress(zstd,15) ret 0 [ 799.661990] lustre_kcompr_4096: acompr zstd(15) of 128kB chunks took 63787 us (1 MB/s), compress ratio: 23.92 [ 799.667978] lustre_kcompr_4096: adecompr zstd(15) took 275 us (18 MB/s) [ 799.678103] lustre_kcompr_4096: test_acomp_compress_decompress(zstd,15) ret 0 [ 799.719777] lustre_kcompr_4096: compr zstdfast(1) in 64kB chunks took 33219 us (120 MB/s), compress ratio: 2.47 [ 799.798947] lustre_kcompr_4096: compr zstdfast(1) in 128kB chunks took 62162 us (64 MB/s), compress ratio: 2.48 [ 799.890519] lustre_kcompr_4096: compr zstdfast(1) in 256kB chunks took 76091 us (52 MB/s), compress ratio: 2.53 [ 799.949786] lustre_kcompr_4096: compr zstdfast(1) in 512kB chunks took 51534 us (77 MB/s), compress ratio: 2.42 [ 800.003434] lustre_kcompr_4096: compr zstdfast(1) in 1024kB chunks took 45746 us (87 MB/s), compress ratio: 2.42 [ 800.075362] lustre_kcompr_4096: compr zstdfast(1) in 2048kB chunks took 60972 us (65 MB/s), compress ratio: 2.42 [ 800.129120] lustre_kcompr_4096: compr zstdfast(1) in 4096kB chunks took 34733 us (115 MB/s), compress ratio: 2.42 [ 800.157676] lustre_kcompr_4096: decompr zstdfast(1) took 11158 us (147 MB/s) [ 800.167940] lustre_kcompr_4096: test_comp_compress_decompress(zstdfast,1) ret 0 [ 800.173487] lustre_kcompr_4096: acompr zstdfast(1) of 128kB chunks took 216 us (578 MB/s), compress ratio: 17.28 [ 800.183363] lustre_kcompr_4096: adecompr zstdfast(1) took 493 us (14 MB/s) [ 800.207358] lustre_kcompr_4096: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 800.242265] lustre_kcompr_4096: compr zstdfast(5) in 64kB chunks took 20483 us (195 MB/s), compress ratio: 2.38 [ 800.276907] lustre_kcompr_4096: compr zstdfast(5) in 128kB chunks took 27150 us (147 MB/s), compress ratio: 2.38 [ 800.300908] lustre_kcompr_4096: compr zstdfast(5) in 256kB chunks took 19632 us (203 MB/s), compress ratio: 2.40 [ 800.316444] lustre_kcompr_4096: compr zstdfast(5) in 512kB chunks took 11873 us (336 MB/s), compress ratio: 2.36 [ 800.348582] lustre_kcompr_4096: compr zstdfast(5) in 1024kB chunks took 27853 us (143 MB/s), compress ratio: 2.36 [ 800.373433] lustre_kcompr_4096: compr zstdfast(5) in 2048kB chunks took 18730 us (213 MB/s), compress ratio: 2.36 [ 800.393472] lustre_kcompr_4096: compr zstdfast(5) in 4096kB chunks took 15174 us (263 MB/s), compress ratio: 2.36 [ 800.409513] lustre_kcompr_4096: decompr zstdfast(5) took 4660 us (362 MB/s) [ 800.414387] lustre_kcompr_4096: test_comp_compress_decompress(zstdfast,5) ret 0 [ 800.418482] lustre_kcompr_4096: acompr zstdfast(5) of 128kB chunks took 175 us (714 MB/s), compress ratio: 16.12 [ 800.422317] lustre_kcompr_4096: adecompr zstdfast(5) took 214 us (36 MB/s) [ 800.428830] lustre_kcompr_4096: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 800.443107] lustre_kcompr_4096: compr zstdfast(12) in 64kB chunks took 6431 us (621 MB/s), compress ratio: 2.07 [ 800.452489] lustre_kcompr_4096: compr zstdfast(12) in 128kB chunks took 5892 us (678 MB/s), compress ratio: 2.07 [ 800.461827] lustre_kcompr_4096: compr zstdfast(12) in 256kB chunks took 5976 us (669 MB/s), compress ratio: 2.08 [ 800.471160] lustre_kcompr_4096: compr zstdfast(12) in 512kB chunks took 5644 us (708 MB/s), compress ratio: 2.07 [ 800.484298] lustre_kcompr_4096: compr zstdfast(12) in 1024kB chunks took 6935 us (576 MB/s), compress ratio: 2.07 [ 800.493863] lustre_kcompr_4096: compr zstdfast(12) in 2048kB chunks took 6407 us (624 MB/s), compress ratio: 2.07 [ 800.502891] lustre_kcompr_4096: compr zstdfast(12) in 4096kB chunks took 4957 us (806 MB/s), compress ratio: 2.08 [ 800.513252] lustre_kcompr_4096: decompr zstdfast(12) took 2297 us (836 MB/s) [ 800.517529] lustre_kcompr_4096: test_comp_compress_decompress(zstdfast,12) ret 0 [ 800.521754] lustre_kcompr_4096: acompr zstdfast(12) of 128kB chunks took 148 us (844 MB/s), compress ratio: 13.13 [ 800.526433] lustre_kcompr_4096: adecompr zstdfast(12) took 103 us (92 MB/s) [ 800.531766] lustre_kcompr_4096: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 800.545466] lustre_kcompr_4096: compr zstdfast(15) in 64kB chunks took 4558 us (877 MB/s), compress ratio: 1.82 [ 800.551748] lustre_kcompr_4096: compr zstdfast(15) in 128kB chunks took 3522 us (1135 MB/s), compress ratio: 1.83 [ 800.560256] lustre_kcompr_4096: compr zstdfast(15) in 256kB chunks took 4443 us (900 MB/s), compress ratio: 1.83 [ 800.568878] lustre_kcompr_4096: compr zstdfast(15) in 512kB chunks took 5053 us (791 MB/s), compress ratio: 1.83 [ 800.579259] lustre_kcompr_4096: compr zstdfast(15) in 1024kB chunks took 5452 us (733 MB/s), compress ratio: 1.83 [ 800.588825] lustre_kcompr_4096: compr zstdfast(15) in 2048kB chunks took 5151 us (776 MB/s), compress ratio: 1.83 [ 800.598355] lustre_kcompr_4096: compr zstdfast(15) in 4096kB chunks took 5442 us (735 MB/s), compress ratio: 1.84 [ 800.610938] lustre_kcompr_4096: decompr zstdfast(15) took 2627 us (826 MB/s) [ 800.615917] lustre_kcompr_4096: test_comp_compress_decompress(zstdfast,15) ret 0 [ 800.619710] lustre_kcompr_4096: acompr zstdfast(15) of 128kB chunks took 257 us (486 MB/s), compress ratio: 10.73 [ 800.623392] lustre_kcompr_4096: adecompr zstdfast(15) took 309 us (37 MB/s) [ 800.628314] lustre_kcompr_4096: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 800.631564] lustre_kcompr_4096: SUCCESS [ 819.881982] Lustre: DEBUG MARKER: == sanity test complete, duration 492 sec ================ 12:37:29 (1789058249) [ 821.382877] Lustre: DEBUG MARKER: === sanity: start cleanup 12:37:31 (1789058251) === [ 824.775640] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:37:34 (1789058254) === [ 826.613190] LustreError: 14303:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff9bc64b2c1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 826.658338] Lustre: Unmounted lustre-client [ 859.371324] Key type lgssc unregistered [ 859.671072] LNet: 14841:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 859.686493] LNetError: 14841:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 860.713104] LNet: Removed LNI 192.168.201.42@tcp [ 861.828230] Key type .llcrypt unregistered [ 861.831997] Key type ._llcrypt unregistered