[ 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 452391141 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001009] APIC: Switch to symmetric I/O mode setup [ 0.002347] x2apic enabled [ 0.003008] Switched APIC routing to physical x2apic. [ 0.004013] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007020] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008010] pid_max: default: 32768 minimum: 301 [ 0.009123] LSM: Security Framework initializing [ 0.011024] Yama: becoming mindful. [ 0.011926] SELinux: Initializing. [ 0.012071] *** VALIDATE selinux *** [ 0.019607] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024031] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025151] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026119] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027150] *** VALIDATE tmpfs *** [ 0.029028] *** VALIDATE proc *** [ 0.030250] *** VALIDATE cgroup *** [ 0.031012] *** VALIDATE cgroup2 *** [ 0.032229] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.033125] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.034008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.035033] Spectre V2 : User space: Vulnerable [ 0.036012] Speculative Store Bypass: Vulnerable [ 0.039035] debug: unmapping init [mem 0xffffffffa4059000-0xffffffffa4060fff] [ 0.042166] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043773] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044026] ... version: 2 [ 0.045028] ... bit width: 48 [ 0.046013] ... generic registers: 4 [ 0.047015] ... value mask: 0000ffffffffffff [ 0.048018] ... max period: 00007fffffffffff [ 0.049017] ... fixed-purpose events: 3 [ 0.050017] ... event mask: 000000070000000f [ 0.051292] rcu: Hierarchical SRCU implementation. [ 0.053560] smp: Bringing up secondary CPUs ... [ 0.054624] x86: Booting SMP configuration: [ 0.055031] .... node #0, CPUs: #1 #2 #3 [ 0.059140] smp: Brought up 1 node, 4 CPUs [ 0.061022] smpboot: Max logical packages: 1 [ 0.062015] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.105439] node 0 deferred pages initialised in 40ms [ 0.107167] devtmpfs: initialized [ 0.109291] x86/mm: Memory block size: 128MB [ 0.113053] gcov: version magic: 0x41383552 [ 0.115158] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.116000] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.117325] pinctrl core: initialized pinctrl subsystem [ 0.120144] [ 0.120506] ************************************************************* [ 0.122006] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.123006] ** ** [ 0.124008] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.126007] ** ** [ 0.127011] ** This means that this kernel is built to expose internal ** [ 0.130014] ** IOMMU data structures, which may compromise security on ** [ 0.132014] ** your system. ** [ 0.134016] ** ** [ 0.135008] ** If you see this message and you are not debugging the ** [ 0.136012] ** kernel, report this immediately to your vendor! ** [ 0.138012] ** ** [ 0.139011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.141012] ************************************************************* [ 0.144306] NET: Registered protocol family 16 [ 0.146380] 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.150056] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.153446] cpuidle: using governor menu [ 0.155243] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.156366] PCI: Using configuration type 1 for base access [ 0.157112] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.164083] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.165020] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.169352] cryptd: max_cpu_qlen set to 1000 [ 0.170566] ACPI: Added _OSI(Module Device) [ 0.171000] ACPI: Added _OSI(Processor Device) [ 0.171012] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.173016] ACPI: Added _OSI(Processor Aggregator Device) [ 0.179685] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.187700] ACPI: Interpreter enabled [ 0.189223] ACPI: PM: (supports S0 S3 S4 S5) [ 0.192015] ACPI: Using IOAPIC for interrupt routing [ 0.195140] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.200560] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.214512] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.217109] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.221022] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.225081] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.231795] acpiphp: Slot [2] registered [ 0.234162] acpiphp: Slot [5] registered [ 0.236189] acpiphp: Slot [6] registered [ 0.239137] acpiphp: Slot [3] registered [ 0.241150] acpiphp: Slot [4] registered [ 0.243222] acpiphp: Slot [7] registered [ 0.245255] acpiphp: Slot [8] registered [ 0.247129] acpiphp: Slot [9] registered [ 0.249607] acpiphp: Slot [10] registered [ 0.252130] acpiphp: Slot [11] registered [ 0.254124] acpiphp: Slot [12] registered [ 0.256157] acpiphp: Slot [13] registered [ 0.258268] acpiphp: Slot [14] registered [ 0.261272] acpiphp: Slot [15] registered [ 0.264245] acpiphp: Slot [16] registered [ 0.267128] acpiphp: Slot [17] registered [ 0.269243] acpiphp: Slot [18] registered [ 0.272140] acpiphp: Slot [19] registered [ 0.274143] acpiphp: Slot [20] registered [ 0.276132] acpiphp: Slot [21] registered [ 0.279521] acpiphp: Slot [22] registered [ 0.282217] acpiphp: Slot [23] registered [ 0.284140] acpiphp: Slot [24] registered [ 0.287142] acpiphp: Slot [25] registered [ 0.289159] acpiphp: Slot [26] registered [ 0.291121] acpiphp: Slot [27] registered [ 0.293163] acpiphp: Slot [28] registered [ 0.295257] acpiphp: Slot [29] registered [ 0.298139] acpiphp: Slot [30] registered [ 0.300132] acpiphp: Slot [31] registered [ 0.302088] PCI host bridge to bus 0000:00 [ 0.304022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.307029] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.310028] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.313034] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.317014] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.320031] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.322191] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.326464] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.330493] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.338016] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.343056] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.346025] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.349026] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.352024] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.354560] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.357971] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.361064] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.364773] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.367000] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.378000] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.382015] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.388219] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.400015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.408016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.437019] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.454372] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.465016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.478023] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.498026] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.515261] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.519474] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.522517] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.525339] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.528248] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.532133] iommu: Default domain type: Passthrough [ 0.534550] SCSI subsystem initialized [ 0.537217] ACPI: bus type USB registered [ 0.541202] usbcore: registered new interface driver usbfs [ 0.543135] usbcore: registered new interface driver hub [ 0.545131] usbcore: registered new device driver usb [ 0.547244] pps_core: LinuxPPS API ver. 1 registered [ 0.549018] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.552057] PTP clock support registered [ 0.554193] EDAC MC: Ver: 3.0.0 [ 0.556033] PCI: Using ACPI for IRQ routing [ 0.558291] NetLabel: Initializing [ 0.560017] NetLabel: domain hash size = 128 [ 0.562012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.565087] NetLabel: unlabeled traffic allowed by default [ 0.568152] vgaarb: loaded [ 0.569347] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.572017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.579000] clocksource: Switched to clocksource kvm-clock [ 0.696267] VFS: Disk quotas dquot_6.6.0 [ 0.698205] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.701700] *** VALIDATE ramfs *** [ 0.703332] *** VALIDATE hugetlbfs *** [ 0.704913] pnp: PnP ACPI init [ 0.708094] pnp: PnP ACPI: found 6 devices [ 0.727657] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.731346] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.733937] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.736583] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.739358] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.742336] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.745812] NET: Registered protocol family 2 [ 0.748810] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.754328] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.758530] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.764681] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.769146] TCP: Hash tables configured (established 65536 bind 65536) [ 0.772438] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.776096] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.779079] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.782527] NET: Registered protocol family 1 [ 0.786269] RPC: Registered named UNIX socket transport module. [ 0.789100] RPC: Registered udp transport module. [ 0.790818] RPC: Registered tcp transport module. [ 0.793111] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.795871] NET: Registered protocol family 44 [ 0.797674] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.799574] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.801625] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.803816] PCI: CLS 0 bytes, default 64 [ 0.805299] Unpacking initramfs... [ 2.209108] debug: unmapping init [mem 0xffff9fa5bcc64000-0xffff9fa5bffcffff] [ 2.213261] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.215740] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.218604] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.731074] Initialise system trusted keyrings [ 2.732183] Key type blacklist registered [ 2.734512] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.746843] zbud: loaded [ 2.750655] *** VALIDATE nfs *** [ 2.752263] *** VALIDATE nfs4 *** [ 2.754513] pstore: using deflate compression [ 2.758884] Platform Keyring initialized [ 2.856848] NET: Registered protocol family 38 [ 2.859294] Key type asymmetric registered [ 2.861242] Asymmetric key parser 'x509' registered [ 2.863380] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.867175] io scheduler mq-deadline registered [ 2.869214] io scheduler kyber registered [ 2.871224] io scheduler bfq registered [ 2.873503] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.876785] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.879662] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.882392] ACPI: Power Button [PWRF] [ 2.888145] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.894504] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.906678] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.933247] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.961050] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.966405] Non-volatile memory driver v1.3 [ 2.968409] Linux agpgart interface v0.103 [ 3.016587] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 3.020164] vda: detected capacity change from 0 to 73097216 [ 3.041541] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.045356] vdb: detected capacity change from 0 to 1073741824 [ 3.064304] libphy: Fixed MDIO Bus: probed [ 3.073814] usbcore: registered new interface driver usbserial_generic [ 3.076900] usbserial: USB Serial support registered for generic [ 3.079858] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.084802] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.086498] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.088529] mousedev: PS/2 mouse device common for all mice [ 3.091556] rtc_cmos 00:05: RTC can wake from S4 [ 3.099119] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.099319] rtc_cmos 00:05: registered as rtc0 [ 3.104179] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.106644] intel_pstate: CPU model not supported [ 3.108942] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.109895] hid: raw HID events driver (C) Jiri Kosina [ 3.114826] usbcore: registered new interface driver usbhid [ 3.116973] usbhid: USB HID core driver [ 3.118839] drop_monitor: Initializing network drop monitor service [ 3.119495] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.122978] Initializing XFRM netlink socket [ 3.123453] NET: Registered protocol family 10 [ 3.125433] Segment Routing with IPv6 [ 3.134100] NET: Registered protocol family 17 [ 3.137567] mpls_gso: MPLS GSO support [ 3.142551] RAS: Correctable Errors collector initialized. [ 3.144767] AVX version of gcm_enc/dec engaged. [ 3.146304] AES CTR mode by8 optimization enabled [ 3.224849] sched_clock: Marking stable (3224760156, 0)->(4104643748, -879883592) [ 3.228167] registered taskstats version 1 [ 3.230225] Loading compiled-in X.509 certificates [ 3.232050] zswap: loaded using pool lzo/zbud [ 3.256093] Key type big_key registered [ 3.268765] Key type encrypted registered [ 3.269965] ima: No TPM chip found, activating TPM-bypass! [ 3.271331] ima: Allocated hash algorithm: sha1 [ 3.272872] ima: No architecture policies found [ 3.274778] evm: Initialising EVM extended attributes: [ 3.276855] evm: security.selinux [ 3.278230] evm: security.ima [ 3.279461] evm: security.capability [ 3.280804] evm: HMAC attrs: 0x1 [ 3.283232] rtc_cmos 00:05: setting system clock to 2026-09-10 16:31:36 UTC (1789057896) [ 3.289878] debug: unmapping init [mem 0xffffffffa5003000-0xffffffffa51fffff] [ 3.293347] debug: unmapping init [mem 0xffffffffa3d82000-0xffffffffa4058fff] [ 3.302258] Write protecting the kernel read-only data: 28672k [ 3.307641] debug: unmapping init [mem 0xffffffffa2403000-0xffffffffa25fffff] [ 3.311704] debug: unmapping init [mem 0xffffffffa2d14000-0xffffffffa2dfffff] [ 3.346789] 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.355564] systemd[1]: Detected virtualization kvm. [ 3.357428] systemd[1]: Detected architecture x86-64. [ 3.359918] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.383628] systemd[1]: No hostname configured. [ 3.385099] systemd[1]: Set hostname to . [ 3.387197] random: systemd: uninitialized urandom read (16 bytes read) [ 3.389086] systemd[1]: Initializing machine ID from random generator. [ 3.413863] random: ln: uninitialized urandom read (6 bytes read) [ 3.527304] random: systemd: uninitialized urandom read (16 bytes read) [ 3.530318] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.535539] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.540739] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Swap. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Sockets. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.187464] device-mapper: uevent: version 1.0.3 [ 4.189097] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.830779] virtio_net virtio0 ens2: renamed from eth0 [ 4.884514] scsi host0: ata_piix [ 4.959210] scsi host1: ata_piix [ 4.961343] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.968752] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.107339] dracut-initqueue[591]: RTNETLINK answers: File exists[ 9.109802] random: fast init done [ 9.787678] random: crng init done [ 9.789018] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.056916] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Timers. [ 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 udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Slices. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.040253] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.234139] SELinux: Disabled at runtime. [ 11.287784] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.293359] systemd[1]: Detected virtualization kvm. [ 11.294805] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.758680] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.761698] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.767717] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.772560] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.777150] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.786389] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.799114] systemd[1]: Listening on RPCbind Server Activation Socket. [ OK ] Listening on RPCbind Server Activation Socket. Mounting POSIX Message Queue File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting Huge Pages File System... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Reached target RPC Port Mapper. Starting Remount Root and Kernel File Systems... [ OK ] Listening on Process Core Dump Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Starting Apply Kernel Variables... Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-serial\x2dgetty.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... Mounting Kernel Debug File System... [ 11.931619] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.214474] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.491404] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.522068] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.640859] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.662250] EDAC sbridge: Ver: 1.1.2 [ 13.657332] Key type dns_resolver registered [ 13.968576] NFS: Registering the id_resolver key type [ 13.969903] Key type id_resolver registered [ 13.971944] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ 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. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting 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 oleg236-client login: [ 31.854577] hrtimer: interrupt took 2759997 ns [ 85.599988] libcfs: loading out-of-tree module taints kernel. [ 85.770586] Key type ._llcrypt registered [ 85.771884] Key type .llcrypt registered [ 86.211211] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 86.219976] alg: No test for adler32 (adler32-zlib) [ 87.879234] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 89.057241] LNet: Added LNI 192.168.202.36@tcp [8/256/0/180] [ 90.967209] Key type lgssc registered [ 93.294223] Lustre: Echo OBD driver; http://www.lustre.org/ [ 100.421961] alg: No test for zstdfast (zstdfast-lustre-generic) [ 100.465556] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 253.207135] Lustre: Mounted lustre-client [ 258.848867] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 277.291670] Lustre: DEBUG MARKER: oleg236-client.virtnet: executing check_logdir /tmp/testlogs/ [ 279.007471] Lustre: lustre-OST0000-osc-ffff9fa604564000: disconnect after 24s idle [ 283.412784] Lustre: DEBUG MARKER: oleg236-client.virtnet: executing yml_node [ 290.699441] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 294.234847] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 298.151868] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 300.134540] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:36:31 EDT 2026 [ 322.019540] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 323.983436] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 325.445562] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a 130b 130c 130d 130e 130f 130g [ 327.501085] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51b 51c 51e 834 [ 329.451961] Lustre: DEBUG MARKER: === sanity: start setup 12:37:00 (1789058220) === [ 334.449306] Lustre: DEBUG MARKER: oleg236-client.virtnet: executing check_config_client /mnt/lustre [ 356.125822] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 367.859400] Lustre: DEBUG MARKER: === sanity: finish setup 12:37:39 (1789058259) === [ 377.684441] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:37:48 (1789058268) [ 378.491969] lustre_kcompr_18415: ***** [ 378.500461] lustre_kcompr_18415: (de)compression test on random binary data [ 378.509500] lustre_kcompr_18415: ***** [ 378.547490] lustre_kcompr_18415: compr lz4(1) in 64kB chunks took 2852 us (1402 MB/s), compress ratio: 96.60 [ 378.558350] lustre_kcompr_18415: compr lz4(1) in 128kB chunks took 2990 us (1337 MB/s), compress ratio: 102.35 [ 378.568464] lustre_kcompr_18415: compr lz4(1) in 256kB chunks took 3302 us (1211 MB/s), compress ratio: 104.55 [ 378.583217] lustre_kcompr_18415: compr lz4(1) in 512kB chunks took 3597 us (1112 MB/s), compress ratio: 106.50 [ 378.591556] lustre_kcompr_18415: compr lz4(1) in 1024kB chunks took 1365 us (2930 MB/s), compress ratio: 107.35 [ 378.608174] lustre_kcompr_18415: compr lz4(1) in 2048kB chunks took 2346 us (1705 MB/s), compress ratio: 107.59 [ 378.628301] lustre_kcompr_18415: compr lz4(1) in 4096kB chunks took 2888 us (1385 MB/s), compress ratio: 107.97 [ 378.656365] lustre_kcompr_18415: decompr lz4(1) took 6072 us (6 MB/s) [ 378.661761] lustre_kcompr_18415: test_comp_compress_decompress(lz4,1) ret 0 [ 378.666721] lustre_kcompr_18415: acompr lz4(1) of 128kB chunks took 103 us (1213 MB/s), compress ratio: 105.27 [ 378.676980] lustre_kcompr_18415: adecompr lz4(1) took 134 us (8 MB/s) [ 378.722216] lustre_kcompr_18415: test_acomp_compress_decompress(lz4,1) ret 0 [ 378.772302] lustre_kcompr_18415: compr lz4(4) in 64kB chunks took 2297 us (1741 MB/s), compress ratio: 82.67 [ 378.783219] lustre_kcompr_18415: compr lz4(4) in 128kB chunks took 1880 us (2127 MB/s), compress ratio: 93.15 [ 378.806194] lustre_kcompr_18415: compr lz4(4) in 256kB chunks took 2872 us (1392 MB/s), compress ratio: 98.92 [ 378.820147] lustre_kcompr_18415: compr lz4(4) in 512kB chunks took 2890 us (1384 MB/s), compress ratio: 102.32 [ 378.838409] lustre_kcompr_18415: compr lz4(4) in 1024kB chunks took 2120 us (1886 MB/s), compress ratio: 104.25 [ 378.859524] lustre_kcompr_18415: compr lz4(4) in 2048kB chunks took 4403 us (908 MB/s), compress ratio: 105.33 [ 378.881508] lustre_kcompr_18415: compr lz4(4) in 4096kB chunks took 12244 us (326 MB/s), compress ratio: 105.59 [ 378.916355] lustre_kcompr_18415: decompr lz4(4) took 5910 us (6 MB/s) [ 378.922232] lustre_kcompr_18415: test_comp_compress_decompress(lz4,4) ret 0 [ 378.928322] lustre_kcompr_18415: acompr lz4(4) of 128kB chunks took 87 us (1436 MB/s), compress ratio: 90.70 [ 378.936320] lustre_kcompr_18415: adecompr lz4(4) took 272 us (5 MB/s) [ 378.962396] lustre_kcompr_18415: test_acomp_compress_decompress(lz4,4) ret 0 [ 379.005330] lustre_kcompr_18415: compr lz4(9) in 64kB chunks took 3149 us (1270 MB/s), compress ratio: 61.41 [ 379.025425] lustre_kcompr_18415: compr lz4(9) in 128kB chunks took 6107 us (654 MB/s), compress ratio: 76.91 [ 379.045796] lustre_kcompr_18415: compr lz4(9) in 256kB chunks took 1351 us (2960 MB/s), compress ratio: 88.12 [ 379.061480] lustre_kcompr_18415: compr lz4(9) in 512kB chunks took 4518 us (885 MB/s), compress ratio: 94.27 [ 379.087971] lustre_kcompr_18415: compr lz4(9) in 1024kB chunks took 5410 us (739 MB/s), compress ratio: 97.78 [ 379.118485] lustre_kcompr_18415: compr lz4(9) in 2048kB chunks took 3572 us (1119 MB/s), compress ratio: 100.57 [ 379.135515] lustre_kcompr_18415: compr lz4(9) in 4096kB chunks took 5031 us (795 MB/s), compress ratio: 101.72 [ 379.182726] lustre_kcompr_18415: decompr lz4(9) took 1649 us (23 MB/s) [ 379.192626] lustre_kcompr_18415: test_comp_compress_decompress(lz4,9) ret 0 [ 379.208975] lustre_kcompr_18415: acompr lz4(9) of 128kB chunks took 93 us (1344 MB/s), compress ratio: 66.03 [ 379.226667] lustre_kcompr_18415: adecompr lz4(9) took 120 us (15 MB/s) [ 379.278311] lustre_kcompr_18415: test_acomp_compress_decompress(lz4,9) ret 0 [ 379.337915] lustre_kcompr_18415: compr lz4(15) in 64kB chunks took 5579 us (716 MB/s), compress ratio: 29.50 [ 379.363138] lustre_kcompr_18415: compr lz4(15) in 128kB chunks took 4674 us (855 MB/s), compress ratio: 43.72 [ 379.380634] lustre_kcompr_18415: compr lz4(15) in 256kB chunks took 6688 us (598 MB/s), compress ratio: 59.70 [ 379.403543] lustre_kcompr_18415: compr lz4(15) in 512kB chunks took 6254 us (639 MB/s), compress ratio: 73.74 [ 379.430741] lustre_kcompr_18415: compr lz4(15) in 1024kB chunks took 5161 us (775 MB/s), compress ratio: 81.76 [ 379.445225] lustre_kcompr_18415: compr lz4(15) in 2048kB chunks took 8301 us (481 MB/s), compress ratio: 87.34 [ 379.474512] lustre_kcompr_18415: compr lz4(15) in 4096kB chunks took 6455 us (619 MB/s), compress ratio: 88.65 [ 379.502336] lustre_kcompr_18415: decompr lz4(15) took 5106 us (8 MB/s) [ 379.515781] lustre_kcompr_18415: test_comp_compress_decompress(lz4,15) ret 0 [ 379.531166] lustre_kcompr_18415: acompr lz4(15) of 128kB chunks took 5226 us (23 MB/s), compress ratio: 39.20 [ 379.547321] lustre_kcompr_18415: adecompr lz4(15) took 134 us (23 MB/s) [ 379.635691] lustre_kcompr_18415: test_acomp_compress_decompress(lz4,15) ret 0 [ 379.723746] lustre_kcompr_18415: compr lz4hc(1) in 64kB chunks took 63618 us (62 MB/s), compress ratio: 97.77 [ 379.806461] lustre_kcompr_18415: compr lz4hc(1) in 128kB chunks took 65269 us (61 MB/s), compress ratio: 103.70 [ 379.883700] lustre_kcompr_18415: compr lz4hc(1) in 256kB chunks took 58223 us (68 MB/s), compress ratio: 106.95 [ 379.976318] lustre_kcompr_18415: compr lz4hc(1) in 512kB chunks took 77383 us (51 MB/s), compress ratio: 108.65 [ 380.044733] lustre_kcompr_18415: compr lz4hc(1) in 1024kB chunks took 59188 us (67 MB/s), compress ratio: 109.52 [ 380.161567] lustre_kcompr_18415: compr lz4hc(1) in 2048kB chunks took 108600 us (36 MB/s), compress ratio: 109.96 [ 380.225403] lustre_kcompr_18415: compr lz4hc(1) in 4096kB chunks took 46267 us (86 MB/s), compress ratio: 110.19 [ 380.253981] lustre_kcompr_18415: decompr lz4hc(1) took 6174 us (5 MB/s) [ 380.261119] lustre_kcompr_18415: test_comp_compress_decompress(lz4hc,1) ret 0 [ 380.275158] lustre_kcompr_18415: acompr lz4hc(1) of 128kB chunks took 3451 us (36 MB/s), compress ratio: 101.13 [ 380.283212] lustre_kcompr_18415: adecompr lz4hc(1) took 282 us (4 MB/s) [ 380.313567] lustre_kcompr_18415: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 380.419876] lustre_kcompr_18415: compr lz4hc(3) in 64kB chunks took 84090 us (47 MB/s), compress ratio: 98.30 [ 380.529755] lustre_kcompr_18415: compr lz4hc(3) in 128kB chunks took 89156 us (44 MB/s), compress ratio: 104.25 [ 380.631339] lustre_kcompr_18415: compr lz4hc(3) in 256kB chunks took 89304 us (44 MB/s), compress ratio: 107.48 [ 380.729582] lustre_kcompr_18415: compr lz4hc(3) in 512kB chunks took 86545 us (46 MB/s), compress ratio: 109.19 [ 380.843469] lustre_kcompr_18415: compr lz4hc(3) in 1024kB chunks took 96490 us (41 MB/s), compress ratio: 110.07 [ 380.933133] lustre_kcompr_18415: compr lz4hc(3) in 2048kB chunks took 81361 us (49 MB/s), compress ratio: 110.52 [ 381.027746] lustre_kcompr_18415: compr lz4hc(3) in 4096kB chunks took 89070 us (44 MB/s), compress ratio: 110.74 [ 381.068710] lustre_kcompr_18415: decompr lz4hc(3) took 11541 us (3 MB/s) [ 381.078368] lustre_kcompr_18415: test_comp_compress_decompress(lz4hc,3) ret 0 [ 381.086549] lustre_kcompr_18415: acompr lz4hc(3) of 128kB chunks took 910 us (137 MB/s), compress ratio: 102.24 [ 381.100207] lustre_kcompr_18415: adecompr lz4hc(3) took 121 us (10 MB/s) [ 381.215464] lustre_kcompr_18415: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 382.429853] lustre_kcompr_18415: compr lz4hc(8) in 64kB chunks took 1189872 us (3 MB/s), compress ratio: 104.57 [ 383.869319] lustre_kcompr_18415: compr lz4hc(8) in 128kB chunks took 1431387 us (2 MB/s), compress ratio: 111.72 [ 385.225910] lustre_kcompr_18415: compr lz4hc(8) in 256kB chunks took 1345333 us (2 MB/s), compress ratio: 115.57 [ 386.228265] lustre_kcompr_18415: compr lz4hc(8) in 512kB chunks took 992872 us (4 MB/s), compress ratio: 117.66 [ 387.277248] lustre_kcompr_18415: compr lz4hc(8) in 1024kB chunks took 1038330 us (3 MB/s), compress ratio: 118.69 [ 388.762597] lustre_kcompr_18415: compr lz4hc(8) in 2048kB chunks took 1478889 us (2 MB/s), compress ratio: 119.19 [ 390.253502] lustre_kcompr_18415: compr lz4hc(8) in 4096kB chunks took 1480895 us (2 MB/s), compress ratio: 119.45 [ 390.274249] lustre_kcompr_18415: decompr lz4hc(8) took 3797 us (8 MB/s) [ 390.278599] lustre_kcompr_18415: test_comp_compress_decompress(lz4hc,8) ret 0 [ 390.332332] lustre_kcompr_18415: acompr lz4hc(8) of 128kB chunks took 45051 us (2 MB/s), compress ratio: 109.31 [ 390.349512] lustre_kcompr_18415: adecompr lz4hc(8) took 4455 us (0 MB/s) [ 390.406170] lustre_kcompr_18415: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 391.614511] lustre_kcompr_18415: compr lz4hc(15) in 64kB chunks took 1190932 us (3 MB/s), compress ratio: 105.17 [ 391.656481] Lustre: lustre-OST0000-osc-ffff9fa604564000: disconnect after 23s idle [ 391.674816] Lustre: Skipped 1 previous similar message [ 393.165475] lustre_kcompr_18415: compr lz4hc(15) in 128kB chunks took 1537924 us (2 MB/s), compress ratio: 112.85 [ 394.735807] lustre_kcompr_18415: compr lz4hc(15) in 256kB chunks took 1565455 us (2 MB/s), compress ratio: 117.09 [ 396.336895] lustre_kcompr_18415: compr lz4hc(15) in 512kB chunks took 1589581 us (2 MB/s), compress ratio: 119.35 [ 398.063507] lustre_kcompr_18415: compr lz4hc(15) in 1024kB chunks took 1709390 us (2 MB/s), compress ratio: 120.48 [ 400.064920] lustre_kcompr_18415: compr lz4hc(15) in 2048kB chunks took 1994112 us (2 MB/s), compress ratio: 121.04 [ 401.733916] lustre_kcompr_18415: compr lz4hc(15) in 4096kB chunks took 1653623 us (2 MB/s), compress ratio: 121.31 [ 401.765303] lustre_kcompr_18415: decompr lz4hc(15) took 3218 us (10 MB/s) [ 401.777858] lustre_kcompr_18415: test_comp_compress_decompress(lz4hc,15) ret 0 [ 401.852479] lustre_kcompr_18415: acompr lz4hc(15) of 128kB chunks took 64895 us (1 MB/s), compress ratio: 110.14 [ 401.861257] lustre_kcompr_18415: adecompr lz4hc(15) took 144 us (7 MB/s) [ 401.902542] lustre_kcompr_18415: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 401.911279] lustre_kcompr_18415: compr lzo(-1) in 64kB chunks took 4940 us (809 MB/s), compress ratio: 81.82 [ 401.923991] lustre_kcompr_18415: compr lzo(-1) in 128kB chunks took 3686 us (1085 MB/s), compress ratio: 86.97 [ 401.936667] lustre_kcompr_18415: compr lzo(-1) in 256kB chunks took 2594 us (1542 MB/s), compress ratio: 86.59 [ 401.953811] lustre_kcompr_18415: compr lzo(-1) in 512kB chunks took 5480 us (729 MB/s), compress ratio: 88.08 [ 401.974237] lustre_kcompr_18415: compr lzo(-1) in 1024kB chunks took 7109 us (562 MB/s), compress ratio: 88.91 [ 401.993722] lustre_kcompr_18415: compr lzo(-1) in 2048kB chunks took 4353 us (918 MB/s), compress ratio: 89.70 [ 402.010315] lustre_kcompr_18415: compr lzo(-1) in 4096kB chunks took 7121 us (561 MB/s), compress ratio: 88.85 [ 402.048305] lustre_kcompr_18415: decompr lzo(-1) took 6198 us (7 MB/s) [ 402.058777] lustre_kcompr_18415: test_comp_compress_decompress(lzo,-1) ret 0 [ 402.071359] lustre_kcompr_18415: acompr lzo(-1) of 128kB chunks took 109 us (1146 MB/s), compress ratio: 89.40 [ 402.077768] lustre_kcompr_18415: adecompr lzo(-1) took 146 us (9 MB/s) [ 402.094667] lustre_kcompr_18415: test_acomp_compress_decompress(lzo,-1) ret 0 [ 402.809906] lustre_kcompr_18415: compr deflate(1) in 64kB chunks took 678043 us (5 MB/s), compress ratio: 97.98 [ 403.458623] lustre_kcompr_18415: compr deflate(1) in 128kB chunks took 636487 us (6 MB/s), compress ratio: 108.46 [ 404.055951] lustre_kcompr_18415: compr deflate(1) in 256kB chunks took 582127 us (6 MB/s), compress ratio: 114.82 [ 404.733557] lustre_kcompr_18415: compr deflate(1) in 512kB chunks took 669585 us (5 MB/s), compress ratio: 118.75 [ 405.283340] lustre_kcompr_18415: compr deflate(1) in 1024kB chunks took 542511 us (7 MB/s), compress ratio: 120.72 [ 405.928241] lustre_kcompr_18415: compr deflate(1) in 2048kB chunks took 635132 us (6 MB/s), compress ratio: 121.66 [ 406.470779] lustre_kcompr_18415: compr deflate(1) in 4096kB chunks took 536971 us (7 MB/s), compress ratio: 121.94 [ 406.496887] lustre_kcompr_18415: decompr deflate(1) took 11393 us (2 MB/s) [ 406.511926] lustre_kcompr_18415: test_comp_compress_decompress(deflate,1) ret 0 [ 406.540135] lustre_kcompr_18415: acompr deflate(1) of 128kB chunks took 16660 us (7 MB/s), compress ratio: 105.10 [ 406.552314] lustre_kcompr_18415: adecompr deflate(1) took 223 us (5 MB/s) [ 406.568217] lustre_kcompr_18415: test_acomp_compress_decompress(deflate,1) ret 0 [ 407.143235] lustre_kcompr_18415: compr deflate(6) in 64kB chunks took 544262 us (7 MB/s), compress ratio: 97.98 [ 407.748268] lustre_kcompr_18415: compr deflate(6) in 128kB chunks took 592747 us (6 MB/s), compress ratio: 108.46 [ 408.280582] lustre_kcompr_18415: compr deflate(6) in 256kB chunks took 520185 us (7 MB/s), compress ratio: 114.82 [ 408.695181] lustre_kcompr_18415: compr deflate(6) in 512kB chunks took 410243 us (9 MB/s), compress ratio: 118.75 [ 409.074324] lustre_kcompr_18415: compr deflate(6) in 1024kB chunks took 360335 us (11 MB/s), compress ratio: 120.72 [ 409.635297] lustre_kcompr_18415: compr deflate(6) in 2048kB chunks took 555425 us (7 MB/s), compress ratio: 121.66 [ 410.113404] lustre_kcompr_18415: compr deflate(6) in 4096kB chunks took 462513 us (8 MB/s), compress ratio: 121.94 [ 410.133568] lustre_kcompr_18415: decompr deflate(6) took 6885 us (4 MB/s) [ 410.140604] lustre_kcompr_18415: test_comp_compress_decompress(deflate,6) ret 0 [ 410.162695] lustre_kcompr_18415: acompr deflate(6) of 128kB chunks took 13929 us (8 MB/s), compress ratio: 105.10 [ 410.169099] lustre_kcompr_18415: adecompr deflate(6) took 195 us (6 MB/s) [ 410.175431] lustre_kcompr_18415: test_acomp_compress_decompress(deflate,6) ret 0 [ 410.598642] lustre_kcompr_18415: compr deflate(9) in 64kB chunks took 412920 us (9 MB/s), compress ratio: 97.98 [ 411.073969] lustre_kcompr_18415: compr deflate(9) in 128kB chunks took 464191 us (8 MB/s), compress ratio: 108.46 [ 411.639602] lustre_kcompr_18415: compr deflate(9) in 256kB chunks took 557693 us (7 MB/s), compress ratio: 114.82 [ 411.996596] lustre_kcompr_18415: compr deflate(9) in 512kB chunks took 343646 us (11 MB/s), compress ratio: 118.75 [ 412.366167] lustre_kcompr_18415: compr deflate(9) in 1024kB chunks took 353365 us (11 MB/s), compress ratio: 120.72 [ 412.854529] lustre_kcompr_18415: compr deflate(9) in 2048kB chunks took 484390 us (8 MB/s), compress ratio: 121.66 [ 413.219235] lustre_kcompr_18415: compr deflate(9) in 4096kB chunks took 352404 us (11 MB/s), compress ratio: 121.94 [ 413.241685] lustre_kcompr_18415: decompr deflate(9) took 8299 us (3 MB/s) [ 413.250653] lustre_kcompr_18415: test_comp_compress_decompress(deflate,9) ret 0 [ 413.272514] lustre_kcompr_18415: acompr deflate(9) of 128kB chunks took 16219 us (7 MB/s), compress ratio: 105.10 [ 413.278871] lustre_kcompr_18415: adecompr deflate(9) took 189 us (6 MB/s) [ 413.286385] lustre_kcompr_18415: test_acomp_compress_decompress(deflate,9) ret 0 [ 413.304651] lustre_kcompr_18415: compr zstd(0) in 64kB chunks took 6320 us (632 MB/s), compress ratio: 159.24 [ 413.327216] lustre_kcompr_18415: compr zstd(0) in 128kB chunks took 17968 us (222 MB/s), compress ratio: 192.77 [ 413.401828] lustre_kcompr_18415: compr zstd(0) in 256kB chunks took 57906 us (69 MB/s), compress ratio: 204.86 [ 413.445604] lustre_kcompr_18415: compr zstd(0) in 512kB chunks took 35962 us (111 MB/s), compress ratio: 210.76 [ 413.458298] lustre_kcompr_18415: compr zstd(0) in 1024kB chunks took 7053 us (567 MB/s), compress ratio: 213.90 [ 413.480657] lustre_kcompr_18415: compr zstd(0) in 2048kB chunks took 12274 us (325 MB/s), compress ratio: 215.24 [ 413.499716] lustre_kcompr_18415: compr zstd(0) in 4096kB chunks took 8466 us (472 MB/s), compress ratio: 216.05 [ 413.523164] lustre_kcompr_18415: decompr zstd(0) took 2267 us (8 MB/s) [ 413.533749] lustre_kcompr_18415: test_comp_compress_decompress(zstd,0) ret 0 [ 413.547949] lustre_kcompr_18415: acompr zstd(0) of 128kB chunks took 245 us (510 MB/s), compress ratio: 186.71 [ 413.557140] lustre_kcompr_18415: adecompr zstd(0) took 120 us (5 MB/s) [ 413.569274] lustre_kcompr_18415: test_acomp_compress_decompress(zstd,0) ret 0 [ 413.606987] lustre_kcompr_18415: compr zstd(1) in 64kB chunks took 11951 us (334 MB/s), compress ratio: 158.38 [ 413.622760] lustre_kcompr_18415: compr zstd(1) in 128kB chunks took 6984 us (572 MB/s), compress ratio: 190.23 [ 413.642128] lustre_kcompr_18415: compr zstd(1) in 256kB chunks took 9695 us (412 MB/s), compress ratio: 203.95 [ 413.661438] lustre_kcompr_18415: compr zstd(1) in 512kB chunks took 3102 us (1289 MB/s), compress ratio: 209.28 [ 413.683220] lustre_kcompr_18415: compr zstd(1) in 1024kB chunks took 2976 us (1344 MB/s), compress ratio: 213.41 [ 413.697442] lustre_kcompr_18415: compr zstd(1) in 2048kB chunks took 4442 us (900 MB/s), compress ratio: 213.55 [ 413.709031] lustre_kcompr_18415: compr zstd(1) in 4096kB chunks took 2586 us (1546 MB/s), compress ratio: 212.83 [ 413.734099] lustre_kcompr_18415: decompr zstd(1) took 4261 us (4 MB/s) [ 413.743422] lustre_kcompr_18415: test_comp_compress_decompress(zstd,1) ret 0 [ 413.751093] lustre_kcompr_18415: acompr zstd(1) of 128kB chunks took 341 us (366 MB/s), compress ratio: 186.71 [ 413.758721] lustre_kcompr_18415: adecompr zstd(1) took 109 us (6 MB/s) [ 413.774121] lustre_kcompr_18415: test_acomp_compress_decompress(zstd,1) ret 0 [ 414.033671] lustre_kcompr_18415: compr zstd(10) in 64kB chunks took 239307 us (16 MB/s), compress ratio: 161.48 [ 414.369606] lustre_kcompr_18415: compr zstd(10) in 128kB chunks took 323412 us (12 MB/s), compress ratio: 184.33 [ 414.604743] lustre_kcompr_18415: compr zstd(10) in 256kB chunks took 224144 us (17 MB/s), compress ratio: 196.03 [ 414.759327] lustre_kcompr_18415: compr zstd(10) in 512kB chunks took 148369 us (26 MB/s), compress ratio: 218.33 [ 415.008397] lustre_kcompr_18415: compr zstd(10) in 1024kB chunks took 244123 us (16 MB/s), compress ratio: 222.63 [ 415.770711] lustre_kcompr_18415: compr zstd(10) in 2048kB chunks took 749306 us (5 MB/s), compress ratio: 224.46 [ 415.898697] lustre_kcompr_18415: compr zstd(10) in 4096kB chunks took 106773 us (37 MB/s), compress ratio: 225.47 [ 415.916120] lustre_kcompr_18415: decompr zstd(10) took 2267 us (7 MB/s) [ 415.922041] lustre_kcompr_18415: test_comp_compress_decompress(zstd,10) ret 0 [ 415.932117] lustre_kcompr_18415: acompr zstd(10) of 128kB chunks took 5320 us (23 MB/s), compress ratio: 177.60 [ 415.942797] lustre_kcompr_18415: adecompr zstd(10) took 320 us (2 MB/s) [ 415.949624] lustre_kcompr_18415: test_acomp_compress_decompress(zstd,10) ret 0 [ 417.200819] lustre_kcompr_18415: compr zstd(15) in 64kB chunks took 1200385 us (3 MB/s), compress ratio: 170.50 [ 418.263148] lustre_kcompr_18415: compr zstd(15) in 128kB chunks took 1051279 us (3 MB/s), compress ratio: 196.42 [ 419.199695] lustre_kcompr_18415: compr zstd(15) in 256kB chunks took 922091 us (4 MB/s), compress ratio: 210.81 [ 420.085807] lustre_kcompr_18415: compr zstd(15) in 512kB chunks took 877255 us (4 MB/s), compress ratio: 217.81 [ 420.807475] lustre_kcompr_18415: compr zstd(15) in 1024kB chunks took 705273 us (5 MB/s), compress ratio: 219.52 [ 422.249730] lustre_kcompr_18415: compr zstd(15) in 2048kB chunks took 1434020 us (2 MB/s), compress ratio: 221.79 [ 424.521895] lustre_kcompr_18415: compr zstd(15) in 4096kB chunks took 2264637 us (1 MB/s), compress ratio: 221.25 [ 424.544705] lustre_kcompr_18415: decompr zstd(15) took 2102 us (8 MB/s) [ 424.557102] lustre_kcompr_18415: test_comp_compress_decompress(zstd,15) ret 0 [ 424.614630] lustre_kcompr_18415: acompr zstd(15) of 128kB chunks took 43921 us (2 MB/s), compress ratio: 191.62 [ 424.624307] lustre_kcompr_18415: adecompr zstd(15) took 421 us (1 MB/s) [ 424.665069] lustre_kcompr_18415: test_acomp_compress_decompress(zstd,15) ret 0 [ 424.699585] lustre_kcompr_18415: compr zstdfast(1) in 64kB chunks took 7367 us (542 MB/s), compress ratio: 158.38 [ 424.710151] lustre_kcompr_18415: compr zstdfast(1) in 128kB chunks took 2887 us (1385 MB/s), compress ratio: 190.23 [ 424.730121] lustre_kcompr_18415: compr zstdfast(1) in 256kB chunks took 3887 us (1029 MB/s), compress ratio: 203.95 [ 424.739900] lustre_kcompr_18415: compr zstdfast(1) in 512kB chunks took 3698 us (1081 MB/s), compress ratio: 209.28 [ 424.749266] lustre_kcompr_18415: compr zstdfast(1) in 1024kB chunks took 2818 us (1419 MB/s), compress ratio: 213.41 [ 424.757545] lustre_kcompr_18415: compr zstdfast(1) in 2048kB chunks took 3112 us (1285 MB/s), compress ratio: 213.55 [ 424.771410] lustre_kcompr_18415: compr zstdfast(1) in 4096kB chunks took 2310 us (1731 MB/s), compress ratio: 212.93 [ 424.800119] lustre_kcompr_18415: decompr zstdfast(1) took 8810 us (2 MB/s) [ 424.813602] lustre_kcompr_18415: test_comp_compress_decompress(zstdfast,1) ret 0 [ 424.826869] lustre_kcompr_18415: acompr zstdfast(1) of 128kB chunks took 160 us (781 MB/s), compress ratio: 186.71 [ 424.837350] lustre_kcompr_18415: adecompr zstdfast(1) took 103 us (6 MB/s) [ 424.859111] lustre_kcompr_18415: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 424.890523] lustre_kcompr_18415: compr zstdfast(5) in 64kB chunks took 9814 us (407 MB/s), compress ratio: 140.05 [ 424.904592] lustre_kcompr_18415: compr zstdfast(5) in 128kB chunks took 4053 us (986 MB/s), compress ratio: 165.00 [ 424.915372] lustre_kcompr_18415: compr zstdfast(5) in 256kB chunks took 2497 us (1601 MB/s), compress ratio: 175.60 [ 424.926356] lustre_kcompr_18415: compr zstdfast(5) in 512kB chunks took 3367 us (1188 MB/s), compress ratio: 179.55 [ 424.933749] lustre_kcompr_18415: compr zstdfast(5) in 1024kB chunks took 2803 us (1427 MB/s), compress ratio: 181.93 [ 424.940306] lustre_kcompr_18415: compr zstdfast(5) in 2048kB chunks took 1951 us (2050 MB/s), compress ratio: 182.18 [ 424.948957] lustre_kcompr_18415: compr zstdfast(5) in 4096kB chunks took 3113 us (1284 MB/s), compress ratio: 185.89 [ 424.962949] lustre_kcompr_18415: decompr zstdfast(5) took 2938 us (7 MB/s) [ 424.968951] lustre_kcompr_18415: test_comp_compress_decompress(zstdfast,5) ret 0 [ 424.974313] lustre_kcompr_18415: acompr zstdfast(5) of 128kB chunks took 153 us (816 MB/s), compress ratio: 154.56 [ 424.982538] lustre_kcompr_18415: adecompr zstdfast(5) took 118 us (6 MB/s) [ 424.992926] lustre_kcompr_18415: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 425.027707] lustre_kcompr_18415: compr zstdfast(12) in 64kB chunks took 11735 us (340 MB/s), compress ratio: 38.13 [ 425.045179] lustre_kcompr_18415: compr zstdfast(12) in 128kB chunks took 4560 us (877 MB/s), compress ratio: 43.19 [ 425.070803] lustre_kcompr_18415: compr zstdfast(12) in 256kB chunks took 7211 us (554 MB/s), compress ratio: 46.88 [ 425.090887] lustre_kcompr_18415: compr zstdfast(12) in 512kB chunks took 3216 us (1243 MB/s), compress ratio: 48.92 [ 425.103666] lustre_kcompr_18415: compr zstdfast(12) in 1024kB chunks took 5545 us (721 MB/s), compress ratio: 52.99 [ 425.115333] lustre_kcompr_18415: compr zstdfast(12) in 2048kB chunks took 3629 us (1102 MB/s), compress ratio: 67.26 [ 425.128301] lustre_kcompr_18415: compr zstdfast(12) in 4096kB chunks took 3017 us (1325 MB/s), compress ratio: 71.90 [ 425.144584] lustre_kcompr_18415: decompr zstdfast(12) took 1933 us (28 MB/s) [ 425.151732] lustre_kcompr_18415: test_comp_compress_decompress(zstdfast,12) ret 0 [ 425.158671] lustre_kcompr_18415: acompr zstdfast(12) of 128kB chunks took 143 us (874 MB/s), compress ratio: 40.90 [ 425.166620] lustre_kcompr_18415: adecompr zstdfast(12) took 217 us (14 MB/s) [ 425.176767] lustre_kcompr_18415: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 425.196196] lustre_kcompr_18415: compr zstdfast(15) in 64kB chunks took 4310 us (928 MB/s), compress ratio: 19.04 [ 425.205154] lustre_kcompr_18415: compr zstdfast(15) in 128kB chunks took 2020 us (1980 MB/s), compress ratio: 20.04 [ 425.211589] lustre_kcompr_18415: compr zstdfast(15) in 256kB chunks took 3242 us (1233 MB/s), compress ratio: 20.52 [ 425.221983] lustre_kcompr_18415: compr zstdfast(15) in 512kB chunks took 2783 us (1437 MB/s), compress ratio: 21.97 [ 425.233761] lustre_kcompr_18415: compr zstdfast(15) in 1024kB chunks took 2497 us (1601 MB/s), compress ratio: 25.35 [ 425.241346] lustre_kcompr_18415: compr zstdfast(15) in 2048kB chunks took 2729 us (1465 MB/s), compress ratio: 29.84 [ 425.248684] lustre_kcompr_18415: compr zstdfast(15) in 4096kB chunks took 2941 us (1360 MB/s), compress ratio: 33.49 [ 425.263301] lustre_kcompr_18415: decompr zstdfast(15) took 2820 us (42 MB/s) [ 425.267824] lustre_kcompr_18415: test_comp_compress_decompress(zstdfast,15) ret 0 [ 425.272780] lustre_kcompr_18415: acompr zstdfast(15) of 128kB chunks took 156 us (801 MB/s), compress ratio: 17.51 [ 425.278450] lustre_kcompr_18415: adecompr zstdfast(15) took 118 us (60 MB/s) [ 425.284207] lustre_kcompr_18415: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 425.288611] lustre_kcompr_18415: SUCCESS [ 432.685235] lustre_kcompr_23075: ***** [ 432.690504] lustre_kcompr_23075: (de)compression test on provided file /tmp/f84.sanity [ 432.696302] lustre_kcompr_23075: ***** [ 432.780453] lustre_kcompr_23075: compr lz4(1) in 64kB chunks took 45483 us (87 MB/s), compress ratio: 2.93 [ 432.841365] lustre_kcompr_23075: compr lz4(1) in 128kB chunks took 32395 us (123 MB/s), compress ratio: 3.04 [ 432.896641] lustre_kcompr_23075: compr lz4(1) in 256kB chunks took 48242 us (82 MB/s), compress ratio: 3.08 [ 432.945323] lustre_kcompr_23075: compr lz4(1) in 512kB chunks took 39848 us (100 MB/s), compress ratio: 3.10 [ 432.991682] lustre_kcompr_23075: compr lz4(1) in 1024kB chunks took 38723 us (103 MB/s), compress ratio: 3.11 [ 433.017592] lustre_kcompr_23075: compr lz4(1) in 2048kB chunks took 20913 us (191 MB/s), compress ratio: 3.11 [ 433.048801] lustre_kcompr_23075: compr lz4(1) in 4096kB chunks took 26688 us (149 MB/s), compress ratio: 3.12 [ 433.076608] lustre_kcompr_23075: decompr lz4(1) took 6321 us (202 MB/s) [ 433.081218] lustre_kcompr_23075: test_comp_compress_decompress(lz4,1) ret 0 [ 433.090077] lustre_kcompr_23075: acompr lz4(1) of 128kB chunks took 1713 us (72 MB/s), compress ratio: 2.68 [ 433.103064] lustre_kcompr_23075: adecompr lz4(1) took 1212 us (38 MB/s) [ 433.110749] lustre_kcompr_23075: test_acomp_compress_decompress(lz4,1) ret 0 [ 433.163916] lustre_kcompr_23075: compr lz4(4) in 64kB chunks took 29110 us (137 MB/s), compress ratio: 2.67 [ 433.210044] lustre_kcompr_23075: compr lz4(4) in 128kB chunks took 39485 us (101 MB/s), compress ratio: 2.63 [ 433.273763] lustre_kcompr_23075: compr lz4(4) in 256kB chunks took 52086 us (76 MB/s), compress ratio: 2.68 [ 433.326202] lustre_kcompr_23075: compr lz4(4) in 512kB chunks took 46253 us (86 MB/s), compress ratio: 2.71 [ 433.368759] lustre_kcompr_23075: compr lz4(4) in 1024kB chunks took 36924 us (108 MB/s), compress ratio: 2.72 [ 433.427263] lustre_kcompr_23075: compr lz4(4) in 2048kB chunks took 44505 us (89 MB/s), compress ratio: 2.72 [ 433.461964] lustre_kcompr_23075: compr lz4(4) in 4096kB chunks took 26777 us (149 MB/s), compress ratio: 2.73 [ 433.503516] lustre_kcompr_23075: decompr lz4(4) took 16924 us (86 MB/s) [ 433.511601] lustre_kcompr_23075: test_comp_compress_decompress(lz4,4) ret 0 [ 433.520981] lustre_kcompr_23075: acompr lz4(4) of 128kB chunks took 936 us (133 MB/s), compress ratio: 2.30 [ 433.527626] lustre_kcompr_23075: adecompr lz4(4) took 392 us (138 MB/s) [ 433.534724] lustre_kcompr_23075: test_acomp_compress_decompress(lz4,4) ret 0 [ 433.580501] lustre_kcompr_23075: compr lz4(9) in 64kB chunks took 29053 us (137 MB/s), compress ratio: 2.30 [ 433.639593] lustre_kcompr_23075: compr lz4(9) in 128kB chunks took 54167 us (73 MB/s), compress ratio: 2.15 [ 433.672566] lustre_kcompr_23075: compr lz4(9) in 256kB chunks took 28160 us (142 MB/s), compress ratio: 2.20 [ 433.716275] lustre_kcompr_23075: compr lz4(9) in 512kB chunks took 36632 us (109 MB/s), compress ratio: 2.23 [ 433.767194] lustre_kcompr_23075: compr lz4(9) in 1024kB chunks took 40814 us (98 MB/s), compress ratio: 2.25 [ 433.814972] lustre_kcompr_23075: compr lz4(9) in 2048kB chunks took 33517 us (119 MB/s), compress ratio: 2.25 [ 433.854959] lustre_kcompr_23075: compr lz4(9) in 4096kB chunks took 30499 us (131 MB/s), compress ratio: 2.26 [ 433.885264] lustre_kcompr_23075: decompr lz4(9) took 5895 us (300 MB/s) [ 433.904194] lustre_kcompr_23075: test_comp_compress_decompress(lz4,9) ret 0 [ 433.920524] lustre_kcompr_23075: acompr lz4(9) of 128kB chunks took 1034 us (120 MB/s), compress ratio: 1.87 [ 433.934717] lustre_kcompr_23075: adecompr lz4(9) took 5969 us (11 MB/s) [ 433.962594] lustre_kcompr_23075: test_acomp_compress_decompress(lz4,9) ret 0 [ 434.020994] lustre_kcompr_23075: compr lz4(15) in 64kB chunks took 24186 us (165 MB/s), compress ratio: 1.63 [ 434.072526] lustre_kcompr_23075: compr lz4(15) in 128kB chunks took 34678 us (115 MB/s), compress ratio: 1.52 [ 434.115105] lustre_kcompr_23075: compr lz4(15) in 256kB chunks took 30716 us (130 MB/s), compress ratio: 1.56 [ 434.167562] lustre_kcompr_23075: compr lz4(15) in 512kB chunks took 42772 us (93 MB/s), compress ratio: 1.58 [ 434.221915] lustre_kcompr_23075: compr lz4(15) in 1024kB chunks took 37039 us (107 MB/s), compress ratio: 1.60 [ 434.290030] lustre_kcompr_23075: compr lz4(15) in 2048kB chunks took 43544 us (91 MB/s), compress ratio: 1.60 [ 434.309346] lustre_kcompr_23075: compr lz4(15) in 4096kB chunks took 12642 us (316 MB/s), compress ratio: 1.60 [ 434.323964] lustre_kcompr_23075: decompr lz4(15) took 3978 us (625 MB/s) [ 434.327616] lustre_kcompr_23075: test_comp_compress_decompress(lz4,15) ret 0 [ 434.332268] lustre_kcompr_23075: acompr lz4(15) of 128kB chunks took 570 us (219 MB/s), compress ratio: 1.33 [ 434.336780] lustre_kcompr_23075: adecompr lz4(15) took 214 us (439 MB/s) [ 434.341442] lustre_kcompr_23075: test_acomp_compress_decompress(lz4,15) ret 0 [ 434.526351] lustre_kcompr_23075: compr lz4hc(1) in 64kB chunks took 176558 us (22 MB/s), compress ratio: 3.58 [ 434.680587] lustre_kcompr_23075: compr lz4hc(1) in 128kB chunks took 140500 us (28 MB/s), compress ratio: 3.77 [ 434.855351] lustre_kcompr_23075: compr lz4hc(1) in 256kB chunks took 167519 us (23 MB/s), compress ratio: 3.88 [ 435.125136] lustre_kcompr_23075: compr lz4hc(1) in 512kB chunks took 265052 us (15 MB/s), compress ratio: 3.93 [ 435.516243] lustre_kcompr_23075: compr lz4hc(1) in 1024kB chunks took 377629 us (10 MB/s), compress ratio: 3.96 [ 435.851321] lustre_kcompr_23075: compr lz4hc(1) in 2048kB chunks took 313208 us (12 MB/s), compress ratio: 3.97 [ 436.137679] lustre_kcompr_23075: compr lz4hc(1) in 4096kB chunks took 280100 us (14 MB/s), compress ratio: 3.98 [ 436.170467] lustre_kcompr_23075: decompr lz4hc(1) took 13185 us (76 MB/s) [ 436.178963] lustre_kcompr_23075: test_comp_compress_decompress(lz4hc,1) ret 0 [ 436.190762] lustre_kcompr_23075: acompr lz4hc(1) of 128kB chunks took 6988 us (17 MB/s), compress ratio: 3.27 [ 436.198578] lustre_kcompr_23075: adecompr lz4hc(1) took 1077 us (35 MB/s) [ 436.205990] lustre_kcompr_23075: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 436.402697] lustre_kcompr_23075: compr lz4hc(3) in 64kB chunks took 184002 us (21 MB/s), compress ratio: 3.68 [ 436.706527] lustre_kcompr_23075: compr lz4hc(3) in 128kB chunks took 299548 us (13 MB/s), compress ratio: 3.91 [ 437.041354] lustre_kcompr_23075: compr lz4hc(3) in 256kB chunks took 324293 us (12 MB/s), compress ratio: 4.04 [ 437.470729] lustre_kcompr_23075: compr lz4hc(3) in 512kB chunks took 424202 us (9 MB/s), compress ratio: 4.10 [ 437.891962] lustre_kcompr_23075: compr lz4hc(3) in 1024kB chunks took 414471 us (9 MB/s), compress ratio: 4.13 [ 438.200915] lustre_kcompr_23075: compr lz4hc(3) in 2048kB chunks took 302457 us (13 MB/s), compress ratio: 4.15 [ 438.684498] lustre_kcompr_23075: compr lz4hc(3) in 4096kB chunks took 477225 us (8 MB/s), compress ratio: 4.16 [ 438.723876] lustre_kcompr_23075: decompr lz4hc(3) took 13879 us (69 MB/s) [ 438.738851] lustre_kcompr_23075: test_comp_compress_decompress(lz4hc,3) ret 0 [ 438.761460] lustre_kcompr_23075: acompr lz4hc(3) of 128kB chunks took 9577 us (13 MB/s), compress ratio: 3.38 [ 438.766646] lustre_kcompr_23075: adecompr lz4hc(3) took 246 us (149 MB/s) [ 438.790568] lustre_kcompr_23075: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 439.443186] lustre_kcompr_23075: compr lz4hc(8) in 64kB chunks took 613991 us (6 MB/s), compress ratio: 3.72 [ 440.289526] lustre_kcompr_23075: compr lz4hc(8) in 128kB chunks took 834656 us (4 MB/s), compress ratio: 3.96 [ 441.016549] lustre_kcompr_23075: compr lz4hc(8) in 256kB chunks took 714867 us (5 MB/s), compress ratio: 4.10 [ 441.922705] lustre_kcompr_23075: compr lz4hc(8) in 512kB chunks took 899003 us (4 MB/s), compress ratio: 4.17 [ 442.739597] lustre_kcompr_23075: compr lz4hc(8) in 1024kB chunks took 801084 us (4 MB/s), compress ratio: 4.21 [ 443.589282] lustre_kcompr_23075: compr lz4hc(8) in 2048kB chunks took 838772 us (4 MB/s), compress ratio: 4.22 [ 444.346318] lustre_kcompr_23075: compr lz4hc(8) in 4096kB chunks took 752730 us (5 MB/s), compress ratio: 4.23 [ 444.384727] lustre_kcompr_23075: decompr lz4hc(8) took 10181 us (92 MB/s) [ 444.403878] lustre_kcompr_23075: test_comp_compress_decompress(lz4hc,8) ret 0 [ 444.460569] lustre_kcompr_23075: acompr lz4hc(8) of 128kB chunks took 42293 us (2 MB/s), compress ratio: 3.42 [ 444.470738] lustre_kcompr_23075: adecompr lz4hc(8) took 288 us (126 MB/s) [ 444.495714] lustre_kcompr_23075: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 444.994220] lustre_kcompr_23075: compr lz4hc(15) in 64kB chunks took 471455 us (8 MB/s), compress ratio: 3.72 [ 445.493347] lustre_kcompr_23075: compr lz4hc(15) in 128kB chunks took 480657 us (8 MB/s), compress ratio: 3.96 [ 446.237541] lustre_kcompr_23075: compr lz4hc(15) in 256kB chunks took 732697 us (5 MB/s), compress ratio: 4.10 [ 447.098421] lustre_kcompr_23075: compr lz4hc(15) in 512kB chunks took 846122 us (4 MB/s), compress ratio: 4.17 [ 447.984949] lustre_kcompr_23075: compr lz4hc(15) in 1024kB chunks took 876635 us (4 MB/s), compress ratio: 4.21 [ 448.669457] lustre_kcompr_23075: compr lz4hc(15) in 2048kB chunks took 677685 us (5 MB/s), compress ratio: 4.22 [ 449.392471] lustre_kcompr_23075: compr lz4hc(15) in 4096kB chunks took 715955 us (5 MB/s), compress ratio: 4.23 [ 449.411859] lustre_kcompr_23075: decompr lz4hc(15) took 7263 us (130 MB/s) [ 449.415596] lustre_kcompr_23075: test_comp_compress_decompress(lz4hc,15) ret 0 [ 449.429719] lustre_kcompr_23075: acompr lz4hc(15) of 128kB chunks took 9609 us (13 MB/s), compress ratio: 3.42 [ 449.434890] lustre_kcompr_23075: adecompr lz4hc(15) took 286 us (127 MB/s) [ 449.440856] lustre_kcompr_23075: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 449.476924] lustre_kcompr_23075: compr lzo(-1) in 64kB chunks took 24065 us (166 MB/s), compress ratio: 2.90 [ 449.509317] lustre_kcompr_23075: compr lzo(-1) in 128kB chunks took 27340 us (146 MB/s), compress ratio: 2.95 [ 449.538436] lustre_kcompr_23075: compr lzo(-1) in 256kB chunks took 23824 us (167 MB/s), compress ratio: 2.96 [ 449.568982] lustre_kcompr_23075: compr lzo(-1) in 512kB chunks took 26795 us (149 MB/s), compress ratio: 2.98 [ 449.601712] lustre_kcompr_23075: compr lzo(-1) in 1024kB chunks took 27198 us (147 MB/s), compress ratio: 2.97 [ 449.634691] lustre_kcompr_23075: compr lzo(-1) in 2048kB chunks took 27291 us (146 MB/s), compress ratio: 2.97 [ 449.671949] lustre_kcompr_23075: compr lzo(-1) in 4096kB chunks took 31152 us (128 MB/s), compress ratio: 2.96 [ 449.707110] lustre_kcompr_23075: decompr lzo(-1) took 15891 us (84 MB/s) [ 449.711689] lustre_kcompr_23075: test_comp_compress_decompress(lzo,-1) ret 0 [ 449.717398] lustre_kcompr_23075: acompr lzo(-1) of 128kB chunks took 683 us (183 MB/s), compress ratio: 2.62 [ 449.722760] lustre_kcompr_23075: adecompr lzo(-1) took 422 us (113 MB/s) [ 449.746142] lustre_kcompr_23075: test_acomp_compress_decompress(lzo,-1) ret 0 [ 450.664619] lustre_kcompr_23075: compr deflate(1) in 64kB chunks took 895429 us (4 MB/s), compress ratio: 3.51 [ 451.367567] lustre_kcompr_23075: compr deflate(1) in 128kB chunks took 693961 us (5 MB/s), compress ratio: 3.53 [ 452.035706] lustre_kcompr_23075: compr deflate(1) in 256kB chunks took 662103 us (6 MB/s), compress ratio: 3.53 [ 452.788065] lustre_kcompr_23075: compr deflate(1) in 512kB chunks took 745633 us (5 MB/s), compress ratio: 3.54 [ 453.671444] lustre_kcompr_23075: compr deflate(1) in 1024kB chunks took 875907 us (4 MB/s), compress ratio: 3.54 [ 454.486459] lustre_kcompr_23075: compr deflate(1) in 2048kB chunks took 802994 us (4 MB/s), compress ratio: 3.54 [ 455.267457] lustre_kcompr_23075: compr deflate(1) in 4096kB chunks took 776695 us (5 MB/s), compress ratio: 3.54 [ 455.362540] lustre_kcompr_23075: decompr deflate(1) took 77443 us (14 MB/s) [ 455.381506] lustre_kcompr_23075: test_comp_compress_decompress(deflate,1) ret 0 [ 455.420806] lustre_kcompr_23075: acompr deflate(1) of 128kB chunks took 30959 us (4 MB/s), compress ratio: 3.09 [ 455.430483] lustre_kcompr_23075: adecompr deflate(1) took 1867 us (21 MB/s) [ 455.440024] lustre_kcompr_23075: test_acomp_compress_decompress(deflate,1) ret 0 [ 456.206251] lustre_kcompr_23075: compr deflate(6) in 64kB chunks took 744437 us (5 MB/s), compress ratio: 3.51 [ 457.202162] lustre_kcompr_23075: compr deflate(6) in 128kB chunks took 984216 us (4 MB/s), compress ratio: 3.53 [ 458.081926] lustre_kcompr_23075: compr deflate(6) in 256kB chunks took 868777 us (4 MB/s), compress ratio: 3.53 [ 458.788447] lustre_kcompr_23075: compr deflate(6) in 512kB chunks took 698398 us (5 MB/s), compress ratio: 3.54 [ 459.740620] lustre_kcompr_23075: compr deflate(6) in 1024kB chunks took 945784 us (4 MB/s), compress ratio: 3.54 [ 460.562801] lustre_kcompr_23075: compr deflate(6) in 2048kB chunks took 815299 us (4 MB/s), compress ratio: 3.54 [ 461.413298] lustre_kcompr_23075: compr deflate(6) in 4096kB chunks took 837410 us (4 MB/s), compress ratio: 3.54 [ 461.534563] lustre_kcompr_23075: decompr deflate(6) took 91990 us (12 MB/s) [ 461.545356] lustre_kcompr_23075: test_comp_compress_decompress(deflate,6) ret 0 [ 461.605807] lustre_kcompr_23075: acompr deflate(6) of 128kB chunks took 45118 us (2 MB/s), compress ratio: 3.09 [ 461.612860] lustre_kcompr_23075: adecompr deflate(6) took 1374 us (29 MB/s) [ 461.647205] lustre_kcompr_23075: test_acomp_compress_decompress(deflate,6) ret 0 [ 462.288711] lustre_kcompr_23075: compr deflate(9) in 64kB chunks took 596777 us (6 MB/s), compress ratio: 3.51 [ 462.968345] lustre_kcompr_23075: compr deflate(9) in 128kB chunks took 671818 us (5 MB/s), compress ratio: 3.53 [ 463.566545] lustre_kcompr_23075: compr deflate(9) in 256kB chunks took 591190 us (6 MB/s), compress ratio: 3.53 [ 464.391553] lustre_kcompr_23075: compr deflate(9) in 512kB chunks took 819172 us (4 MB/s), compress ratio: 3.54 [ 465.320158] lustre_kcompr_23075: compr deflate(9) in 1024kB chunks took 920332 us (4 MB/s), compress ratio: 3.54 [ 466.245200] lustre_kcompr_23075: compr deflate(9) in 2048kB chunks took 915740 us (4 MB/s), compress ratio: 3.54 [ 467.239105] lustre_kcompr_23075: compr deflate(9) in 4096kB chunks took 983783 us (4 MB/s), compress ratio: 3.54 [ 467.355773] lustre_kcompr_23075: decompr deflate(9) took 85299 us (13 MB/s) [ 467.372562] lustre_kcompr_23075: test_comp_compress_decompress(deflate,9) ret 0 [ 467.428504] lustre_kcompr_23075: acompr deflate(9) of 128kB chunks took 46052 us (2 MB/s), compress ratio: 3.09 [ 467.445667] lustre_kcompr_23075: adecompr deflate(9) took 3913 us (10 MB/s) [ 467.500591] lustre_kcompr_23075: test_acomp_compress_decompress(deflate,9) ret 0 [ 467.604874] lustre_kcompr_23075: compr zstd(0) in 64kB chunks took 82199 us (48 MB/s), compress ratio: 4.28 [ 467.774717] lustre_kcompr_23075: compr zstd(0) in 128kB chunks took 163094 us (24 MB/s), compress ratio: 4.46 [ 468.017240] lustre_kcompr_23075: compr zstd(0) in 256kB chunks took 231803 us (17 MB/s), compress ratio: 4.61 [ 468.330888] lustre_kcompr_23075: compr zstd(0) in 512kB chunks took 295341 us (13 MB/s), compress ratio: 4.72 [ 468.620530] lustre_kcompr_23075: compr zstd(0) in 1024kB chunks took 267403 us (14 MB/s), compress ratio: 4.80 [ 468.911889] lustre_kcompr_23075: compr zstd(0) in 2048kB chunks took 282541 us (14 MB/s), compress ratio: 4.85 [ 469.347215] lustre_kcompr_23075: compr zstd(0) in 4096kB chunks took 423860 us (9 MB/s), compress ratio: 4.88 [ 469.503866] lustre_kcompr_23075: decompr zstd(0) took 122054 us (6 MB/s) [ 469.516219] lustre_kcompr_23075: test_comp_compress_decompress(zstd,0) ret 0 [ 469.535471] lustre_kcompr_23075: acompr zstd(0) of 128kB chunks took 6136 us (20 MB/s), compress ratio: 3.98 [ 469.547270] lustre_kcompr_23075: adecompr zstd(0) took 1887 us (16 MB/s) [ 469.568267] lustre_kcompr_23075: test_acomp_compress_decompress(zstd,0) ret 0 [ 469.744527] lustre_kcompr_23075: compr zstd(1) in 64kB chunks took 138707 us (28 MB/s), compress ratio: 4.06 [ 469.860651] lustre_kcompr_23075: compr zstd(1) in 128kB chunks took 107138 us (37 MB/s), compress ratio: 4.20 [ 469.956312] lustre_kcompr_23075: compr zstd(1) in 256kB chunks took 89173 us (44 MB/s), compress ratio: 4.34 [ 470.084545] lustre_kcompr_23075: compr zstd(1) in 512kB chunks took 110988 us (36 MB/s), compress ratio: 4.34 [ 470.185898] lustre_kcompr_23075: compr zstd(1) in 1024kB chunks took 94198 us (42 MB/s), compress ratio: 4.37 [ 470.384621] lustre_kcompr_23075: compr zstd(1) in 2048kB chunks took 178270 us (22 MB/s), compress ratio: 4.39 [ 470.550178] lustre_kcompr_23075: compr zstd(1) in 4096kB chunks took 151392 us (26 MB/s), compress ratio: 4.40 [ 470.613504] lustre_kcompr_23075: decompr zstd(1) took 36523 us (24 MB/s) [ 470.628239] lustre_kcompr_23075: test_comp_compress_decompress(zstd,1) ret 0 [ 470.644402] lustre_kcompr_23075: acompr zstd(1) of 128kB chunks took 4280 us (29 MB/s), compress ratio: 3.73 [ 470.655737] lustre_kcompr_23075: adecompr zstd(1) took 934 us (35 MB/s) [ 470.676880] lustre_kcompr_23075: test_acomp_compress_decompress(zstd,1) ret 0 [ 473.104528] lustre_kcompr_23075: compr zstd(10) in 64kB chunks took 2386728 us (1 MB/s), compress ratio: 4.80 [ 475.289559] lustre_kcompr_23075: compr zstd(10) in 128kB chunks took 2166228 us (1 MB/s), compress ratio: 5.09 [ 477.852862] lustre_kcompr_23075: compr zstd(10) in 256kB chunks took 2556920 us (1 MB/s), compress ratio: 5.34 [ 478.987996] lustre_kcompr_23075: compr zstd(10) in 512kB chunks took 1122298 us (3 MB/s), compress ratio: 5.45 [ 480.553693] lustre_kcompr_23075: compr zstd(10) in 1024kB chunks took 1554304 us (2 MB/s), compress ratio: 5.62 [ 482.610780] lustre_kcompr_23075: compr zstd(10) in 2048kB chunks took 2049085 us (1 MB/s), compress ratio: 5.76 [ 484.568251] lustre_kcompr_23075: compr zstd(10) in 4096kB chunks took 1949301 us (2 MB/s), compress ratio: 5.89 [ 484.604225] lustre_kcompr_23075: decompr zstd(10) took 24967 us (27 MB/s) [ 484.608750] lustre_kcompr_23075: test_comp_compress_decompress(zstd,10) ret 0 [ 484.642343] lustre_kcompr_23075: acompr zstd(10) of 128kB chunks took 29708 us (4 MB/s), compress ratio: 4.46 [ 484.647395] lustre_kcompr_23075: adecompr zstd(10) took 774 us (36 MB/s) [ 484.653724] lustre_kcompr_23075: test_acomp_compress_decompress(zstd,10) ret 0 [ 502.223471] lustre_kcompr_23075: compr zstd(15) in 64kB chunks took 17558695 us (0 MB/s), compress ratio: 4.96 [ 518.443051] lustre_kcompr_23075: compr zstd(15) in 128kB chunks took 16210123 us (0 MB/s), compress ratio: 5.28 [ 532.473779] lustre_kcompr_23075: compr zstd(15) in 256kB chunks took 14026373 us (0 MB/s), compress ratio: 5.57 [ 547.443726] lustre_kcompr_23075: compr zstd(15) in 512kB chunks took 14964168 us (0 MB/s), compress ratio: 5.83 [ 559.246628] lustre_kcompr_23075: compr zstd(15) in 1024kB chunks took 11798379 us (0 MB/s), compress ratio: 6.06 [ 574.069677] lustre_kcompr_23075: compr zstd(15) in 2048kB chunks took 14815506 us (0 MB/s), compress ratio: 6.26 [ 585.669507] lustre_kcompr_23075: compr zstd(15) in 4096kB chunks took 11595852 us (0 MB/s), compress ratio: 6.46 [ 585.820919] lustre_kcompr_23075: decompr zstd(15) took 117272 us (5 MB/s) [ 585.843510] lustre_kcompr_23075: test_comp_compress_decompress(zstd,15) ret 0 [ 586.412719] lustre_kcompr_23075: acompr zstd(15) of 128kB chunks took 555378 us (0 MB/s), compress ratio: 4.64 [ 586.425475] lustre_kcompr_23075: adecompr zstd(15) took 652 us (41 MB/s) [ 586.438680] lustre_kcompr_23075: test_acomp_compress_decompress(zstd,15) ret 0 [ 586.552140] lustre_kcompr_23075: compr zstdfast(1) in 64kB chunks took 87765 us (45 MB/s), compress ratio: 3.49 [ 586.622871] lustre_kcompr_23075: compr zstdfast(1) in 128kB chunks took 64884 us (61 MB/s), compress ratio: 3.62 [ 586.736792] lustre_kcompr_23075: compr zstdfast(1) in 256kB chunks took 107451 us (37 MB/s), compress ratio: 3.84 [ 586.844963] lustre_kcompr_23075: compr zstdfast(1) in 512kB chunks took 95212 us (42 MB/s), compress ratio: 3.73 [ 586.981484] lustre_kcompr_23075: compr zstdfast(1) in 1024kB chunks took 115434 us (34 MB/s), compress ratio: 3.76 [ 587.105347] lustre_kcompr_23075: compr zstdfast(1) in 2048kB chunks took 116435 us (34 MB/s), compress ratio: 3.77 [ 587.228523] lustre_kcompr_23075: compr zstdfast(1) in 4096kB chunks took 112806 us (35 MB/s), compress ratio: 3.78 [ 587.314258] lustre_kcompr_23075: decompr zstdfast(1) took 49617 us (21 MB/s) [ 587.333590] lustre_kcompr_23075: test_comp_compress_decompress(zstdfast,1) ret 0 [ 587.351936] lustre_kcompr_23075: acompr zstdfast(1) of 128kB chunks took 2659 us (47 MB/s), compress ratio: 3.19 [ 587.362683] lustre_kcompr_23075: adecompr zstdfast(1) took 751 us (52 MB/s) [ 587.379119] lustre_kcompr_23075: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 587.478695] lustre_kcompr_23075: compr zstdfast(5) in 64kB chunks took 73679 us (54 MB/s), compress ratio: 2.81 [ 587.538277] lustre_kcompr_23075: compr zstdfast(5) in 128kB chunks took 53295 us (75 MB/s), compress ratio: 2.93 [ 587.671478] lustre_kcompr_23075: compr zstdfast(5) in 256kB chunks took 129526 us (30 MB/s), compress ratio: 3.16 [ 587.766343] lustre_kcompr_23075: compr zstdfast(5) in 512kB chunks took 84372 us (47 MB/s), compress ratio: 3.04 [ 587.848128] lustre_kcompr_23075: compr zstdfast(5) in 1024kB chunks took 73257 us (54 MB/s), compress ratio: 3.07 [ 587.999744] lustre_kcompr_23075: compr zstdfast(5) in 2048kB chunks took 136457 us (29 MB/s), compress ratio: 3.08 [ 588.045291] lustre_kcompr_23075: compr zstdfast(5) in 4096kB chunks took 32197 us (124 MB/s), compress ratio: 3.09 [ 588.106086] lustre_kcompr_23075: decompr zstdfast(5) took 40795 us (31 MB/s) [ 588.127203] lustre_kcompr_23075: test_comp_compress_decompress(zstdfast,5) ret 0 [ 588.146318] lustre_kcompr_23075: acompr zstdfast(5) of 128kB chunks took 4003 us (31 MB/s), compress ratio: 2.56 [ 588.157983] lustre_kcompr_23075: adecompr zstdfast(5) took 339 us (143 MB/s) [ 588.184383] lustre_kcompr_23075: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 588.226468] lustre_kcompr_23075: compr zstdfast(12) in 64kB chunks took 16644 us (240 MB/s), compress ratio: 1.43 [ 588.248234] lustre_kcompr_23075: compr zstdfast(12) in 128kB chunks took 17929 us (223 MB/s), compress ratio: 1.50 [ 588.268200] lustre_kcompr_23075: compr zstdfast(12) in 256kB chunks took 14936 us (267 MB/s), compress ratio: 1.62 [ 588.283935] lustre_kcompr_23075: compr zstdfast(12) in 512kB chunks took 13291 us (300 MB/s), compress ratio: 1.55 [ 588.304414] lustre_kcompr_23075: compr zstdfast(12) in 1024kB chunks took 15891 us (251 MB/s), compress ratio: 1.58 [ 588.332501] lustre_kcompr_23075: compr zstdfast(12) in 2048kB chunks took 23022 us (173 MB/s), compress ratio: 1.60 [ 588.358987] lustre_kcompr_23075: compr zstdfast(12) in 4096kB chunks took 23091 us (173 MB/s), compress ratio: 1.60 [ 588.377626] lustre_kcompr_23075: decompr zstdfast(12) took 9911 us (251 MB/s) [ 588.382357] lustre_kcompr_23075: test_comp_compress_decompress(zstdfast,12) ret 0 [ 588.388106] lustre_kcompr_23075: acompr zstdfast(12) of 128kB chunks took 661 us (189 MB/s), compress ratio: 1.37 [ 588.392050] lustre_kcompr_23075: adecompr zstdfast(12) took 294 us (310 MB/s) [ 588.395973] lustre_kcompr_23075: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 588.417634] lustre_kcompr_23075: compr zstdfast(15) in 64kB chunks took 12836 us (311 MB/s), compress ratio: 1.12 [ 588.433699] lustre_kcompr_23075: compr zstdfast(15) in 128kB chunks took 11909 us (335 MB/s), compress ratio: 1.16 [ 588.456725] lustre_kcompr_23075: compr zstdfast(15) in 256kB chunks took 18745 us (213 MB/s), compress ratio: 1.22 [ 588.477449] lustre_kcompr_23075: compr zstdfast(15) in 512kB chunks took 15904 us (251 MB/s), compress ratio: 1.20 [ 588.506123] lustre_kcompr_23075: compr zstdfast(15) in 1024kB chunks took 22566 us (177 MB/s), compress ratio: 1.22 [ 588.533140] lustre_kcompr_23075: compr zstdfast(15) in 2048kB chunks took 21474 us (186 MB/s), compress ratio: 1.23 [ 588.567676] lustre_kcompr_23075: compr zstdfast(15) in 4096kB chunks took 29240 us (136 MB/s), compress ratio: 1.23 [ 588.599793] lustre_kcompr_23075: decompr zstdfast(15) took 9474 us (341 MB/s) [ 588.615660] lustre_kcompr_23075: test_comp_compress_decompress(zstdfast,15) ret 0 [ 588.623908] lustre_kcompr_23075: acompr zstdfast(15) of 128kB chunks took 1103 us (113 MB/s), compress ratio: 1.08 [ 588.628732] lustre_kcompr_23075: adecompr zstdfast(15) took 203 us (568 MB/s) [ 588.652137] lustre_kcompr_23075: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 588.659477] lustre_kcompr_23075: SUCCESS [ 595.266104] lustre_kcompr_22039: ***** [ 595.275494] lustre_kcompr_22039: (de)compression test on provided file /tmp/f84.sanity [ 595.290103] lustre_kcompr_22039: ***** [ 595.349694] lustre_kcompr_22039: compr lz4(1) in 64kB chunks took 35993 us (111 MB/s), compress ratio: 2.45 [ 595.407941] lustre_kcompr_22039: compr lz4(1) in 128kB chunks took 47032 us (85 MB/s), compress ratio: 2.39 [ 595.510226] lustre_kcompr_22039: compr lz4(1) in 256kB chunks took 88281 us (45 MB/s), compress ratio: 2.39 [ 595.557667] lustre_kcompr_22039: compr lz4(1) in 512kB chunks took 26843 us (149 MB/s), compress ratio: 2.39 [ 595.607633] lustre_kcompr_22039: compr lz4(1) in 1024kB chunks took 27942 us (143 MB/s), compress ratio: 2.39 [ 595.682980] lustre_kcompr_22039: compr lz4(1) in 2048kB chunks took 56915 us (70 MB/s), compress ratio: 2.39 [ 595.745093] lustre_kcompr_22039: compr lz4(1) in 4096kB chunks took 42873 us (93 MB/s), compress ratio: 2.39 [ 595.792731] lustre_kcompr_22039: decompr lz4(1) took 15851 us (105 MB/s) [ 595.800786] lustre_kcompr_22039: test_comp_compress_decompress(lz4,1) ret 0 [ 595.808048] lustre_kcompr_22039: acompr lz4(1) of 128kB chunks took 170 us (735 MB/s), compress ratio: 15.67 [ 595.819727] lustre_kcompr_22039: adecompr lz4(1) took 202 us (39 MB/s) [ 595.831567] lustre_kcompr_22039: test_acomp_compress_decompress(lz4,1) ret 0 [ 595.883975] lustre_kcompr_22039: compr lz4(4) in 64kB chunks took 20074 us (199 MB/s), compress ratio: 2.36 [ 595.919860] lustre_kcompr_22039: compr lz4(4) in 128kB chunks took 29949 us (133 MB/s), compress ratio: 2.35 [ 595.978663] lustre_kcompr_22039: compr lz4(4) in 256kB chunks took 44696 us (89 MB/s), compress ratio: 2.35 [ 596.040576] lustre_kcompr_22039: compr lz4(4) in 512kB chunks took 41498 us (96 MB/s), compress ratio: 2.35 [ 596.099101] lustre_kcompr_22039: compr lz4(4) in 1024kB chunks took 52711 us (75 MB/s), compress ratio: 2.35 [ 596.161424] lustre_kcompr_22039: compr lz4(4) in 2048kB chunks took 32780 us (122 MB/s), compress ratio: 2.35 [ 596.233980] lustre_kcompr_22039: compr lz4(4) in 4096kB chunks took 44450 us (89 MB/s), compress ratio: 2.35 [ 596.271488] lustre_kcompr_22039: decompr lz4(4) took 12628 us (134 MB/s) [ 596.292932] lustre_kcompr_22039: test_comp_compress_decompress(lz4,4) ret 0 [ 596.331153] lustre_kcompr_22039: acompr lz4(4) of 128kB chunks took 124 us (1008 MB/s), compress ratio: 15.30 [ 596.345878] lustre_kcompr_22039: adecompr lz4(4) took 198 us (41 MB/s) [ 596.400499] lustre_kcompr_22039: test_acomp_compress_decompress(lz4,4) ret 0 [ 596.457539] lustre_kcompr_22039: compr lz4(9) in 64kB chunks took 18163 us (220 MB/s), compress ratio: 2.32 [ 596.506930] lustre_kcompr_22039: compr lz4(9) in 128kB chunks took 23402 us (170 MB/s), compress ratio: 2.31 [ 596.549368] lustre_kcompr_22039: compr lz4(9) in 256kB chunks took 34313 us (116 MB/s), compress ratio: 2.31 [ 596.585688] lustre_kcompr_22039: compr lz4(9) in 512kB chunks took 25231 us (158 MB/s), compress ratio: 2.31 [ 596.611100] lustre_kcompr_22039: compr lz4(9) in 1024kB chunks took 19662 us (203 MB/s), compress ratio: 2.31 [ 596.636144] lustre_kcompr_22039: compr lz4(9) in 2048kB chunks took 16745 us (238 MB/s), compress ratio: 2.32 [ 596.654562] lustre_kcompr_22039: compr lz4(9) in 4096kB chunks took 11647 us (343 MB/s), compress ratio: 2.32 [ 596.684493] lustre_kcompr_22039: decompr lz4(9) took 9700 us (177 MB/s) [ 596.691506] lustre_kcompr_22039: test_comp_compress_decompress(lz4,9) ret 0 [ 596.701133] lustre_kcompr_22039: acompr lz4(9) of 128kB chunks took 398 us (314 MB/s), compress ratio: 14.81 [ 596.712135] lustre_kcompr_22039: adecompr lz4(9) took 249 us (33 MB/s) [ 596.722906] lustre_kcompr_22039: test_acomp_compress_decompress(lz4,9) ret 0 [ 596.763770] lustre_kcompr_22039: compr lz4(15) in 64kB chunks took 8836 us (452 MB/s), compress ratio: 2.23 [ 596.789242] lustre_kcompr_22039: compr lz4(15) in 128kB chunks took 14192 us (281 MB/s), compress ratio: 2.23 [ 596.835883] lustre_kcompr_22039: compr lz4(15) in 256kB chunks took 23249 us (172 MB/s), compress ratio: 2.23 [ 596.860915] lustre_kcompr_22039: compr lz4(15) in 512kB chunks took 13391 us (298 MB/s), compress ratio: 2.23 [ 596.884620] lustre_kcompr_22039: compr lz4(15) in 1024kB chunks took 14897 us (268 MB/s), compress ratio: 2.23 [ 596.911506] lustre_kcompr_22039: compr lz4(15) in 2048kB chunks took 20172 us (198 MB/s), compress ratio: 2.23 [ 596.931138] lustre_kcompr_22039: compr lz4(15) in 4096kB chunks took 12724 us (314 MB/s), compress ratio: 2.23 [ 596.964267] lustre_kcompr_22039: decompr lz4(15) took 6746 us (265 MB/s) [ 596.980957] lustre_kcompr_22039: test_comp_compress_decompress(lz4,15) ret 0 [ 596.988156] lustre_kcompr_22039: acompr lz4(15) of 128kB chunks took 121 us (1033 MB/s), compress ratio: 14.18 [ 596.998223] lustre_kcompr_22039: adecompr lz4(15) took 111 us (79 MB/s) [ 597.041630] lustre_kcompr_22039: test_acomp_compress_decompress(lz4,15) ret 0 [ 597.563772] lustre_kcompr_22039: compr lz4hc(1) in 64kB chunks took 478349 us (8 MB/s), compress ratio: 2.54 [ 597.819503] lustre_kcompr_22039: compr lz4hc(1) in 128kB chunks took 245616 us (16 MB/s), compress ratio: 2.61 [ 598.232046] lustre_kcompr_22039: compr lz4hc(1) in 256kB chunks took 406545 us (9 MB/s), compress ratio: 2.64 [ 598.566573] lustre_kcompr_22039: compr lz4hc(1) in 512kB chunks took 310286 us (12 MB/s), compress ratio: 2.66 [ 598.877656] lustre_kcompr_22039: compr lz4hc(1) in 1024kB chunks took 305207 us (13 MB/s), compress ratio: 2.67 [ 599.054314] lustre_kcompr_22039: compr lz4hc(1) in 2048kB chunks took 172607 us (23 MB/s), compress ratio: 2.67 [ 599.304182] lustre_kcompr_22039: compr lz4hc(1) in 4096kB chunks took 244470 us (16 MB/s), compress ratio: 2.67 [ 599.366190] lustre_kcompr_22039: decompr lz4hc(1) took 22672 us (65 MB/s) [ 599.381411] lustre_kcompr_22039: test_comp_compress_decompress(lz4hc,1) ret 0 [ 599.393342] lustre_kcompr_22039: acompr lz4hc(1) of 128kB chunks took 1190 us (105 MB/s), compress ratio: 15.97 [ 599.405292] lustre_kcompr_22039: adecompr lz4hc(1) took 126 us (62 MB/s) [ 599.415977] lustre_kcompr_22039: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 600.047529] lustre_kcompr_22039: compr lz4hc(3) in 64kB chunks took 597067 us (6 MB/s), compress ratio: 2.57 [ 600.482827] lustre_kcompr_22039: compr lz4hc(3) in 128kB chunks took 420588 us (9 MB/s), compress ratio: 2.64 [ 600.712427] lustre_kcompr_22039: compr lz4hc(3) in 256kB chunks took 217897 us (18 MB/s), compress ratio: 2.68 [ 600.890591] lustre_kcompr_22039: compr lz4hc(3) in 512kB chunks took 173757 us (23 MB/s), compress ratio: 2.69 [ 601.175082] lustre_kcompr_22039: compr lz4hc(3) in 1024kB chunks took 275110 us (14 MB/s), compress ratio: 2.70 [ 601.366470] lustre_kcompr_22039: compr lz4hc(3) in 2048kB chunks took 186975 us (21 MB/s), compress ratio: 2.71 [ 602.547141] lustre_kcompr_22039: compr lz4hc(3) in 4096kB chunks took 1163652 us (3 MB/s), compress ratio: 2.71 [ 602.626261] lustre_kcompr_22039: decompr lz4hc(3) took 36475 us (40 MB/s) [ 602.637093] lustre_kcompr_22039: test_comp_compress_decompress(lz4hc,3) ret 0 [ 602.648872] lustre_kcompr_22039: acompr lz4hc(3) of 128kB chunks took 1431 us (87 MB/s), compress ratio: 16.00 [ 602.664862] lustre_kcompr_22039: adecompr lz4hc(3) took 148 us (52 MB/s) [ 602.797593] lustre_kcompr_22039: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 604.190746] lustre_kcompr_22039: compr lz4hc(8) in 64kB chunks took 1337567 us (2 MB/s), compress ratio: 2.60 [ 605.738124] lustre_kcompr_22039: compr lz4hc(8) in 128kB chunks took 1537194 us (2 MB/s), compress ratio: 2.66 [ 607.592376] lustre_kcompr_22039: compr lz4hc(8) in 256kB chunks took 1821654 us (2 MB/s), compress ratio: 2.70 [ 609.017590] lustre_kcompr_22039: compr lz4hc(8) in 512kB chunks took 1410219 us (2 MB/s), compress ratio: 2.71 [ 610.253814] lustre_kcompr_22039: compr lz4hc(8) in 1024kB chunks took 1198626 us (3 MB/s), compress ratio: 2.72 [ 611.499529] lustre_kcompr_22039: compr lz4hc(8) in 2048kB chunks took 1227125 us (3 MB/s), compress ratio: 2.73 [ 612.778964] lustre_kcompr_22039: compr lz4hc(8) in 4096kB chunks took 1267915 us (3 MB/s), compress ratio: 2.73 [ 612.824314] lustre_kcompr_22039: decompr lz4hc(8) took 9655 us (151 MB/s) [ 612.835517] lustre_kcompr_22039: test_comp_compress_decompress(lz4hc,8) ret 0 [ 612.875257] lustre_kcompr_22039: acompr lz4hc(8) of 128kB chunks took 23343 us (5 MB/s), compress ratio: 16.17 [ 612.882096] lustre_kcompr_22039: adecompr lz4hc(8) took 101 us (76 MB/s) [ 612.904133] lustre_kcompr_22039: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 619.019887] lustre_kcompr_22039: compr lz4hc(15) in 64kB chunks took 6094586 us (0 MB/s), compress ratio: 2.61 [ 630.446488] lustre_kcompr_22039: compr lz4hc(15) in 128kB chunks took 11420671 us (0 MB/s), compress ratio: 2.67 [ 642.039496] lustre_kcompr_22039: compr lz4hc(15) in 256kB chunks took 11584772 us (0 MB/s), compress ratio: 2.71 [ 656.524822] lustre_kcompr_22039: compr lz4hc(15) in 512kB chunks took 14473532 us (0 MB/s), compress ratio: 2.72 [ 670.033875] lustre_kcompr_22039: compr lz4hc(15) in 1024kB chunks took 13496364 us (0 MB/s), compress ratio: 2.73 [ 685.644918] lustre_kcompr_22039: compr lz4hc(15) in 2048kB chunks took 15606795 us (0 MB/s), compress ratio: 2.74 [ 699.793070] lustre_kcompr_22039: compr lz4hc(15) in 4096kB chunks took 14144212 us (0 MB/s), compress ratio: 2.74 [ 699.833262] lustre_kcompr_22039: decompr lz4hc(15) took 10443 us (139 MB/s) [ 699.846578] lustre_kcompr_22039: test_comp_compress_decompress(lz4hc,15) ret 0 [ 699.885369] lustre_kcompr_22039: acompr lz4hc(15) of 128kB chunks took 33097 us (3 MB/s), compress ratio: 16.30 [ 699.891696] lustre_kcompr_22039: adecompr lz4hc(15) took 142 us (53 MB/s) [ 699.900388] lustre_kcompr_22039: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 699.930683] lustre_kcompr_22039: compr lzo(-1) in 64kB chunks took 25891 us (154 MB/s), compress ratio: 2.35 [ 699.983482] lustre_kcompr_22039: compr lzo(-1) in 128kB chunks took 42801 us (93 MB/s), compress ratio: 2.35 [ 700.050196] lustre_kcompr_22039: compr lzo(-1) in 256kB chunks took 53591 us (74 MB/s), compress ratio: 2.35 [ 700.111963] lustre_kcompr_22039: compr lzo(-1) in 512kB chunks took 42621 us (93 MB/s), compress ratio: 2.36 [ 700.169720] lustre_kcompr_22039: compr lzo(-1) in 1024kB chunks took 36680 us (109 MB/s), compress ratio: 2.36 [ 700.236263] lustre_kcompr_22039: compr lzo(-1) in 2048kB chunks took 48723 us (82 MB/s), compress ratio: 2.36 [ 700.278573] lustre_kcompr_22039: compr lzo(-1) in 4096kB chunks took 29514 us (135 MB/s), compress ratio: 2.36 [ 700.315363] lustre_kcompr_22039: decompr lzo(-1) took 14152 us (119 MB/s) [ 700.320657] lustre_kcompr_22039: test_comp_compress_decompress(lzo,-1) ret 0 [ 700.330376] lustre_kcompr_22039: acompr lzo(-1) of 128kB chunks took 291 us (429 MB/s), compress ratio: 15.45 [ 700.338363] lustre_kcompr_22039: adecompr lzo(-1) took 450 us (17 MB/s) [ 700.352189] lustre_kcompr_22039: test_acomp_compress_decompress(lzo,-1) ret 0 [ 701.389081] lustre_kcompr_22039: compr deflate(1) in 64kB chunks took 1009838 us (3 MB/s), compress ratio: 3.27 [ 702.559531] lustre_kcompr_22039: compr deflate(1) in 128kB chunks took 1156401 us (3 MB/s), compress ratio: 3.28 [ 703.895810] lustre_kcompr_22039: compr deflate(1) in 256kB chunks took 1327967 us (3 MB/s), compress ratio: 3.28 [ 705.404975] lustre_kcompr_22039: compr deflate(1) in 512kB chunks took 1497782 us (2 MB/s), compress ratio: 3.28 [ 706.428396] lustre_kcompr_22039: compr deflate(1) in 1024kB chunks took 1001190 us (3 MB/s), compress ratio: 3.28 [ 707.414490] lustre_kcompr_22039: compr deflate(1) in 2048kB chunks took 966383 us (4 MB/s), compress ratio: 3.28 [ 708.559365] lustre_kcompr_22039: compr deflate(1) in 4096kB chunks took 1124576 us (3 MB/s), compress ratio: 3.28 [ 708.657493] lustre_kcompr_22039: decompr deflate(1) took 72185 us (16 MB/s) [ 708.677281] lustre_kcompr_22039: test_comp_compress_decompress(deflate,1) ret 0 [ 708.710235] lustre_kcompr_22039: acompr deflate(1) of 128kB chunks took 24899 us (5 MB/s), compress ratio: 21.43 [ 708.727483] lustre_kcompr_22039: adecompr deflate(1) took 278 us (20 MB/s) [ 708.804777] lustre_kcompr_22039: test_acomp_compress_decompress(deflate,1) ret 0 [ 709.587352] lustre_kcompr_22039: compr deflate(6) in 64kB chunks took 720676 us (5 MB/s), compress ratio: 3.27 [ 710.968879] lustre_kcompr_22039: compr deflate(6) in 128kB chunks took 1363183 us (2 MB/s), compress ratio: 3.28 [ 712.179434] lustre_kcompr_22039: compr deflate(6) in 256kB chunks took 1193195 us (3 MB/s), compress ratio: 3.28 [ 712.523564] lustre_kcompr_22039: compr deflate(6) in 512kB chunks took 335464 us (11 MB/s), compress ratio: 3.28 [ 713.056820] lustre_kcompr_22039: compr deflate(6) in 1024kB chunks took 528096 us (7 MB/s), compress ratio: 3.28 [ 713.481076] lustre_kcompr_22039: compr deflate(6) in 2048kB chunks took 411630 us (9 MB/s), compress ratio: 3.28 [ 714.288933] lustre_kcompr_22039: compr deflate(6) in 4096kB chunks took 802480 us (4 MB/s), compress ratio: 3.28 [ 714.468573] lustre_kcompr_22039: decompr deflate(6) took 122949 us (9 MB/s) [ 714.493817] lustre_kcompr_22039: test_comp_compress_decompress(deflate,6) ret 0 [ 714.549314] lustre_kcompr_22039: acompr deflate(6) of 128kB chunks took 37377 us (3 MB/s), compress ratio: 21.43 [ 714.565964] lustre_kcompr_22039: adecompr deflate(6) took 532 us (10 MB/s) [ 714.621433] lustre_kcompr_22039: test_acomp_compress_decompress(deflate,6) ret 0 [ 715.345780] lustre_kcompr_22039: compr deflate(9) in 64kB chunks took 705235 us (5 MB/s), compress ratio: 3.27 [ 716.385930] lustre_kcompr_22039: compr deflate(9) in 128kB chunks took 1029379 us (3 MB/s), compress ratio: 3.28 [ 717.479033] lustre_kcompr_22039: compr deflate(9) in 256kB chunks took 1082420 us (3 MB/s), compress ratio: 3.28 [ 718.720768] lustre_kcompr_22039: compr deflate(9) in 512kB chunks took 1234085 us (3 MB/s), compress ratio: 3.28 [ 720.211655] lustre_kcompr_22039: compr deflate(9) in 1024kB chunks took 1455089 us (2 MB/s), compress ratio: 3.28 [ 721.163765] lustre_kcompr_22039: compr deflate(9) in 2048kB chunks took 926579 us (4 MB/s), compress ratio: 3.28 [ 722.092529] lustre_kcompr_22039: compr deflate(9) in 4096kB chunks took 921189 us (4 MB/s), compress ratio: 3.28 [ 722.179713] lustre_kcompr_22039: decompr deflate(9) took 52887 us (23 MB/s) [ 722.200732] lustre_kcompr_22039: test_comp_compress_decompress(deflate,9) ret 0 [ 722.228145] lustre_kcompr_22039: acompr deflate(9) of 128kB chunks took 12620 us (9 MB/s), compress ratio: 21.43 [ 722.242412] lustre_kcompr_22039: adecompr deflate(9) took 2206 us (2 MB/s) [ 722.304437] lustre_kcompr_22039: test_acomp_compress_decompress(deflate,9) ret 0 [ 722.533362] lustre_kcompr_22039: compr zstd(0) in 64kB chunks took 191491 us (20 MB/s), compress ratio: 3.28 [ 722.733440] lustre_kcompr_22039: compr zstd(0) in 128kB chunks took 183375 us (21 MB/s), compress ratio: 3.26 [ 722.932692] lustre_kcompr_22039: compr zstd(0) in 256kB chunks took 183244 us (21 MB/s), compress ratio: 3.31 [ 723.272223] lustre_kcompr_22039: compr zstd(0) in 512kB chunks took 335941 us (11 MB/s), compress ratio: 3.32 [ 723.759720] lustre_kcompr_22039: compr zstd(0) in 1024kB chunks took 478234 us (8 MB/s), compress ratio: 3.32 [ 724.315129] lustre_kcompr_22039: compr zstd(0) in 2048kB chunks took 532243 us (7 MB/s), compress ratio: 3.33 [ 724.991577] lustre_kcompr_22039: compr zstd(0) in 4096kB chunks took 644440 us (6 MB/s), compress ratio: 3.33 [ 725.066436] lustre_kcompr_22039: decompr zstd(0) took 48321 us (24 MB/s) [ 725.077851] lustre_kcompr_22039: test_comp_compress_decompress(zstd,0) ret 0 [ 725.089741] lustre_kcompr_22039: acompr zstd(0) of 128kB chunks took 453 us (275 MB/s), compress ratio: 22.64 [ 725.102534] lustre_kcompr_22039: adecompr zstd(0) took 190 us (29 MB/s) [ 725.131772] lustre_kcompr_22039: test_acomp_compress_decompress(zstd,0) ret 0 [ 725.251716] lustre_kcompr_22039: compr zstd(1) in 64kB chunks took 77271 us (51 MB/s), compress ratio: 3.22 [ 725.367501] lustre_kcompr_22039: compr zstd(1) in 128kB chunks took 100924 us (39 MB/s), compress ratio: 3.18 [ 725.466496] lustre_kcompr_22039: compr zstd(1) in 256kB chunks took 90725 us (44 MB/s), compress ratio: 3.19 [ 725.587619] lustre_kcompr_22039: compr zstd(1) in 512kB chunks took 105904 us (37 MB/s), compress ratio: 3.19 [ 725.742872] lustre_kcompr_22039: compr zstd(1) in 1024kB chunks took 131551 us (30 MB/s), compress ratio: 3.19 [ 725.882421] lustre_kcompr_22039: compr zstd(1) in 2048kB chunks took 110189 us (36 MB/s), compress ratio: 3.19 [ 726.040560] lustre_kcompr_22039: compr zstd(1) in 4096kB chunks took 140501 us (28 MB/s), compress ratio: 3.19 [ 726.121867] lustre_kcompr_22039: decompr zstd(1) took 56189 us (22 MB/s) [ 726.133377] lustre_kcompr_22039: test_comp_compress_decompress(zstd,1) ret 0 [ 726.142855] lustre_kcompr_22039: acompr zstd(1) of 128kB chunks took 320 us (390 MB/s), compress ratio: 22.79 [ 726.165134] lustre_kcompr_22039: adecompr zstd(1) took 161 us (34 MB/s) [ 726.266766] lustre_kcompr_22039: test_acomp_compress_decompress(zstd,1) ret 0 [ 726.764101] lustre_kcompr_22039: compr zstd(10) in 64kB chunks took 458118 us (8 MB/s), compress ratio: 3.33 [ 727.308647] lustre_kcompr_22039: compr zstd(10) in 128kB chunks took 540548 us (7 MB/s), compress ratio: 3.33 [ 728.112514] lustre_kcompr_22039: compr zstd(10) in 256kB chunks took 786817 us (5 MB/s), compress ratio: 3.37 [ 728.564503] lustre_kcompr_22039: compr zstd(10) in 512kB chunks took 448396 us (8 MB/s), compress ratio: 3.40 [ 730.100045] lustre_kcompr_22039: compr zstd(10) in 1024kB chunks took 1529465 us (2 MB/s), compress ratio: 3.42 [ 731.990420] lustre_kcompr_22039: compr zstd(10) in 2048kB chunks took 1869719 us (2 MB/s), compress ratio: 3.46 [ 733.616566] lustre_kcompr_22039: compr zstd(10) in 4096kB chunks took 1618763 us (2 MB/s), compress ratio: 3.50 [ 733.683287] lustre_kcompr_22039: decompr zstd(10) took 44028 us (25 MB/s) [ 733.688568] lustre_kcompr_22039: test_comp_compress_decompress(zstd,10) ret 0 [ 733.695325] lustre_kcompr_22039: acompr zstd(10) of 128kB chunks took 2336 us (53 MB/s), compress ratio: 22.78 [ 733.704794] lustre_kcompr_22039: adecompr zstd(10) took 229 us (23 MB/s) [ 733.713578] lustre_kcompr_22039: test_acomp_compress_decompress(zstd,10) ret 0 [ 746.139354] lustre_kcompr_22039: compr zstd(15) in 64kB chunks took 12397653 us (0 MB/s), compress ratio: 3.36 [ 759.740617] lustre_kcompr_22039: compr zstd(15) in 128kB chunks took 13592784 us (0 MB/s), compress ratio: 3.39 [ 766.733440] lustre_kcompr_22039: compr zstd(15) in 256kB chunks took 6989300 us (0 MB/s), compress ratio: 3.40 [ 770.403747] lustre_kcompr_22039: compr zstd(15) in 512kB chunks took 3648782 us (1 MB/s), compress ratio: 3.42 [ 773.703357] lustre_kcompr_22039: compr zstd(15) in 1024kB chunks took 3277319 us (1 MB/s), compress ratio: 3.43 [ 780.728945] lustre_kcompr_22039: compr zstd(15) in 2048kB chunks took 7009885 us (0 MB/s), compress ratio: 3.48 [ 785.546705] lustre_kcompr_22039: compr zstd(15) in 4096kB chunks took 4806158 us (0 MB/s), compress ratio: 3.56 [ 785.606889] lustre_kcompr_22039: decompr zstd(15) took 45955 us (24 MB/s) [ 785.622477] lustre_kcompr_22039: test_comp_compress_decompress(zstd,15) ret 0 [ 785.683290] lustre_kcompr_22039: acompr zstd(15) of 128kB chunks took 50706 us (2 MB/s), compress ratio: 23.92 [ 785.687104] lustre_kcompr_22039: adecompr zstd(15) took 151 us (34 MB/s) [ 785.690839] lustre_kcompr_22039: test_acomp_compress_decompress(zstd,15) ret 0 [ 785.725672] lustre_kcompr_22039: compr zstdfast(1) in 64kB chunks took 22689 us (176 MB/s), compress ratio: 2.47 [ 785.745167] lustre_kcompr_22039: compr zstdfast(1) in 128kB chunks took 17048 us (234 MB/s), compress ratio: 2.48 [ 785.764061] lustre_kcompr_22039: compr zstdfast(1) in 256kB chunks took 15934 us (251 MB/s), compress ratio: 2.53 [ 785.781493] lustre_kcompr_22039: compr zstdfast(1) in 512kB chunks took 14756 us (271 MB/s), compress ratio: 2.42 [ 785.802894] lustre_kcompr_22039: compr zstdfast(1) in 1024kB chunks took 17726 us (225 MB/s), compress ratio: 2.42 [ 785.820218] lustre_kcompr_22039: compr zstdfast(1) in 2048kB chunks took 13536 us (295 MB/s), compress ratio: 2.42 [ 785.838524] lustre_kcompr_22039: compr zstdfast(1) in 4096kB chunks took 15653 us (255 MB/s), compress ratio: 2.42 [ 785.848749] lustre_kcompr_22039: decompr zstdfast(1) took 2945 us (560 MB/s) [ 785.851709] lustre_kcompr_22039: test_comp_compress_decompress(zstdfast,1) ret 0 [ 785.854599] lustre_kcompr_22039: acompr zstdfast(1) of 128kB chunks took 197 us (634 MB/s), compress ratio: 17.28 [ 785.857646] lustre_kcompr_22039: adecompr zstdfast(1) took 118 us (61 MB/s) [ 785.862904] lustre_kcompr_22039: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 785.881684] lustre_kcompr_22039: compr zstdfast(5) in 64kB chunks took 11132 us (359 MB/s), compress ratio: 2.38 [ 785.899470] lustre_kcompr_22039: compr zstdfast(5) in 128kB chunks took 13951 us (286 MB/s), compress ratio: 2.38 [ 785.917349] lustre_kcompr_22039: compr zstdfast(5) in 256kB chunks took 13303 us (300 MB/s), compress ratio: 2.40 [ 785.929641] lustre_kcompr_22039: compr zstdfast(5) in 512kB chunks took 9790 us (408 MB/s), compress ratio: 2.36 [ 785.942564] lustre_kcompr_22039: compr zstdfast(5) in 1024kB chunks took 9650 us (414 MB/s), compress ratio: 2.36 [ 785.953845] lustre_kcompr_22039: compr zstdfast(5) in 2048kB chunks took 8440 us (473 MB/s), compress ratio: 2.36 [ 785.967640] lustre_kcompr_22039: compr zstdfast(5) in 4096kB chunks took 10443 us (383 MB/s), compress ratio: 2.36 [ 785.980637] lustre_kcompr_22039: decompr zstdfast(5) took 3702 us (455 MB/s) [ 785.984597] lustre_kcompr_22039: test_comp_compress_decompress(zstdfast,5) ret 0 [ 785.987761] lustre_kcompr_22039: acompr zstdfast(5) of 128kB chunks took 154 us (811 MB/s), compress ratio: 16.12 [ 785.991191] lustre_kcompr_22039: adecompr zstdfast(5) took 186 us (41 MB/s) [ 785.999663] lustre_kcompr_22039: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 786.017402] lustre_kcompr_22039: compr zstdfast(12) in 64kB chunks took 7669 us (521 MB/s), compress ratio: 2.07 [ 786.028287] lustre_kcompr_22039: compr zstdfast(12) in 128kB chunks took 6108 us (654 MB/s), compress ratio: 2.07 [ 786.039894] lustre_kcompr_22039: compr zstdfast(12) in 256kB chunks took 7100 us (563 MB/s), compress ratio: 2.08 [ 786.051311] lustre_kcompr_22039: compr zstdfast(12) in 512kB chunks took 6876 us (581 MB/s), compress ratio: 2.07 [ 786.063186] lustre_kcompr_22039: compr zstdfast(12) in 1024kB chunks took 7502 us (533 MB/s), compress ratio: 2.07 [ 786.074654] lustre_kcompr_22039: compr zstdfast(12) in 2048kB chunks took 7325 us (546 MB/s), compress ratio: 2.07 [ 786.087641] lustre_kcompr_22039: compr zstdfast(12) in 4096kB chunks took 8253 us (484 MB/s), compress ratio: 2.08 [ 786.104329] lustre_kcompr_22039: decompr zstdfast(12) took 2788 us (689 MB/s) [ 786.114951] lustre_kcompr_22039: test_comp_compress_decompress(zstdfast,12) ret 0 [ 786.119734] lustre_kcompr_22039: acompr zstdfast(12) of 128kB chunks took 146 us (856 MB/s), compress ratio: 13.13 [ 786.124265] lustre_kcompr_22039: adecompr zstdfast(12) took 105 us (90 MB/s) [ 786.129861] lustre_kcompr_22039: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 786.146187] lustre_kcompr_22039: compr zstdfast(15) in 64kB chunks took 6152 us (650 MB/s), compress ratio: 1.82 [ 786.161685] lustre_kcompr_22039: compr zstdfast(15) in 128kB chunks took 10906 us (366 MB/s), compress ratio: 1.83 [ 786.169358] lustre_kcompr_22039: compr zstdfast(15) in 256kB chunks took 4264 us (938 MB/s), compress ratio: 1.83 [ 786.176409] lustre_kcompr_22039: compr zstdfast(15) in 512kB chunks took 3826 us (1045 MB/s), compress ratio: 1.83 [ 786.183390] lustre_kcompr_22039: compr zstdfast(15) in 1024kB chunks took 3933 us (1017 MB/s), compress ratio: 1.83 [ 786.190054] lustre_kcompr_22039: compr zstdfast(15) in 2048kB chunks took 3752 us (1066 MB/s), compress ratio: 1.83 [ 786.197458] lustre_kcompr_22039: compr zstdfast(15) in 4096kB chunks took 4396 us (909 MB/s), compress ratio: 1.84 [ 786.208046] lustre_kcompr_22039: decompr zstdfast(15) took 2475 us (877 MB/s) [ 786.211552] lustre_kcompr_22039: test_comp_compress_decompress(zstdfast,15) ret 0 [ 786.214810] lustre_kcompr_22039: acompr zstdfast(15) of 128kB chunks took 162 us (771 MB/s), compress ratio: 10.73 [ 786.218392] lustre_kcompr_22039: adecompr zstdfast(15) took 110 us (105 MB/s) [ 786.224235] lustre_kcompr_22039: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 786.227785] lustre_kcompr_22039: SUCCESS [ 812.490549] Lustre: DEBUG MARKER: == sanity test complete, duration 510 sec ================ 12:45:03 (1789058703) [ 815.447762] Lustre: DEBUG MARKER: === sanity: start cleanup 12:45:06 (1789058706) === [ 820.084829] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:45:11 (1789058711) === [ 822.482982] LustreError: 13401:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff9fa604564000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 822.542060] Lustre: Unmounted lustre-client [ 853.703189] Key type lgssc unregistered [ 854.032057] LNet: 13883:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 854.035818] LNetError: 13883:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 854.055564] LNet: Removed LNI 192.168.202.36@tcp [ 854.993259] Key type .llcrypt unregistered [ 854.995218] Key type ._llcrypt unregistered