[ 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 470653660 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.001010] APIC: Switch to symmetric I/O mode setup [ 0.002330] x2apic enabled [ 0.003008] Switched APIC routing to physical x2apic. [ 0.004011] kvm-guest: setup PV IPIs [ 0.006755] ..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.009133] LSM: Security Framework initializing [ 0.010048] Yama: becoming mindful. [ 0.011031] SELinux: Initializing. [ 0.012063] *** VALIDATE selinux *** [ 0.020703] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025472] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026137] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027109] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028105] *** VALIDATE tmpfs *** [ 0.030183] *** VALIDATE proc *** [ 0.031217] *** VALIDATE cgroup *** [ 0.032008] *** VALIDATE cgroup2 *** [ 0.033277] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.034137] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.035006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.036029] Spectre V2 : User space: Vulnerable [ 0.037009] Speculative Store Bypass: Vulnerable [ 0.040401] debug: unmapping init [mem 0xffffffffb3e59000-0xffffffffb3e60fff] [ 0.042236] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043672] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044021] ... version: 2 [ 0.045010] ... bit width: 48 [ 0.046011] ... generic registers: 4 [ 0.047010] ... value mask: 0000ffffffffffff [ 0.048011] ... max period: 00007fffffffffff [ 0.049012] ... fixed-purpose events: 3 [ 0.050009] ... event mask: 000000070000000f [ 0.051345] rcu: Hierarchical SRCU implementation. [ 0.053488] smp: Bringing up secondary CPUs ... [ 0.054492] x86: Booting SMP configuration: [ 0.055022] .... node #0, CPUs: #1 #2 #3 [ 0.066226] smp: Brought up 1 node, 4 CPUs [ 0.068014] smpboot: Max logical packages: 1 [ 0.069011] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.092000] node 0 deferred pages initialised in 21ms [ 0.095612] devtmpfs: initialized [ 0.096280] x86/mm: Memory block size: 128MB [ 0.098917] gcov: version magic: 0x41383552 [ 0.100235] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.101094] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.102347] pinctrl core: initialized pinctrl subsystem [ 0.103186] [ 0.103665] ************************************************************* [ 0.104013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.105012] ** ** [ 0.106016] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.107011] ** ** [ 0.108010] ** This means that this kernel is built to expose internal ** [ 0.109009] ** IOMMU data structures, which may compromise security on ** [ 0.110015] ** your system. ** [ 0.111015] ** ** [ 0.112015] ** If you see this message and you are not debugging the ** [ 0.113012] ** kernel, report this immediately to your vendor! ** [ 0.114019] ** ** [ 0.115077] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.116019] ************************************************************* [ 0.117825] NET: Registered protocol family 16 [ 0.118634] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.119058] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.120061] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.121878] cpuidle: using governor menu [ 0.122995] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.123489] PCI: Using configuration type 1 for base access [ 0.124133] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.132121] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.133015] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.136207] cryptd: max_cpu_qlen set to 1000 [ 0.138572] ACPI: Added _OSI(Module Device) [ 0.139000] ACPI: Added _OSI(Processor Device) [ 0.139000] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.141012] ACPI: Added _OSI(Processor Aggregator Device) [ 0.146558] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.152480] ACPI: Interpreter enabled [ 0.153059] ACPI: PM: (supports S0 S3 S4 S5) [ 0.154014] ACPI: Using IOAPIC for interrupt routing [ 0.155116] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.156410] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.166749] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.167040] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.168020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.169078] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.171436] acpiphp: Slot [2] registered [ 0.172111] acpiphp: Slot [5] registered [ 0.173129] acpiphp: Slot [6] registered [ 0.174117] acpiphp: Slot [3] registered [ 0.175191] acpiphp: Slot [4] registered [ 0.176113] acpiphp: Slot [7] registered [ 0.177109] acpiphp: Slot [8] registered [ 0.178290] acpiphp: Slot [9] registered [ 0.179118] acpiphp: Slot [10] registered [ 0.180137] acpiphp: Slot [11] registered [ 0.181139] acpiphp: Slot [12] registered [ 0.182107] acpiphp: Slot [13] registered [ 0.183111] acpiphp: Slot [14] registered [ 0.184305] acpiphp: Slot [15] registered [ 0.185088] acpiphp: Slot [16] registered [ 0.186101] acpiphp: Slot [17] registered [ 0.187095] acpiphp: Slot [18] registered [ 0.188303] acpiphp: Slot [19] registered [ 0.189129] acpiphp: Slot [20] registered [ 0.190231] acpiphp: Slot [21] registered [ 0.191098] acpiphp: Slot [22] registered [ 0.192221] acpiphp: Slot [23] registered [ 0.193124] acpiphp: Slot [24] registered [ 0.194154] acpiphp: Slot [25] registered [ 0.195260] acpiphp: Slot [26] registered [ 0.196123] acpiphp: Slot [27] registered [ 0.197100] acpiphp: Slot [28] registered [ 0.198118] acpiphp: Slot [29] registered [ 0.199120] acpiphp: Slot [30] registered [ 0.200161] acpiphp: Slot [31] registered [ 0.201147] PCI host bridge to bus 0000:00 [ 0.202025] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.203040] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.204032] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.205026] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.206025] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.207027] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.208307] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.210565] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.212300] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.219020] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.222436] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.223026] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.224023] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.225021] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.227083] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.228000] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.233046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.238729] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.243017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.261020] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.268000] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.277302] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.289019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.301016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.332018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.342734] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.350015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.358019] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.375017] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.395479] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.398680] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.402499] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.406805] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.410237] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.421061] iommu: Default domain type: Passthrough [ 0.424408] SCSI subsystem initialized [ 0.426128] ACPI: bus type USB registered [ 0.431161] usbcore: registered new interface driver usbfs [ 0.436120] usbcore: registered new interface driver hub [ 0.440097] usbcore: registered new device driver usb [ 0.442379] pps_core: LinuxPPS API ver. 1 registered [ 0.444010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.448084] PTP clock support registered [ 0.451045] EDAC MC: Ver: 3.0.0 [ 0.453126] PCI: Using ACPI for IRQ routing [ 0.455553] NetLabel: Initializing [ 0.456012] NetLabel: domain hash size = 128 [ 0.459016] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.462088] NetLabel: unlabeled traffic allowed by default [ 0.468039] vgaarb: loaded [ 0.470268] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.474015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.491279] clocksource: Switched to clocksource kvm-clock [ 0.754340] VFS: Disk quotas dquot_6.6.0 [ 0.759340] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.765195] *** VALIDATE ramfs *** [ 0.774958] *** VALIDATE hugetlbfs *** [ 0.778864] pnp: PnP ACPI init [ 0.785807] pnp: PnP ACPI: found 6 devices [ 0.872212] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.887726] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.889689] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.902276] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.912694] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.919737] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.927662] NET: Registered protocol family 2 [ 0.929761] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.943372] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.952796] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.969619] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.979366] TCP: Hash tables configured (established 65536 bind 65536) [ 0.999261] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 1.013603] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.024760] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.038623] NET: Registered protocol family 1 [ 1.044113] RPC: Registered named UNIX socket transport module. [ 1.046120] RPC: Registered udp transport module. [ 1.057348] RPC: Registered tcp transport module. [ 1.059484] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.070039] NET: Registered protocol family 44 [ 1.073585] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.080586] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.082190] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.094024] pci 0000:00:01.0: quirk_isa_dma_hangs+0x0/0x20 took 11552 usecs [ 1.099576] PCI: CLS 0 bytes, default 64 [ 1.106082] Unpacking initramfs... [ 5.522338] debug: unmapping init [mem 0xffff8896fcc64000-0xffff8896fffcffff] [ 5.541327] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 5.548340] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 5.560179] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 8.971865] Initialise system trusted keyrings [ 8.975442] Key type blacklist registered [ 8.981619] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 9.008354] zbud: loaded [ 9.016609] *** VALIDATE nfs *** [ 9.019356] *** VALIDATE nfs4 *** [ 9.022286] pstore: using deflate compression [ 9.032460] Platform Keyring initialized [ 9.354382] NET: Registered protocol family 38 [ 9.357267] Key type asymmetric registered [ 9.359485] Asymmetric key parser 'x509' registered [ 9.368226] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 9.374525] io scheduler mq-deadline registered [ 9.376257] io scheduler kyber registered [ 9.381534] io scheduler bfq registered [ 9.385416] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 9.396402] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 9.402652] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 9.409400] ACPI: Power Button [PWRF] [ 9.421503] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 9.438453] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 9.468435] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 9.511142] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 9.568289] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 9.595210] Non-volatile memory driver v1.3 [ 9.598158] Linux agpgart interface v0.103 [ 9.716194] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 9.728728] vda: detected capacity change from 0 to 73097216 [ 9.760148] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 9.767724] vdb: detected capacity change from 0 to 1073741824 [ 9.784315] libphy: Fixed MDIO Bus: probed [ 9.838875] usbcore: registered new interface driver usbserial_generic [ 9.845775] usbserial: USB Serial support registered for generic [ 9.850111] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 9.861792] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 9.864472] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 9.867774] mousedev: PS/2 mouse device common for all mice [ 9.873255] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 9.873298] rtc_cmos 00:05: RTC can wake from S4 [ 9.891204] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 9.895960] rtc_cmos 00:05: registered as rtc0 [ 9.907360] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 9.916466] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 9.927451] intel_pstate: CPU model not supported [ 9.936545] hid: raw HID events driver (C) Jiri Kosina [ 9.943595] usbcore: registered new interface driver usbhid [ 9.945562] usbhid: USB HID core driver [ 9.947105] drop_monitor: Initializing network drop monitor service [ 9.948979] Initializing XFRM netlink socket [ 9.950593] NET: Registered protocol family 10 [ 9.953610] Segment Routing with IPv6 [ 9.955440] NET: Registered protocol family 17 [ 9.958585] mpls_gso: MPLS GSO support [ 9.963778] RAS: Correctable Errors collector initialized. [ 9.965594] AVX version of gcm_enc/dec engaged. [ 9.966751] AES CTR mode by8 optimization enabled [ 10.187491] sched_clock: Marking stable (10187466096, 0)->(11199030211, -1011564115) [ 10.197550] registered taskstats version 1 [ 10.200852] Loading compiled-in X.509 certificates [ 10.204279] zswap: loaded using pool lzo/zbud [ 10.296689] Key type big_key registered [ 10.349331] Key type encrypted registered [ 10.355498] ima: No TPM chip found, activating TPM-bypass! [ 10.358452] ima: Allocated hash algorithm: sha1 [ 10.364119] ima: No architecture policies found [ 10.368989] evm: Initialising EVM extended attributes: [ 10.379278] evm: security.selinux [ 10.383600] evm: security.ima [ 10.391762] evm: security.capability [ 10.396527] evm: HMAC attrs: 0x1 [ 10.415443] rtc_cmos 00:05: setting system clock to 2026-09-10 16:49:08 UTC (1789058948) [ 10.429551] debug: unmapping init [mem 0xffffffffb4e03000-0xffffffffb4ffffff] [ 10.438236] debug: unmapping init [mem 0xffffffffb3b82000-0xffffffffb3e58fff] [ 10.452318] Write protecting the kernel read-only data: 28672k [ 10.457120] debug: unmapping init [mem 0xffffffffb2203000-0xffffffffb23fffff] [ 10.466583] debug: unmapping init [mem 0xffffffffb2b14000-0xffffffffb2bfffff] [ 10.607399] 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) [ 10.623499] systemd[1]: Detected virtualization kvm. [ 10.631729] systemd[1]: Detected architecture x86-64. [ 10.636218] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 10.689138] systemd[1]: No hostname configured. [ 10.697903] systemd[1]: Set hostname to . [ 10.708477] random: systemd: uninitialized urandom read (16 bytes read) [ 10.714520] systemd[1]: Initializing machine ID from random generator. [ 10.909258] random: ln: uninitialized urandom read (6 bytes read) [ 11.121335] random: systemd: uninitialized urandom read (16 bytes read) [ 11.126348] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 11.135325] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 11.143088] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Timers. [ OK ] Reached target Slices. [ OK ] Reached target Initrd Root Device. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. 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... [ 13.350644] device-mapper: uevent: version 1.0.3 [ 13.356229] 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.[ 15.961454] random: fast init done [ OK ] Reached target Basic System. [ 16.168068] virtio_net virtio0 ens2: renamed from eth0 [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 16.493970] scsi host0: ata_piix [ 16.646742] scsi host1: ata_piix [ 16.652590] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 16.662036] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 21.934706] random: crng init done [ 21.942182] random: 7 urandom warning(s) missed due to ratelimiting [ 23.445568] dracut-initqueue[585]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 24.856165] 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Timers. [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 27.858980] printk: systemd: 26 output lines suppressed due to ratelimiting [ 29.184120] SELinux: Disabled at runtime. [ 29.408305] 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) [ 29.431583] systemd[1]: Detected virtualization kvm. [ 29.438524] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 31.503316] systemd[1]: initrd-switch-root.service: Succeeded. [ 31.510921] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 31.548405] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 31.565119] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 31.578442] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 31.640719] systemd[1]: Starting Journal Service... Starting Journal Service... [ 31.668149] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target Slices. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... Mounting Kernel Debug File System... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Starting Remount Root and Kernel File Systems... Mounting Huge Pages File System... Mounting POSIX Message Queue File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target rpc_pipefs.target. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ 32.397357] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd Root File System. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ 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 udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 33.373389] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 35.146717] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 35.182026] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 35.850182] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 35.991863] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is r[ 40.420266] Key type dns_resolver registered unning for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 41.636820] NFS: Registering the id_resolver key type [ 41.644486] Key type id_resolver registered [ 41.648191] Key type id_legacy registered [ *** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ 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. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. [ OK ] Reached target sshd-keygen.target. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Started Login Service. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg231-client login: [ 78.428166] hrtimer: interrupt took 12032397 ns [ 120.311729] libcfs: loading out-of-tree module taints kernel. [ 120.374863] Key type ._llcrypt registered [ 120.376572] Key type .llcrypt registered [ 121.222943] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 121.239284] alg: No test for adler32 (adler32-zlib) [ 122.690297] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 123.669903] LNet: Added LNI 192.168.202.31@tcp [8/256/0/180] [ 125.527393] Key type lgssc registered [ 128.491350] Lustre: Echo OBD driver; http://www.lustre.org/ [ 136.678246] alg: No test for zstdfast (zstdfast-lustre-generic) [ 136.705237] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 296.032213] Lustre: Mounted lustre-client [ 303.157353] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 317.623212] Lustre: DEBUG MARKER: oleg231-client.virtnet: executing check_logdir /tmp/testlogs/ [ 321.512551] Lustre: lustre-OST0000-osc-ffff8897507bb800: disconnect after 22s idle [ 326.460992] Lustre: DEBUG MARKER: oleg231-client.virtnet: executing yml_node [ 333.917569] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 337.507597] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 340.861416] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 342.372205] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:54:39 EDT 2026 [ 364.133317] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 365.649732] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 367.411884] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a [ 370.085204] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51c 51e 834 [ 371.669188] Lustre: DEBUG MARKER: === sanity: start setup 12:55:08 (1789059308) === [ 375.867224] Lustre: DEBUG MARKER: oleg231-client.virtnet: executing check_config_client /mnt/lustre [ 396.452874] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 413.000697] Lustre: DEBUG MARKER: === sanity: finish setup 12:55:49 (1789059349) === [ 424.082373] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:56:00 (1789059360) [ 426.038504] lustre_kcompr_23032: ***** [ 426.040488] lustre_kcompr_23032: (de)compression test on random binary data [ 426.049836] lustre_kcompr_23032: ***** [ 426.071873] lustre_kcompr_23032: compr lz4(1) in 64kB chunks took 2039 us (1961 MB/s), compress ratio: 96.85 [ 426.082249] lustre_kcompr_23032: compr lz4(1) in 128kB chunks took 2637 us (1516 MB/s), compress ratio: 101.58 [ 426.101838] lustre_kcompr_23032: compr lz4(1) in 256kB chunks took 2315 us (1727 MB/s), compress ratio: 104.30 [ 426.113918] lustre_kcompr_23032: compr lz4(1) in 512kB chunks took 1783 us (2243 MB/s), compress ratio: 106.08 [ 426.122609] lustre_kcompr_23032: compr lz4(1) in 1024kB chunks took 1829 us (2186 MB/s), compress ratio: 107.11 [ 426.132447] lustre_kcompr_23032: compr lz4(1) in 2048kB chunks took 1913 us (2090 MB/s), compress ratio: 107.80 [ 426.143589] lustre_kcompr_23032: compr lz4(1) in 4096kB chunks took 3294 us (1214 MB/s), compress ratio: 107.70 [ 426.161591] lustre_kcompr_23032: decompr lz4(1) took 5846 us (6 MB/s) [ 426.165665] lustre_kcompr_23032: test_comp_compress_decompress(lz4,1) ret 0 [ 426.169736] lustre_kcompr_23032: acompr lz4(1) of 128kB chunks took 92 us (1358 MB/s), compress ratio: 100.20 [ 426.174355] lustre_kcompr_23032: adecompr lz4(1) took 119 us (10 MB/s) [ 426.180311] lustre_kcompr_23032: test_acomp_compress_decompress(lz4,1) ret 0 [ 426.199516] lustre_kcompr_23032: compr lz4(4) in 64kB chunks took 5073 us (788 MB/s), compress ratio: 82.76 [ 426.224315] lustre_kcompr_23032: compr lz4(4) in 128kB chunks took 14441 us (276 MB/s), compress ratio: 93.20 [ 426.235428] lustre_kcompr_23032: compr lz4(4) in 256kB chunks took 2679 us (1493 MB/s), compress ratio: 98.87 [ 426.249401] lustre_kcompr_23032: compr lz4(4) in 512kB chunks took 3621 us (1104 MB/s), compress ratio: 102.19 [ 426.260601] lustre_kcompr_23032: compr lz4(4) in 1024kB chunks took 1889 us (2117 MB/s), compress ratio: 104.40 [ 426.274468] lustre_kcompr_23032: compr lz4(4) in 2048kB chunks took 4717 us (847 MB/s), compress ratio: 105.28 [ 426.288771] lustre_kcompr_23032: compr lz4(4) in 4096kB chunks took 2461 us (1625 MB/s), compress ratio: 105.86 [ 426.312307] lustre_kcompr_23032: decompr lz4(4) took 2997 us (12 MB/s) [ 426.319680] lustre_kcompr_23032: test_comp_compress_decompress(lz4,4) ret 0 [ 426.328505] lustre_kcompr_23032: acompr lz4(4) of 128kB chunks took 96 us (1302 MB/s), compress ratio: 90.20 [ 426.344691] lustre_kcompr_23032: adecompr lz4(4) took 139 us (9 MB/s) [ 426.367831] lustre_kcompr_23032: test_acomp_compress_decompress(lz4,4) ret 0 [ 426.413082] lustre_kcompr_23032: compr lz4(9) in 64kB chunks took 3751 us (1066 MB/s), compress ratio: 61.61 [ 426.435358] lustre_kcompr_23032: compr lz4(9) in 128kB chunks took 13578 us (294 MB/s), compress ratio: 76.45 [ 426.454154] lustre_kcompr_23032: compr lz4(9) in 256kB chunks took 4313 us (927 MB/s), compress ratio: 88.47 [ 426.464810] lustre_kcompr_23032: compr lz4(9) in 512kB chunks took 4233 us (944 MB/s), compress ratio: 94.74 [ 426.488497] lustre_kcompr_23032: compr lz4(9) in 1024kB chunks took 1905 us (2099 MB/s), compress ratio: 98.01 [ 426.501285] lustre_kcompr_23032: compr lz4(9) in 2048kB chunks took 1614 us (2478 MB/s), compress ratio: 99.78 [ 426.518231] lustre_kcompr_23032: compr lz4(9) in 4096kB chunks took 9001 us (444 MB/s), compress ratio: 100.44 [ 426.543704] lustre_kcompr_23032: decompr lz4(9) took 6636 us (6 MB/s) [ 426.551631] lustre_kcompr_23032: test_comp_compress_decompress(lz4,9) ret 0 [ 426.557590] lustre_kcompr_23032: acompr lz4(9) of 128kB chunks took 101 us (1237 MB/s), compress ratio: 75.98 [ 426.571489] lustre_kcompr_23032: adecompr lz4(9) took 102 us (16 MB/s) [ 426.596388] lustre_kcompr_23032: test_acomp_compress_decompress(lz4,9) ret 0 [ 426.631416] lustre_kcompr_23032: compr lz4(15) in 64kB chunks took 6917 us (578 MB/s), compress ratio: 29.47 [ 426.653492] lustre_kcompr_23032: compr lz4(15) in 128kB chunks took 11506 us (347 MB/s), compress ratio: 43.64 [ 426.671277] lustre_kcompr_23032: compr lz4(15) in 256kB chunks took 1480 us (2702 MB/s), compress ratio: 59.10 [ 426.682157] lustre_kcompr_23032: compr lz4(15) in 512kB chunks took 1423 us (2810 MB/s), compress ratio: 72.02 [ 426.694595] lustre_kcompr_23032: compr lz4(15) in 1024kB chunks took 5353 us (747 MB/s), compress ratio: 79.26 [ 426.706336] lustre_kcompr_23032: compr lz4(15) in 2048kB chunks took 2984 us (1340 MB/s), compress ratio: 84.84 [ 426.720860] lustre_kcompr_23032: compr lz4(15) in 4096kB chunks took 3012 us (1328 MB/s), compress ratio: 87.43 [ 426.763671] lustre_kcompr_23032: decompr lz4(15) took 9555 us (4 MB/s) [ 426.774718] lustre_kcompr_23032: test_comp_compress_decompress(lz4,15) ret 0 [ 426.789196] lustre_kcompr_23032: acompr lz4(15) of 128kB chunks took 423 us (295 MB/s), compress ratio: 43.73 [ 426.794747] lustre_kcompr_23032: adecompr lz4(15) took 198 us (14 MB/s) [ 426.806709] lustre_kcompr_23032: test_acomp_compress_decompress(lz4,15) ret 0 [ 426.882665] lustre_kcompr_23032: compr lz4hc(1) in 64kB chunks took 49224 us (81 MB/s), compress ratio: 98.12 [ 426.960759] lustre_kcompr_23032: compr lz4hc(1) in 128kB chunks took 53457 us (74 MB/s), compress ratio: 104.12 [ 427.016456] lustre_kcompr_23032: compr lz4hc(1) in 256kB chunks took 42627 us (93 MB/s), compress ratio: 107.40 [ 427.064198] lustre_kcompr_23032: compr lz4hc(1) in 512kB chunks took 39008 us (102 MB/s), compress ratio: 109.11 [ 427.117677] lustre_kcompr_23032: compr lz4hc(1) in 1024kB chunks took 44868 us (89 MB/s), compress ratio: 109.98 [ 427.189842] lustre_kcompr_23032: compr lz4hc(1) in 2048kB chunks took 59361 us (67 MB/s), compress ratio: 110.43 [ 427.237417] lustre_kcompr_23032: compr lz4hc(1) in 4096kB chunks took 38335 us (104 MB/s), compress ratio: 110.65 [ 427.263621] lustre_kcompr_23032: decompr lz4hc(1) took 4826 us (7 MB/s) [ 427.272265] lustre_kcompr_23032: test_comp_compress_decompress(lz4hc,1) ret 0 [ 427.276125] lustre_kcompr_23032: acompr lz4hc(1) of 128kB chunks took 679 us (184 MB/s), compress ratio: 104.77 [ 427.281353] lustre_kcompr_23032: adecompr lz4hc(1) took 94 us (12 MB/s) [ 427.296165] lustre_kcompr_23032: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 427.388448] lustre_kcompr_23032: compr lz4hc(3) in 64kB chunks took 72903 us (54 MB/s), compress ratio: 98.51 [ 427.480178] lustre_kcompr_23032: compr lz4hc(3) in 128kB chunks took 83280 us (48 MB/s), compress ratio: 104.52 [ 427.570091] lustre_kcompr_23032: compr lz4hc(3) in 256kB chunks took 75186 us (53 MB/s), compress ratio: 107.80 [ 427.666067] lustre_kcompr_23032: compr lz4hc(3) in 512kB chunks took 82659 us (48 MB/s), compress ratio: 109.52 [ 427.797491] lustre_kcompr_23032: compr lz4hc(3) in 1024kB chunks took 107633 us (37 MB/s), compress ratio: 110.39 [ 427.964599] lustre_kcompr_23032: compr lz4hc(3) in 2048kB chunks took 145280 us (27 MB/s), compress ratio: 110.85 [ 428.082433] lustre_kcompr_23032: compr lz4hc(3) in 4096kB chunks took 103436 us (38 MB/s), compress ratio: 111.07 [ 428.108535] lustre_kcompr_23032: decompr lz4hc(3) took 2544 us (14 MB/s) [ 428.117619] lustre_kcompr_23032: test_comp_compress_decompress(lz4hc,3) ret 0 [ 428.133659] lustre_kcompr_23032: acompr lz4hc(3) of 128kB chunks took 951 us (131 MB/s), compress ratio: 105.27 [ 428.144210] lustre_kcompr_23032: adecompr lz4hc(3) took 80 us (14 MB/s) [ 428.157262] lustre_kcompr_23032: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 429.323632] lustre_kcompr_23032: compr lz4hc(8) in 64kB chunks took 1142415 us (3 MB/s), compress ratio: 105.10 [ 430.694376] lustre_kcompr_23032: compr lz4hc(8) in 128kB chunks took 1349745 us (2 MB/s), compress ratio: 112.27 [ 431.970816] lustre_kcompr_23032: compr lz4hc(8) in 256kB chunks took 1264010 us (3 MB/s), compress ratio: 116.32 [ 433.193427] lustre_kcompr_23032: compr lz4hc(8) in 512kB chunks took 1210389 us (3 MB/s), compress ratio: 118.38 [ 434.143319] Lustre: lustre-OST0000-osc-ffff8897507bb800: disconnect after 21s idle [ 434.146137] Lustre: Skipped 1 previous similar message [ 434.292775] lustre_kcompr_23032: compr lz4hc(8) in 1024kB chunks took 1092539 us (3 MB/s), compress ratio: 119.43 [ 435.433247] lustre_kcompr_23032: compr lz4hc(8) in 2048kB chunks took 1131286 us (3 MB/s), compress ratio: 119.98 [ 436.852266] lustre_kcompr_23032: compr lz4hc(8) in 4096kB chunks took 1409579 us (2 MB/s), compress ratio: 120.26 [ 436.882950] lustre_kcompr_23032: decompr lz4hc(8) took 4880 us (6 MB/s) [ 436.892450] lustre_kcompr_23032: test_comp_compress_decompress(lz4hc,8) ret 0 [ 436.960574] lustre_kcompr_23032: acompr lz4hc(8) of 128kB chunks took 58985 us (2 MB/s), compress ratio: 112.41 [ 436.973081] lustre_kcompr_23032: adecompr lz4hc(8) took 193 us (5 MB/s) [ 436.980315] lustre_kcompr_23032: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 438.057428] lustre_kcompr_23032: compr lz4hc(15) in 64kB chunks took 1059220 us (3 MB/s), compress ratio: 105.68 [ 439.272967] lustre_kcompr_23032: compr lz4hc(15) in 128kB chunks took 1207842 us (3 MB/s), compress ratio: 113.35 [ 440.212263] lustre_kcompr_23032: compr lz4hc(15) in 256kB chunks took 926623 us (4 MB/s), compress ratio: 117.61 [ 441.754988] lustre_kcompr_23032: compr lz4hc(15) in 512kB chunks took 1527440 us (2 MB/s), compress ratio: 119.83 [ 443.165590] lustre_kcompr_23032: compr lz4hc(15) in 1024kB chunks took 1397301 us (2 MB/s), compress ratio: 120.94 [ 444.748629] lustre_kcompr_23032: compr lz4hc(15) in 2048kB chunks took 1576728 us (2 MB/s), compress ratio: 121.54 [ 446.196743] lustre_kcompr_23032: compr lz4hc(15) in 4096kB chunks took 1435374 us (2 MB/s), compress ratio: 121.84 [ 446.207080] lustre_kcompr_23032: decompr lz4hc(15) took 1617 us (20 MB/s) [ 446.210854] lustre_kcompr_23032: test_comp_compress_decompress(lz4hc,15) ret 0 [ 446.237260] lustre_kcompr_23032: acompr lz4hc(15) of 128kB chunks took 22302 us (5 MB/s), compress ratio: 113.58 [ 446.242327] lustre_kcompr_23032: adecompr lz4hc(15) took 279 us (3 MB/s) [ 446.249228] lustre_kcompr_23032: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 446.256252] lustre_kcompr_23032: compr lzo(-1) in 64kB chunks took 2233 us (1791 MB/s), compress ratio: 82.20 [ 446.265676] lustre_kcompr_23032: compr lzo(-1) in 128kB chunks took 2784 us (1436 MB/s), compress ratio: 86.93 [ 446.274825] lustre_kcompr_23032: compr lzo(-1) in 256kB chunks took 2467 us (1621 MB/s), compress ratio: 87.46 [ 446.283810] lustre_kcompr_23032: compr lzo(-1) in 512kB chunks took 2904 us (1377 MB/s), compress ratio: 88.42 [ 446.291809] lustre_kcompr_23032: compr lzo(-1) in 1024kB chunks took 2126 us (1881 MB/s), compress ratio: 88.48 [ 446.302937] lustre_kcompr_23032: compr lzo(-1) in 2048kB chunks took 3344 us (1196 MB/s), compress ratio: 88.57 [ 446.312706] lustre_kcompr_23032: compr lzo(-1) in 4096kB chunks took 2672 us (1497 MB/s), compress ratio: 88.76 [ 446.344918] lustre_kcompr_23032: decompr lzo(-1) took 2456 us (18 MB/s) [ 446.356485] lustre_kcompr_23032: test_comp_compress_decompress(lzo,-1) ret 0 [ 446.360393] lustre_kcompr_23032: acompr lzo(-1) of 128kB chunks took 106 us (1179 MB/s), compress ratio: 82.79 [ 446.367754] lustre_kcompr_23032: adecompr lzo(-1) took 1668 us (0 MB/s) [ 446.376250] lustre_kcompr_23032: test_acomp_compress_decompress(lzo,-1) ret 0 [ 446.880567] lustre_kcompr_23032: compr deflate(1) in 64kB chunks took 490835 us (8 MB/s), compress ratio: 98.71 [ 447.607622] lustre_kcompr_23032: compr deflate(1) in 128kB chunks took 720046 us (5 MB/s), compress ratio: 108.86 [ 448.235122] lustre_kcompr_23032: compr deflate(1) in 256kB chunks took 614590 us (6 MB/s), compress ratio: 115.39 [ 448.999841] lustre_kcompr_23032: compr deflate(1) in 512kB chunks took 753534 us (5 MB/s), compress ratio: 119.26 [ 449.672680] lustre_kcompr_23032: compr deflate(1) in 1024kB chunks took 660486 us (6 MB/s), compress ratio: 121.19 [ 450.310739] lustre_kcompr_23032: compr deflate(1) in 2048kB chunks took 631236 us (6 MB/s), compress ratio: 122.14 [ 450.957571] lustre_kcompr_23032: compr deflate(1) in 4096kB chunks took 635861 us (6 MB/s), compress ratio: 122.43 [ 451.020105] lustre_kcompr_23032: decompr deflate(1) took 9174 us (3 MB/s) [ 451.038466] lustre_kcompr_23032: test_comp_compress_decompress(deflate,1) ret 0 [ 451.097616] lustre_kcompr_23032: acompr deflate(1) of 128kB chunks took 39814 us (3 MB/s), compress ratio: 108.50 [ 451.104873] lustre_kcompr_23032: adecompr deflate(1) took 218 us (5 MB/s) [ 451.130474] lustre_kcompr_23032: test_acomp_compress_decompress(deflate,1) ret 0 [ 451.620750] lustre_kcompr_23032: compr deflate(6) in 64kB chunks took 451791 us (8 MB/s), compress ratio: 98.71 [ 452.124310] lustre_kcompr_23032: compr deflate(6) in 128kB chunks took 498683 us (8 MB/s), compress ratio: 108.86 [ 452.585586] lustre_kcompr_23032: compr deflate(6) in 256kB chunks took 456125 us (8 MB/s), compress ratio: 115.39 [ 453.212971] lustre_kcompr_23032: compr deflate(6) in 512kB chunks took 612280 us (6 MB/s), compress ratio: 119.26 [ 453.762474] lustre_kcompr_23032: compr deflate(6) in 1024kB chunks took 536801 us (7 MB/s), compress ratio: 121.19 [ 454.211394] lustre_kcompr_23032: compr deflate(6) in 2048kB chunks took 443906 us (9 MB/s), compress ratio: 122.14 [ 454.785398] lustre_kcompr_23032: compr deflate(6) in 4096kB chunks took 562929 us (7 MB/s), compress ratio: 122.43 [ 454.834448] lustre_kcompr_23032: decompr deflate(6) took 6583 us (4 MB/s) [ 454.858537] lustre_kcompr_23032: test_comp_compress_decompress(deflate,6) ret 0 [ 454.908520] lustre_kcompr_23032: acompr deflate(6) of 128kB chunks took 33094 us (3 MB/s), compress ratio: 108.50 [ 454.921563] lustre_kcompr_23032: adecompr deflate(6) took 184 us (6 MB/s) [ 454.955280] lustre_kcompr_23032: test_acomp_compress_decompress(deflate,6) ret 0 [ 455.574488] lustre_kcompr_23032: compr deflate(9) in 64kB chunks took 592784 us (6 MB/s), compress ratio: 98.71 [ 456.096992] lustre_kcompr_23032: compr deflate(9) in 128kB chunks took 509349 us (7 MB/s), compress ratio: 108.86 [ 456.668602] lustre_kcompr_23032: compr deflate(9) in 256kB chunks took 556470 us (7 MB/s), compress ratio: 115.39 [ 457.231577] lustre_kcompr_23032: compr deflate(9) in 512kB chunks took 555787 us (7 MB/s), compress ratio: 119.26 [ 457.704472] lustre_kcompr_23032: compr deflate(9) in 1024kB chunks took 463485 us (8 MB/s), compress ratio: 121.19 [ 458.233423] lustre_kcompr_23032: compr deflate(9) in 2048kB chunks took 520315 us (7 MB/s), compress ratio: 122.14 [ 458.805714] lustre_kcompr_23032: compr deflate(9) in 4096kB chunks took 565743 us (7 MB/s), compress ratio: 122.43 [ 458.844391] lustre_kcompr_23032: decompr deflate(9) took 10662 us (3 MB/s) [ 458.857203] lustre_kcompr_23032: test_comp_compress_decompress(deflate,9) ret 0 [ 458.895453] lustre_kcompr_23032: acompr deflate(9) of 128kB chunks took 29652 us (4 MB/s), compress ratio: 108.50 [ 458.905937] lustre_kcompr_23032: adecompr deflate(9) took 180 us (6 MB/s) [ 458.936116] lustre_kcompr_23032: test_acomp_compress_decompress(deflate,9) ret 0 [ 458.981676] lustre_kcompr_23032: compr zstd(0) in 64kB chunks took 12984 us (308 MB/s), compress ratio: 159.74 [ 459.030617] lustre_kcompr_23032: compr zstd(0) in 128kB chunks took 39801 us (100 MB/s), compress ratio: 193.80 [ 459.091756] lustre_kcompr_23032: compr zstd(0) in 256kB chunks took 47198 us (84 MB/s), compress ratio: 205.49 [ 459.128389] lustre_kcompr_23032: compr zstd(0) in 512kB chunks took 27547 us (145 MB/s), compress ratio: 213.15 [ 459.143525] lustre_kcompr_23032: compr zstd(0) in 1024kB chunks took 7643 us (523 MB/s), compress ratio: 215.68 [ 459.157797] lustre_kcompr_23032: compr zstd(0) in 2048kB chunks took 5353 us (747 MB/s), compress ratio: 217.27 [ 459.182265] lustre_kcompr_23032: compr zstd(0) in 4096kB chunks took 15618 us (256 MB/s), compress ratio: 217.72 [ 459.208914] lustre_kcompr_23032: decompr zstd(0) took 10048 us (1 MB/s) [ 459.228112] lustre_kcompr_23032: test_comp_compress_decompress(zstd,0) ret 0 [ 459.241160] lustre_kcompr_23032: acompr zstd(0) of 128kB chunks took 1614 us (77 MB/s), compress ratio: 193.89 [ 459.261822] lustre_kcompr_23032: adecompr zstd(0) took 128 us (5 MB/s) [ 459.288125] lustre_kcompr_23032: test_acomp_compress_decompress(zstd,0) ret 0 [ 459.328458] lustre_kcompr_23032: compr zstd(1) in 64kB chunks took 2928 us (1366 MB/s), compress ratio: 159.09 [ 459.349929] lustre_kcompr_23032: compr zstd(1) in 128kB chunks took 3579 us (1117 MB/s), compress ratio: 192.34 [ 459.375133] lustre_kcompr_23032: compr zstd(1) in 256kB chunks took 9501 us (421 MB/s), compress ratio: 204.27 [ 459.390705] lustre_kcompr_23032: compr zstd(1) in 512kB chunks took 7265 us (550 MB/s), compress ratio: 210.98 [ 459.405816] lustre_kcompr_23032: compr zstd(1) in 1024kB chunks took 6632 us (603 MB/s), compress ratio: 213.11 [ 459.418435] lustre_kcompr_23032: compr zstd(1) in 2048kB chunks took 6006 us (666 MB/s), compress ratio: 212.70 [ 459.436381] lustre_kcompr_23032: compr zstd(1) in 4096kB chunks took 3688 us (1084 MB/s), compress ratio: 213.77 [ 459.475197] lustre_kcompr_23032: decompr zstd(1) took 1854 us (10 MB/s) [ 459.493660] lustre_kcompr_23032: test_comp_compress_decompress(zstd,1) ret 0 [ 459.507317] lustre_kcompr_23032: acompr zstd(1) of 128kB chunks took 508 us (246 MB/s), compress ratio: 193.89 [ 459.515760] lustre_kcompr_23032: adecompr zstd(1) took 193 us (3 MB/s) [ 459.527436] lustre_kcompr_23032: test_acomp_compress_decompress(zstd,1) ret 0 [ 459.737559] lustre_kcompr_23032: compr zstd(10) in 64kB chunks took 183857 us (21 MB/s), compress ratio: 162.23 [ 459.981433] lustre_kcompr_23032: compr zstd(10) in 128kB chunks took 230204 us (17 MB/s), compress ratio: 185.58 [ 460.373394] lustre_kcompr_23032: compr zstd(10) in 256kB chunks took 385082 us (10 MB/s), compress ratio: 197.67 [ 460.572983] lustre_kcompr_23032: compr zstd(10) in 512kB chunks took 190243 us (21 MB/s), compress ratio: 219.52 [ 460.775217] lustre_kcompr_23032: compr zstd(10) in 1024kB chunks took 193032 us (20 MB/s), compress ratio: 223.98 [ 461.020138] lustre_kcompr_23032: compr zstd(10) in 2048kB chunks took 235201 us (17 MB/s), compress ratio: 225.63 [ 461.062683] lustre_kcompr_23032: compr zstd(10) in 4096kB chunks took 37770 us (105 MB/s), compress ratio: 226.80 [ 461.081351] lustre_kcompr_23032: decompr zstd(10) took 2377 us (7 MB/s) [ 461.087718] lustre_kcompr_23032: test_comp_compress_decompress(zstd,10) ret 0 [ 461.099360] lustre_kcompr_23032: acompr zstd(10) of 128kB chunks took 4121 us (30 MB/s), compress ratio: 185.91 [ 461.108872] lustre_kcompr_23032: adecompr zstd(10) took 128 us (5 MB/s) [ 461.123251] lustre_kcompr_23032: test_acomp_compress_decompress(zstd,10) ret 0 [ 461.964936] lustre_kcompr_23032: compr zstd(15) in 64kB chunks took 829349 us (4 MB/s), compress ratio: 171.00 [ 462.862726] lustre_kcompr_23032: compr zstd(15) in 128kB chunks took 886375 us (4 MB/s), compress ratio: 197.19 [ 463.865139] lustre_kcompr_23032: compr zstd(15) in 256kB chunks took 997385 us (4 MB/s), compress ratio: 211.47 [ 464.734332] lustre_kcompr_23032: compr zstd(15) in 512kB chunks took 853379 us (4 MB/s), compress ratio: 219.39 [ 465.714058] lustre_kcompr_23032: compr zstd(15) in 1024kB chunks took 966314 us (4 MB/s), compress ratio: 222.73 [ 466.943735] lustre_kcompr_23032: compr zstd(15) in 2048kB chunks took 1222361 us (3 MB/s), compress ratio: 223.25 [ 469.063544] lustre_kcompr_23032: compr zstd(15) in 4096kB chunks took 2107667 us (1 MB/s), compress ratio: 222.66 [ 469.086087] lustre_kcompr_23032: decompr zstd(15) took 3123 us (5 MB/s) [ 469.096127] lustre_kcompr_23032: test_comp_compress_decompress(zstd,15) ret 0 [ 469.144528] lustre_kcompr_23032: acompr zstd(15) of 128kB chunks took 36254 us (3 MB/s), compress ratio: 195.33 [ 469.154577] lustre_kcompr_23032: adecompr zstd(15) took 1017 us (0 MB/s) [ 469.169412] lustre_kcompr_23032: test_acomp_compress_decompress(zstd,15) ret 0 [ 469.198262] lustre_kcompr_23032: compr zstdfast(1) in 64kB chunks took 8246 us (485 MB/s), compress ratio: 159.09 [ 469.209311] lustre_kcompr_23032: compr zstdfast(1) in 128kB chunks took 4152 us (963 MB/s), compress ratio: 192.34 [ 469.221333] lustre_kcompr_23032: compr zstdfast(1) in 256kB chunks took 2028 us (1972 MB/s), compress ratio: 204.27 [ 469.231156] lustre_kcompr_23032: compr zstdfast(1) in 512kB chunks took 2259 us (1770 MB/s), compress ratio: 210.98 [ 469.246443] lustre_kcompr_23032: compr zstdfast(1) in 1024kB chunks took 2010 us (1990 MB/s), compress ratio: 213.11 [ 469.259161] lustre_kcompr_23032: compr zstdfast(1) in 2048kB chunks took 4774 us (837 MB/s), compress ratio: 212.70 [ 469.278902] lustre_kcompr_23032: compr zstdfast(1) in 4096kB chunks took 6089 us (656 MB/s), compress ratio: 213.77 [ 469.297540] lustre_kcompr_23032: decompr zstdfast(1) took 4716 us (3 MB/s) [ 469.304545] lustre_kcompr_23032: test_comp_compress_decompress(zstdfast,1) ret 0 [ 469.313472] lustre_kcompr_23032: acompr zstdfast(1) of 128kB chunks took 147 us (850 MB/s), compress ratio: 193.89 [ 469.323784] lustre_kcompr_23032: adecompr zstdfast(1) took 107 us (6 MB/s) [ 469.328507] lustre_kcompr_23032: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 469.340297] lustre_kcompr_23032: compr zstdfast(5) in 64kB chunks took 3358 us (1191 MB/s), compress ratio: 140.81 [ 469.350569] lustre_kcompr_23032: compr zstdfast(5) in 128kB chunks took 7023 us (569 MB/s), compress ratio: 167.02 [ 469.365073] lustre_kcompr_23032: compr zstdfast(5) in 256kB chunks took 2145 us (1864 MB/s), compress ratio: 175.83 [ 469.393242] lustre_kcompr_23032: compr zstdfast(5) in 512kB chunks took 10170 us (393 MB/s), compress ratio: 181.08 [ 469.400754] lustre_kcompr_23032: compr zstdfast(5) in 1024kB chunks took 2557 us (1564 MB/s), compress ratio: 182.35 [ 469.409383] lustre_kcompr_23032: compr zstdfast(5) in 2048kB chunks took 2754 us (1452 MB/s), compress ratio: 182.81 [ 469.415852] lustre_kcompr_23032: compr zstdfast(5) in 4096kB chunks took 1366 us (2928 MB/s), compress ratio: 183.38 [ 469.427741] lustre_kcompr_23032: decompr zstdfast(5) took 2212 us (9 MB/s) [ 469.431721] lustre_kcompr_23032: test_comp_compress_decompress(zstdfast,5) ret 0 [ 469.436904] lustre_kcompr_23032: acompr zstdfast(5) of 128kB chunks took 146 us (856 MB/s), compress ratio: 170.66 [ 469.444162] lustre_kcompr_23032: adecompr zstdfast(5) took 136 us (5 MB/s) [ 469.455681] lustre_kcompr_23032: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 469.495928] lustre_kcompr_23032: compr zstdfast(12) in 64kB chunks took 2527 us (1582 MB/s), compress ratio: 38.94 [ 469.518294] lustre_kcompr_23032: compr zstdfast(12) in 128kB chunks took 6622 us (604 MB/s), compress ratio: 44.98 [ 469.540218] lustre_kcompr_23032: compr zstdfast(12) in 256kB chunks took 2865 us (1396 MB/s), compress ratio: 50.50 [ 469.564781] lustre_kcompr_23032: compr zstdfast(12) in 512kB chunks took 6106 us (655 MB/s), compress ratio: 57.18 [ 469.578424] lustre_kcompr_23032: compr zstdfast(12) in 1024kB chunks took 3564 us (1122 MB/s), compress ratio: 67.36 [ 469.597399] lustre_kcompr_23032: compr zstdfast(12) in 2048kB chunks took 4454 us (898 MB/s), compress ratio: 72.12 [ 469.618396] lustre_kcompr_23032: compr zstdfast(12) in 4096kB chunks took 11165 us (358 MB/s), compress ratio: 73.93 [ 469.644478] lustre_kcompr_23032: decompr zstdfast(12) took 1609 us (33 MB/s) [ 469.663768] lustre_kcompr_23032: test_comp_compress_decompress(zstdfast,12) ret 0 [ 469.675248] lustre_kcompr_23032: acompr zstdfast(12) of 128kB chunks took 152 us (822 MB/s), compress ratio: 44.31 [ 469.684782] lustre_kcompr_23032: adecompr zstdfast(12) took 121 us (23 MB/s) [ 469.705321] lustre_kcompr_23032: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 469.727855] lustre_kcompr_23032: compr zstdfast(15) in 64kB chunks took 8182 us (488 MB/s), compress ratio: 19.01 [ 469.743642] lustre_kcompr_23032: compr zstdfast(15) in 128kB chunks took 2114 us (1892 MB/s), compress ratio: 19.72 [ 469.750966] lustre_kcompr_23032: compr zstdfast(15) in 256kB chunks took 1974 us (2026 MB/s), compress ratio: 20.23 [ 469.761954] lustre_kcompr_23032: compr zstdfast(15) in 512kB chunks took 3236 us (1236 MB/s), compress ratio: 20.94 [ 469.771671] lustre_kcompr_23032: compr zstdfast(15) in 1024kB chunks took 3840 us (1041 MB/s), compress ratio: 22.42 [ 469.780792] lustre_kcompr_23032: compr zstdfast(15) in 2048kB chunks took 2030 us (1970 MB/s), compress ratio: 21.74 [ 469.797365] lustre_kcompr_23032: compr zstdfast(15) in 4096kB chunks took 4616 us (866 MB/s), compress ratio: 26.71 [ 469.812424] lustre_kcompr_23032: decompr zstdfast(15) took 2446 us (61 MB/s) [ 469.825321] lustre_kcompr_23032: test_comp_compress_decompress(zstdfast,15) ret 0 [ 469.842238] lustre_kcompr_23032: acompr zstdfast(15) of 128kB chunks took 155 us (806 MB/s), compress ratio: 18.80 [ 469.850345] lustre_kcompr_23032: adecompr zstdfast(15) took 114 us (58 MB/s) [ 469.903459] lustre_kcompr_23032: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 469.912408] lustre_kcompr_23032: SUCCESS [ 477.608737] lustre_kcompr_26370: ***** [ 477.610763] lustre_kcompr_26370: (de)compression test on provided file /tmp/f84.sanity [ 477.614130] lustre_kcompr_26370: ***** [ 477.649358] lustre_kcompr_26370: compr lz4(1) in 64kB chunks took 25604 us (156 MB/s), compress ratio: 2.93 [ 477.673289] lustre_kcompr_26370: compr lz4(1) in 128kB chunks took 20396 us (196 MB/s), compress ratio: 3.04 [ 477.719246] lustre_kcompr_26370: compr lz4(1) in 256kB chunks took 40854 us (97 MB/s), compress ratio: 3.08 [ 477.767365] lustre_kcompr_26370: compr lz4(1) in 512kB chunks took 39757 us (100 MB/s), compress ratio: 3.10 [ 477.815570] lustre_kcompr_26370: compr lz4(1) in 1024kB chunks took 38279 us (104 MB/s), compress ratio: 3.11 [ 477.861176] lustre_kcompr_26370: compr lz4(1) in 2048kB chunks took 36453 us (109 MB/s), compress ratio: 3.11 [ 477.897744] lustre_kcompr_26370: compr lz4(1) in 4096kB chunks took 32189 us (124 MB/s), compress ratio: 3.12 [ 477.913373] lustre_kcompr_26370: decompr lz4(1) took 4841 us (264 MB/s) [ 477.917921] lustre_kcompr_26370: test_comp_compress_decompress(lz4,1) ret 0 [ 477.924137] lustre_kcompr_26370: acompr lz4(1) of 128kB chunks took 856 us (146 MB/s), compress ratio: 2.68 [ 477.929288] lustre_kcompr_26370: adecompr lz4(1) took 448 us (103 MB/s) [ 477.936971] lustre_kcompr_26370: test_acomp_compress_decompress(lz4,1) ret 0 [ 477.968713] lustre_kcompr_26370: compr lz4(4) in 64kB chunks took 21188 us (188 MB/s), compress ratio: 2.67 [ 477.998572] lustre_kcompr_26370: compr lz4(4) in 128kB chunks took 24164 us (165 MB/s), compress ratio: 2.63 [ 478.028768] lustre_kcompr_26370: compr lz4(4) in 256kB chunks took 23871 us (167 MB/s), compress ratio: 2.68 [ 478.069253] lustre_kcompr_26370: compr lz4(4) in 512kB chunks took 28905 us (138 MB/s), compress ratio: 2.71 [ 478.117196] lustre_kcompr_26370: compr lz4(4) in 1024kB chunks took 36867 us (108 MB/s), compress ratio: 2.72 [ 478.174656] lustre_kcompr_26370: compr lz4(4) in 2048kB chunks took 47885 us (83 MB/s), compress ratio: 2.72 [ 478.226572] lustre_kcompr_26370: compr lz4(4) in 4096kB chunks took 44433 us (90 MB/s), compress ratio: 2.73 [ 478.245282] lustre_kcompr_26370: decompr lz4(4) took 7264 us (201 MB/s) [ 478.248694] lustre_kcompr_26370: test_comp_compress_decompress(lz4,4) ret 0 [ 478.258251] lustre_kcompr_26370: acompr lz4(4) of 128kB chunks took 1198 us (104 MB/s), compress ratio: 2.30 [ 478.265665] lustre_kcompr_26370: adecompr lz4(4) took 747 us (72 MB/s) [ 478.323694] lustre_kcompr_26370: test_acomp_compress_decompress(lz4,4) ret 0 [ 478.428445] lustre_kcompr_26370: compr lz4(9) in 64kB chunks took 47063 us (84 MB/s), compress ratio: 2.30 [ 478.474835] lustre_kcompr_26370: compr lz4(9) in 128kB chunks took 36047 us (110 MB/s), compress ratio: 2.15 [ 478.529909] lustre_kcompr_26370: compr lz4(9) in 256kB chunks took 43974 us (90 MB/s), compress ratio: 2.20 [ 478.585113] lustre_kcompr_26370: compr lz4(9) in 512kB chunks took 39270 us (101 MB/s), compress ratio: 2.23 [ 478.634330] lustre_kcompr_26370: compr lz4(9) in 1024kB chunks took 40238 us (99 MB/s), compress ratio: 2.25 [ 478.688720] lustre_kcompr_26370: compr lz4(9) in 2048kB chunks took 42096 us (95 MB/s), compress ratio: 2.25 [ 478.735245] lustre_kcompr_26370: compr lz4(9) in 4096kB chunks took 28919 us (138 MB/s), compress ratio: 2.26 [ 478.774950] lustre_kcompr_26370: decompr lz4(9) took 15872 us (111 MB/s) [ 478.786691] lustre_kcompr_26370: test_comp_compress_decompress(lz4,9) ret 0 [ 478.797254] lustre_kcompr_26370: acompr lz4(9) of 128kB chunks took 2169 us (57 MB/s), compress ratio: 1.87 [ 478.806738] lustre_kcompr_26370: adecompr lz4(9) took 242 us (275 MB/s) [ 478.877216] lustre_kcompr_26370: test_acomp_compress_decompress(lz4,9) ret 0 [ 478.926394] lustre_kcompr_26370: compr lz4(15) in 64kB chunks took 24482 us (163 MB/s), compress ratio: 1.63 [ 478.972541] lustre_kcompr_26370: compr lz4(15) in 128kB chunks took 32438 us (123 MB/s), compress ratio: 1.52 [ 479.028883] lustre_kcompr_26370: compr lz4(15) in 256kB chunks took 42706 us (93 MB/s), compress ratio: 1.56 [ 479.062386] lustre_kcompr_26370: compr lz4(15) in 512kB chunks took 13806 us (289 MB/s), compress ratio: 1.58 [ 479.102178] lustre_kcompr_26370: compr lz4(15) in 1024kB chunks took 34673 us (115 MB/s), compress ratio: 1.60 [ 479.122545] lustre_kcompr_26370: compr lz4(15) in 2048kB chunks took 14653 us (272 MB/s), compress ratio: 1.60 [ 479.143306] lustre_kcompr_26370: compr lz4(15) in 4096kB chunks took 15831 us (252 MB/s), compress ratio: 1.60 [ 479.163551] lustre_kcompr_26370: decompr lz4(15) took 3655 us (680 MB/s) [ 479.169294] lustre_kcompr_26370: test_comp_compress_decompress(lz4,15) ret 0 [ 479.175314] lustre_kcompr_26370: acompr lz4(15) of 128kB chunks took 653 us (191 MB/s), compress ratio: 1.33 [ 479.181308] lustre_kcompr_26370: adecompr lz4(15) took 232 us (405 MB/s) [ 479.188858] lustre_kcompr_26370: test_acomp_compress_decompress(lz4,15) ret 0 [ 479.374649] lustre_kcompr_26370: compr lz4hc(1) in 64kB chunks took 173112 us (23 MB/s), compress ratio: 3.58 [ 479.481701] lustre_kcompr_26370: compr lz4hc(1) in 128kB chunks took 103421 us (38 MB/s), compress ratio: 3.77 [ 479.708718] lustre_kcompr_26370: compr lz4hc(1) in 256kB chunks took 218979 us (18 MB/s), compress ratio: 3.88 [ 479.937082] lustre_kcompr_26370: compr lz4hc(1) in 512kB chunks took 214889 us (18 MB/s), compress ratio: 3.93 [ 480.334411] lustre_kcompr_26370: compr lz4hc(1) in 1024kB chunks took 391733 us (10 MB/s), compress ratio: 3.96 [ 480.806136] lustre_kcompr_26370: compr lz4hc(1) in 2048kB chunks took 461689 us (8 MB/s), compress ratio: 3.97 [ 481.066632] lustre_kcompr_26370: compr lz4hc(1) in 4096kB chunks took 240838 us (16 MB/s), compress ratio: 3.98 [ 481.099568] lustre_kcompr_26370: decompr lz4hc(1) took 20078 us (50 MB/s) [ 481.105048] lustre_kcompr_26370: test_comp_compress_decompress(lz4hc,1) ret 0 [ 481.141779] lustre_kcompr_26370: acompr lz4hc(1) of 128kB chunks took 13825 us (9 MB/s), compress ratio: 3.27 [ 481.148946] lustre_kcompr_26370: adecompr lz4hc(1) took 202 us (189 MB/s) [ 481.154855] lustre_kcompr_26370: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 481.438126] lustre_kcompr_26370: compr lz4hc(3) in 64kB chunks took 260722 us (15 MB/s), compress ratio: 3.68 [ 481.864939] lustre_kcompr_26370: compr lz4hc(3) in 128kB chunks took 404372 us (9 MB/s), compress ratio: 3.91 [ 482.533518] lustre_kcompr_26370: compr lz4hc(3) in 256kB chunks took 662648 us (6 MB/s), compress ratio: 4.04 [ 483.054429] lustre_kcompr_26370: compr lz4hc(3) in 512kB chunks took 501307 us (7 MB/s), compress ratio: 4.10 [ 483.480685] lustre_kcompr_26370: compr lz4hc(3) in 1024kB chunks took 414899 us (9 MB/s), compress ratio: 4.13 [ 483.732256] lustre_kcompr_26370: compr lz4hc(3) in 2048kB chunks took 243739 us (16 MB/s), compress ratio: 4.15 [ 483.926799] lustre_kcompr_26370: compr lz4hc(3) in 4096kB chunks took 188545 us (21 MB/s), compress ratio: 4.16 [ 483.940180] lustre_kcompr_26370: decompr lz4hc(3) took 4136 us (232 MB/s) [ 483.943722] lustre_kcompr_26370: test_comp_compress_decompress(lz4hc,3) ret 0 [ 483.956142] lustre_kcompr_26370: acompr lz4hc(3) of 128kB chunks took 5136 us (24 MB/s), compress ratio: 3.38 [ 483.960994] lustre_kcompr_26370: adecompr lz4hc(3) took 522 us (70 MB/s) [ 483.965743] lustre_kcompr_26370: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 484.312588] lustre_kcompr_26370: compr lz4hc(8) in 64kB chunks took 337305 us (11 MB/s), compress ratio: 3.72 [ 484.911584] lustre_kcompr_26370: compr lz4hc(8) in 128kB chunks took 589064 us (6 MB/s), compress ratio: 3.96 [ 485.471291] lustre_kcompr_26370: compr lz4hc(8) in 256kB chunks took 549329 us (7 MB/s), compress ratio: 4.10 [ 486.065980] lustre_kcompr_26370: compr lz4hc(8) in 512kB chunks took 590102 us (6 MB/s), compress ratio: 4.17 [ 486.704832] lustre_kcompr_26370: compr lz4hc(8) in 1024kB chunks took 631852 us (6 MB/s), compress ratio: 4.21 [ 487.403269] lustre_kcompr_26370: compr lz4hc(8) in 2048kB chunks took 692243 us (5 MB/s), compress ratio: 4.22 [ 487.835494] lustre_kcompr_26370: compr lz4hc(8) in 4096kB chunks took 420612 us (9 MB/s), compress ratio: 4.23 [ 487.862863] lustre_kcompr_26370: decompr lz4hc(8) took 8365 us (112 MB/s) [ 487.868163] lustre_kcompr_26370: test_comp_compress_decompress(lz4hc,8) ret 0 [ 487.892923] lustre_kcompr_26370: acompr lz4hc(8) of 128kB chunks took 18701 us (6 MB/s), compress ratio: 3.42 [ 487.902820] lustre_kcompr_26370: adecompr lz4hc(8) took 1029 us (35 MB/s) [ 487.937093] lustre_kcompr_26370: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 488.474608] lustre_kcompr_26370: compr lz4hc(15) in 64kB chunks took 517780 us (7 MB/s), compress ratio: 3.72 [ 489.036446] lustre_kcompr_26370: compr lz4hc(15) in 128kB chunks took 555040 us (7 MB/s), compress ratio: 3.96 [ 489.587200] lustre_kcompr_26370: compr lz4hc(15) in 256kB chunks took 547443 us (7 MB/s), compress ratio: 4.10 [ 490.360937] lustre_kcompr_26370: compr lz4hc(15) in 512kB chunks took 769377 us (5 MB/s), compress ratio: 4.17 [ 491.131956] lustre_kcompr_26370: compr lz4hc(15) in 1024kB chunks took 754430 us (5 MB/s), compress ratio: 4.21 [ 491.733580] lustre_kcompr_26370: compr lz4hc(15) in 2048kB chunks took 594788 us (6 MB/s), compress ratio: 4.22 [ 492.542337] lustre_kcompr_26370: compr lz4hc(15) in 4096kB chunks took 802636 us (4 MB/s), compress ratio: 4.23 [ 492.591992] lustre_kcompr_26370: decompr lz4hc(15) took 14563 us (64 MB/s) [ 492.604402] lustre_kcompr_26370: test_comp_compress_decompress(lz4hc,15) ret 0 [ 492.637168] lustre_kcompr_26370: acompr lz4hc(15) of 128kB chunks took 27371 us (4 MB/s), compress ratio: 3.42 [ 492.647607] lustre_kcompr_26370: adecompr lz4hc(15) took 204 us (178 MB/s) [ 492.663336] lustre_kcompr_26370: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 492.722171] lustre_kcompr_26370: compr lzo(-1) in 64kB chunks took 50536 us (79 MB/s), compress ratio: 2.90 [ 492.756598] lustre_kcompr_26370: compr lzo(-1) in 128kB chunks took 28130 us (142 MB/s), compress ratio: 2.95 [ 492.804233] lustre_kcompr_26370: compr lzo(-1) in 256kB chunks took 34439 us (116 MB/s), compress ratio: 2.96 [ 492.833100] lustre_kcompr_26370: compr lzo(-1) in 512kB chunks took 23449 us (170 MB/s), compress ratio: 2.98 [ 492.863429] lustre_kcompr_26370: compr lzo(-1) in 1024kB chunks took 24961 us (160 MB/s), compress ratio: 2.97 [ 492.889570] lustre_kcompr_26370: compr lzo(-1) in 2048kB chunks took 21258 us (188 MB/s), compress ratio: 2.97 [ 492.923474] lustre_kcompr_26370: compr lzo(-1) in 4096kB chunks took 28270 us (141 MB/s), compress ratio: 2.96 [ 492.948409] lustre_kcompr_26370: decompr lzo(-1) took 10700 us (125 MB/s) [ 492.956160] lustre_kcompr_26370: test_comp_compress_decompress(lzo,-1) ret 0 [ 492.961970] lustre_kcompr_26370: acompr lzo(-1) of 128kB chunks took 687 us (181 MB/s), compress ratio: 2.62 [ 492.970432] lustre_kcompr_26370: adecompr lzo(-1) took 784 us (60 MB/s) [ 492.977380] lustre_kcompr_26370: test_acomp_compress_decompress(lzo,-1) ret 0 [ 493.667494] lustre_kcompr_26370: compr deflate(1) in 64kB chunks took 675238 us (5 MB/s), compress ratio: 3.51 [ 494.478817] lustre_kcompr_26370: compr deflate(1) in 128kB chunks took 800478 us (4 MB/s), compress ratio: 3.53 [ 495.245116] lustre_kcompr_26370: compr deflate(1) in 256kB chunks took 746176 us (5 MB/s), compress ratio: 3.53 [ 496.212955] lustre_kcompr_26370: compr deflate(1) in 512kB chunks took 957250 us (4 MB/s), compress ratio: 3.54 [ 497.172667] lustre_kcompr_26370: compr deflate(1) in 1024kB chunks took 944451 us (4 MB/s), compress ratio: 3.54 [ 498.028210] lustre_kcompr_26370: compr deflate(1) in 2048kB chunks took 842327 us (4 MB/s), compress ratio: 3.54 [ 498.614595] lustre_kcompr_26370: compr deflate(1) in 4096kB chunks took 573125 us (6 MB/s), compress ratio: 3.54 [ 498.672775] lustre_kcompr_26370: decompr deflate(1) took 46381 us (24 MB/s) [ 498.683394] lustre_kcompr_26370: test_comp_compress_decompress(deflate,1) ret 0 [ 498.713602] lustre_kcompr_26370: acompr deflate(1) of 128kB chunks took 24830 us (5 MB/s), compress ratio: 3.09 [ 498.722402] lustre_kcompr_26370: adecompr deflate(1) took 1915 us (21 MB/s) [ 498.744706] lustre_kcompr_26370: test_acomp_compress_decompress(deflate,1) ret 0 [ 499.256925] lustre_kcompr_26370: compr deflate(6) in 64kB chunks took 493496 us (8 MB/s), compress ratio: 3.51 [ 499.978956] lustre_kcompr_26370: compr deflate(6) in 128kB chunks took 715305 us (5 MB/s), compress ratio: 3.53 [ 500.536565] lustre_kcompr_26370: compr deflate(6) in 256kB chunks took 548721 us (7 MB/s), compress ratio: 3.53 [ 501.321221] lustre_kcompr_26370: compr deflate(6) in 512kB chunks took 779266 us (5 MB/s), compress ratio: 3.54 [ 502.178635] lustre_kcompr_26370: compr deflate(6) in 1024kB chunks took 846974 us (4 MB/s), compress ratio: 3.54 [ 502.971392] lustre_kcompr_26370: compr deflate(6) in 2048kB chunks took 779312 us (5 MB/s), compress ratio: 3.54 [ 503.716908] lustre_kcompr_26370: compr deflate(6) in 4096kB chunks took 734746 us (5 MB/s), compress ratio: 3.54 [ 503.770721] lustre_kcompr_26370: decompr deflate(6) took 42775 us (26 MB/s) [ 503.778395] lustre_kcompr_26370: test_comp_compress_decompress(deflate,6) ret 0 [ 503.803712] lustre_kcompr_26370: acompr deflate(6) of 128kB chunks took 17789 us (7 MB/s), compress ratio: 3.09 [ 503.813857] lustre_kcompr_26370: adecompr deflate(6) took 1378 us (29 MB/s) [ 503.822230] lustre_kcompr_26370: test_acomp_compress_decompress(deflate,6) ret 0 [ 504.576761] lustre_kcompr_26370: compr deflate(9) in 64kB chunks took 737896 us (5 MB/s), compress ratio: 3.51 [ 505.344300] lustre_kcompr_26370: compr deflate(9) in 128kB chunks took 753313 us (5 MB/s), compress ratio: 3.53 [ 506.231513] lustre_kcompr_26370: compr deflate(9) in 256kB chunks took 875761 us (4 MB/s), compress ratio: 3.53 [ 507.079863] lustre_kcompr_26370: compr deflate(9) in 512kB chunks took 839627 us (4 MB/s), compress ratio: 3.54 [ 507.934909] lustre_kcompr_26370: compr deflate(9) in 1024kB chunks took 847135 us (4 MB/s), compress ratio: 3.54 [ 508.704858] lustre_kcompr_26370: compr deflate(9) in 2048kB chunks took 749146 us (5 MB/s), compress ratio: 3.54 [ 509.485411] lustre_kcompr_26370: compr deflate(9) in 4096kB chunks took 767689 us (5 MB/s), compress ratio: 3.54 [ 509.569591] lustre_kcompr_26370: decompr deflate(9) took 60167 us (18 MB/s) [ 509.582595] lustre_kcompr_26370: test_comp_compress_decompress(deflate,9) ret 0 [ 509.626662] lustre_kcompr_26370: acompr deflate(9) of 128kB chunks took 35979 us (3 MB/s), compress ratio: 3.09 [ 509.642488] lustre_kcompr_26370: adecompr deflate(9) took 1158 us (34 MB/s) [ 509.660046] lustre_kcompr_26370: test_acomp_compress_decompress(deflate,9) ret 0 [ 509.800355] lustre_kcompr_26370: compr zstd(0) in 64kB chunks took 102439 us (39 MB/s), compress ratio: 4.28 [ 509.938357] lustre_kcompr_26370: compr zstd(0) in 128kB chunks took 129846 us (30 MB/s), compress ratio: 4.46 [ 510.086296] lustre_kcompr_26370: compr zstd(0) in 256kB chunks took 128007 us (31 MB/s), compress ratio: 4.61 [ 510.244882] lustre_kcompr_26370: compr zstd(0) in 512kB chunks took 149976 us (26 MB/s), compress ratio: 4.72 [ 510.431911] lustre_kcompr_26370: compr zstd(0) in 1024kB chunks took 176708 us (22 MB/s), compress ratio: 4.80 [ 510.659779] lustre_kcompr_26370: compr zstd(0) in 2048kB chunks took 212740 us (18 MB/s), compress ratio: 4.85 [ 510.817194] lustre_kcompr_26370: compr zstd(0) in 4096kB chunks took 151945 us (26 MB/s), compress ratio: 4.88 [ 510.880786] lustre_kcompr_26370: decompr zstd(0) took 42840 us (19 MB/s) [ 510.889923] lustre_kcompr_26370: test_comp_compress_decompress(zstd,0) ret 0 [ 510.916714] lustre_kcompr_26370: acompr zstd(0) of 128kB chunks took 7821 us (15 MB/s), compress ratio: 3.98 [ 510.921849] lustre_kcompr_26370: adecompr zstd(0) took 533 us (58 MB/s) [ 510.929328] lustre_kcompr_26370: test_acomp_compress_decompress(zstd,0) ret 0 [ 511.056733] lustre_kcompr_26370: compr zstd(1) in 64kB chunks took 83191 us (48 MB/s), compress ratio: 4.06 [ 511.131448] lustre_kcompr_26370: compr zstd(1) in 128kB chunks took 58127 us (68 MB/s), compress ratio: 4.20 [ 511.220680] lustre_kcompr_26370: compr zstd(1) in 256kB chunks took 78445 us (50 MB/s), compress ratio: 4.34 [ 511.280841] lustre_kcompr_26370: compr zstd(1) in 512kB chunks took 55863 us (71 MB/s), compress ratio: 4.34 [ 511.355606] lustre_kcompr_26370: compr zstd(1) in 1024kB chunks took 67296 us (59 MB/s), compress ratio: 4.37 [ 511.470343] lustre_kcompr_26370: compr zstd(1) in 2048kB chunks took 101588 us (39 MB/s), compress ratio: 4.39 [ 511.567706] lustre_kcompr_26370: compr zstd(1) in 4096kB chunks took 83942 us (47 MB/s), compress ratio: 4.40 [ 511.602238] lustre_kcompr_26370: decompr zstd(1) took 21118 us (43 MB/s) [ 511.608065] lustre_kcompr_26370: test_comp_compress_decompress(zstd,1) ret 0 [ 511.615185] lustre_kcompr_26370: acompr zstd(1) of 128kB chunks took 1987 us (62 MB/s), compress ratio: 3.73 [ 511.624778] lustre_kcompr_26370: adecompr zstd(1) took 662 us (50 MB/s) [ 511.643880] lustre_kcompr_26370: test_acomp_compress_decompress(zstd,1) ret 0 [ 513.001882] lustre_kcompr_26370: compr zstd(10) in 64kB chunks took 1344236 us (2 MB/s), compress ratio: 4.80 [ 514.707295] lustre_kcompr_26370: compr zstd(10) in 128kB chunks took 1702435 us (2 MB/s), compress ratio: 5.09 [ 517.553892] lustre_kcompr_26370: compr zstd(10) in 256kB chunks took 2838803 us (1 MB/s), compress ratio: 5.34 [ 519.475663] lustre_kcompr_26370: compr zstd(10) in 512kB chunks took 1911675 us (2 MB/s), compress ratio: 5.45 [ 521.242531] lustre_kcompr_26370: compr zstd(10) in 1024kB chunks took 1756858 us (2 MB/s), compress ratio: 5.62 [ 522.714380] lustre_kcompr_26370: compr zstd(10) in 2048kB chunks took 1465944 us (2 MB/s), compress ratio: 5.76 [ 524.953919] lustre_kcompr_26370: compr zstd(10) in 4096kB chunks took 2219391 us (1 MB/s), compress ratio: 5.89 [ 525.017503] lustre_kcompr_26370: decompr zstd(10) took 48899 us (13 MB/s) [ 525.031831] lustre_kcompr_26370: test_comp_compress_decompress(zstd,10) ret 0 [ 525.111173] lustre_kcompr_26370: acompr zstd(10) of 128kB chunks took 69044 us (1 MB/s), compress ratio: 4.46 [ 525.124478] lustre_kcompr_26370: adecompr zstd(10) took 1585 us (17 MB/s) [ 525.132568] lustre_kcompr_26370: test_acomp_compress_decompress(zstd,10) ret 0 [ 541.351550] lustre_kcompr_26370: compr zstd(15) in 64kB chunks took 16206665 us (0 MB/s), compress ratio: 4.96 [ 563.928476] lustre_kcompr_26370: compr zstd(15) in 128kB chunks took 22558101 us (0 MB/s), compress ratio: 5.28 [ 581.464590] lustre_kcompr_26370: compr zstd(15) in 256kB chunks took 17529747 us (0 MB/s), compress ratio: 5.57 [ 595.373470] lustre_kcompr_26370: compr zstd(15) in 512kB chunks took 13885320 us (0 MB/s), compress ratio: 5.83 [ 611.119639] lustre_kcompr_26370: compr zstd(15) in 1024kB chunks took 15739673 us (0 MB/s), compress ratio: 6.06 [ 629.411962] lustre_kcompr_26370: compr zstd(15) in 2048kB chunks took 18274344 us (0 MB/s), compress ratio: 6.26 [ 647.158978] lustre_kcompr_26370: compr zstd(15) in 4096kB chunks took 17738687 us (0 MB/s), compress ratio: 6.46 [ 647.238657] lustre_kcompr_26370: decompr zstd(15) took 61062 us (10 MB/s) [ 647.261110] lustre_kcompr_26370: test_comp_compress_decompress(zstd,15) ret 0 [ 647.960553] lustre_kcompr_26370: acompr zstd(15) of 128kB chunks took 677881 us (0 MB/s), compress ratio: 4.64 [ 647.971440] lustre_kcompr_26370: adecompr zstd(15) took 611 us (44 MB/s) [ 647.986416] lustre_kcompr_26370: test_acomp_compress_decompress(zstd,15) ret 0 [ 648.116404] lustre_kcompr_26370: compr zstdfast(1) in 64kB chunks took 86935 us (46 MB/s), compress ratio: 3.49 [ 648.222770] lustre_kcompr_26370: compr zstdfast(1) in 128kB chunks took 95075 us (42 MB/s), compress ratio: 3.62 [ 648.345672] lustre_kcompr_26370: compr zstdfast(1) in 256kB chunks took 106144 us (37 MB/s), compress ratio: 3.84 [ 648.477971] lustre_kcompr_26370: compr zstdfast(1) in 512kB chunks took 118938 us (33 MB/s), compress ratio: 3.73 [ 648.594287] lustre_kcompr_26370: compr zstdfast(1) in 1024kB chunks took 101210 us (39 MB/s), compress ratio: 3.76 [ 648.697350] lustre_kcompr_26370: compr zstdfast(1) in 2048kB chunks took 91741 us (43 MB/s), compress ratio: 3.77 [ 648.760559] lustre_kcompr_26370: compr zstdfast(1) in 4096kB chunks took 56731 us (70 MB/s), compress ratio: 3.78 [ 648.815397] lustre_kcompr_26370: decompr zstdfast(1) took 35829 us (29 MB/s) [ 648.835645] lustre_kcompr_26370: test_comp_compress_decompress(zstdfast,1) ret 0 [ 648.860931] lustre_kcompr_26370: acompr zstdfast(1) of 128kB chunks took 14501 us (8 MB/s), compress ratio: 3.19 [ 648.875739] lustre_kcompr_26370: adecompr zstdfast(1) took 455 us (86 MB/s) [ 648.888415] lustre_kcompr_26370: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 649.021151] lustre_kcompr_26370: compr zstdfast(5) in 64kB chunks took 101597 us (39 MB/s), compress ratio: 2.81 [ 649.164471] lustre_kcompr_26370: compr zstdfast(5) in 128kB chunks took 120291 us (33 MB/s), compress ratio: 2.93 [ 649.264227] lustre_kcompr_26370: compr zstdfast(5) in 256kB chunks took 86406 us (46 MB/s), compress ratio: 3.16 [ 649.408787] lustre_kcompr_26370: compr zstdfast(5) in 512kB chunks took 116352 us (34 MB/s), compress ratio: 3.04 [ 649.535130] lustre_kcompr_26370: compr zstdfast(5) in 1024kB chunks took 107982 us (37 MB/s), compress ratio: 3.07 [ 649.644669] lustre_kcompr_26370: compr zstdfast(5) in 2048kB chunks took 92684 us (43 MB/s), compress ratio: 3.08 [ 649.739831] lustre_kcompr_26370: compr zstdfast(5) in 4096kB chunks took 82757 us (48 MB/s), compress ratio: 3.09 [ 649.799228] lustre_kcompr_26370: decompr zstdfast(5) took 36753 us (35 MB/s) [ 649.813429] lustre_kcompr_26370: test_comp_compress_decompress(zstdfast,5) ret 0 [ 649.831610] lustre_kcompr_26370: acompr zstdfast(5) of 128kB chunks took 5345 us (23 MB/s), compress ratio: 2.56 [ 649.851393] lustre_kcompr_26370: adecompr zstdfast(5) took 1340 us (36 MB/s) [ 649.873622] lustre_kcompr_26370: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 649.988683] lustre_kcompr_26370: compr zstdfast(12) in 64kB chunks took 70438 us (56 MB/s), compress ratio: 1.43 [ 650.063553] lustre_kcompr_26370: compr zstdfast(12) in 128kB chunks took 61223 us (65 MB/s), compress ratio: 1.50 [ 650.121684] lustre_kcompr_26370: compr zstdfast(12) in 256kB chunks took 44450 us (89 MB/s), compress ratio: 1.62 [ 650.176735] lustre_kcompr_26370: compr zstdfast(12) in 512kB chunks took 44239 us (90 MB/s), compress ratio: 1.55 [ 650.235651] lustre_kcompr_26370: compr zstdfast(12) in 1024kB chunks took 46090 us (86 MB/s), compress ratio: 1.58 [ 650.323518] lustre_kcompr_26370: compr zstdfast(12) in 2048kB chunks took 73615 us (54 MB/s), compress ratio: 1.60 [ 650.378780] lustre_kcompr_26370: compr zstdfast(12) in 4096kB chunks took 45309 us (88 MB/s), compress ratio: 1.60 [ 650.440755] lustre_kcompr_26370: decompr zstdfast(12) took 31122 us (80 MB/s) [ 650.454456] lustre_kcompr_26370: test_comp_compress_decompress(zstdfast,12) ret 0 [ 650.470929] lustre_kcompr_26370: acompr zstdfast(12) of 128kB chunks took 1303 us (95 MB/s), compress ratio: 1.37 [ 650.482696] lustre_kcompr_26370: adecompr zstdfast(12) took 1168 us (78 MB/s) [ 650.538283] lustre_kcompr_26370: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 650.592714] lustre_kcompr_26370: compr zstdfast(15) in 64kB chunks took 27632 us (144 MB/s), compress ratio: 1.12 [ 650.631625] lustre_kcompr_26370: compr zstdfast(15) in 128kB chunks took 28847 us (138 MB/s), compress ratio: 1.16 [ 650.683419] lustre_kcompr_26370: compr zstdfast(15) in 256kB chunks took 33931 us (117 MB/s), compress ratio: 1.22 [ 650.748373] lustre_kcompr_26370: compr zstdfast(15) in 512kB chunks took 38949 us (102 MB/s), compress ratio: 1.20 [ 650.807458] lustre_kcompr_26370: compr zstdfast(15) in 1024kB chunks took 50520 us (79 MB/s), compress ratio: 1.22 [ 650.848389] lustre_kcompr_26370: compr zstdfast(15) in 2048kB chunks took 27469 us (145 MB/s), compress ratio: 1.23 [ 650.892326] lustre_kcompr_26370: compr zstdfast(15) in 4096kB chunks took 35201 us (113 MB/s), compress ratio: 1.23 [ 650.923881] lustre_kcompr_26370: decompr zstdfast(15) took 8886 us (364 MB/s) [ 650.934480] lustre_kcompr_26370: test_comp_compress_decompress(zstdfast,15) ret 0 [ 650.947066] lustre_kcompr_26370: acompr zstdfast(15) of 128kB chunks took 393 us (318 MB/s), compress ratio: 1.08 [ 650.954529] lustre_kcompr_26370: adecompr zstdfast(15) took 193 us (598 MB/s) [ 650.972856] lustre_kcompr_26370: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 650.985634] lustre_kcompr_26370: SUCCESS [ 658.637308] lustre_kcompr_19481: ***** [ 658.650970] lustre_kcompr_19481: (de)compression test on provided file /tmp/f84.sanity [ 658.657248] lustre_kcompr_19481: ***** [ 658.754461] lustre_kcompr_19481: compr lz4(1) in 64kB chunks took 51735 us (77 MB/s), compress ratio: 2.45 [ 658.829418] lustre_kcompr_19481: compr lz4(1) in 128kB chunks took 50240 us (79 MB/s), compress ratio: 2.39 [ 658.891979] lustre_kcompr_19481: compr lz4(1) in 256kB chunks took 48065 us (83 MB/s), compress ratio: 2.39 [ 658.943282] lustre_kcompr_19481: compr lz4(1) in 512kB chunks took 39883 us (100 MB/s), compress ratio: 2.39 [ 659.020667] lustre_kcompr_19481: compr lz4(1) in 1024kB chunks took 56224 us (71 MB/s), compress ratio: 2.39 [ 659.081923] lustre_kcompr_19481: compr lz4(1) in 2048kB chunks took 46025 us (86 MB/s), compress ratio: 2.39 [ 659.136323] lustre_kcompr_19481: compr lz4(1) in 4096kB chunks took 41170 us (97 MB/s), compress ratio: 2.39 [ 659.160648] lustre_kcompr_19481: decompr lz4(1) took 6704 us (248 MB/s) [ 659.169230] lustre_kcompr_19481: test_comp_compress_decompress(lz4,1) ret 0 [ 659.186169] lustre_kcompr_19481: acompr lz4(1) of 128kB chunks took 317 us (394 MB/s), compress ratio: 15.67 [ 659.200168] lustre_kcompr_19481: adecompr lz4(1) took 272 us (29 MB/s) [ 659.217361] lustre_kcompr_19481: test_acomp_compress_decompress(lz4,1) ret 0 [ 659.273214] lustre_kcompr_19481: compr lz4(4) in 64kB chunks took 21489 us (186 MB/s), compress ratio: 2.36 [ 659.309254] lustre_kcompr_19481: compr lz4(4) in 128kB chunks took 23644 us (169 MB/s), compress ratio: 2.35 [ 659.350157] lustre_kcompr_19481: compr lz4(4) in 256kB chunks took 31333 us (127 MB/s), compress ratio: 2.35 [ 659.385923] lustre_kcompr_19481: compr lz4(4) in 512kB chunks took 25879 us (154 MB/s), compress ratio: 2.35 [ 659.415238] lustre_kcompr_19481: compr lz4(4) in 1024kB chunks took 23908 us (167 MB/s), compress ratio: 2.35 [ 659.452156] lustre_kcompr_19481: compr lz4(4) in 2048kB chunks took 25637 us (156 MB/s), compress ratio: 2.35 [ 659.484453] lustre_kcompr_19481: compr lz4(4) in 4096kB chunks took 23475 us (170 MB/s), compress ratio: 2.35 [ 659.507501] lustre_kcompr_19481: decompr lz4(4) took 2678 us (634 MB/s) [ 659.514606] lustre_kcompr_19481: test_comp_compress_decompress(lz4,4) ret 0 [ 659.529638] lustre_kcompr_19481: acompr lz4(4) of 128kB chunks took 107 us (1168 MB/s), compress ratio: 15.30 [ 659.540472] lustre_kcompr_19481: adecompr lz4(4) took 94 us (86 MB/s) [ 659.555610] lustre_kcompr_19481: test_acomp_compress_decompress(lz4,4) ret 0 [ 659.594395] lustre_kcompr_19481: compr lz4(9) in 64kB chunks took 12882 us (310 MB/s), compress ratio: 2.32 [ 659.628541] lustre_kcompr_19481: compr lz4(9) in 128kB chunks took 18317 us (218 MB/s), compress ratio: 2.31 [ 659.658154] lustre_kcompr_19481: compr lz4(9) in 256kB chunks took 19045 us (210 MB/s), compress ratio: 2.31 [ 659.689983] lustre_kcompr_19481: compr lz4(9) in 512kB chunks took 18761 us (213 MB/s), compress ratio: 2.31 [ 659.724378] lustre_kcompr_19481: compr lz4(9) in 1024kB chunks took 20395 us (196 MB/s), compress ratio: 2.31 [ 659.753539] lustre_kcompr_19481: compr lz4(9) in 2048kB chunks took 12824 us (311 MB/s), compress ratio: 2.32 [ 659.783168] lustre_kcompr_19481: compr lz4(9) in 4096kB chunks took 19195 us (208 MB/s), compress ratio: 2.32 [ 659.812160] lustre_kcompr_19481: decompr lz4(9) took 6318 us (272 MB/s) [ 659.818467] lustre_kcompr_19481: test_comp_compress_decompress(lz4,9) ret 0 [ 659.831159] lustre_kcompr_19481: acompr lz4(9) of 128kB chunks took 2499 us (50 MB/s), compress ratio: 14.81 [ 659.846326] lustre_kcompr_19481: adecompr lz4(9) took 211 us (40 MB/s) [ 659.885302] lustre_kcompr_19481: test_acomp_compress_decompress(lz4,9) ret 0 [ 659.921749] lustre_kcompr_19481: compr lz4(15) in 64kB chunks took 9949 us (402 MB/s), compress ratio: 2.23 [ 659.959360] lustre_kcompr_19481: compr lz4(15) in 128kB chunks took 24560 us (162 MB/s), compress ratio: 2.23 [ 660.008354] lustre_kcompr_19481: compr lz4(15) in 256kB chunks took 17612 us (227 MB/s), compress ratio: 2.23 [ 660.050306] lustre_kcompr_19481: compr lz4(15) in 512kB chunks took 23681 us (168 MB/s), compress ratio: 2.23 [ 660.083554] lustre_kcompr_19481: compr lz4(15) in 1024kB chunks took 21927 us (182 MB/s), compress ratio: 2.23 [ 660.109854] lustre_kcompr_19481: compr lz4(15) in 2048kB chunks took 15190 us (263 MB/s), compress ratio: 2.23 [ 660.142355] lustre_kcompr_19481: compr lz4(15) in 4096kB chunks took 16080 us (248 MB/s), compress ratio: 2.23 [ 660.172800] lustre_kcompr_19481: decompr lz4(15) took 10564 us (169 MB/s) [ 660.182407] lustre_kcompr_19481: test_comp_compress_decompress(lz4,15) ret 0 [ 660.193840] lustre_kcompr_19481: acompr lz4(15) of 128kB chunks took 112 us (1116 MB/s), compress ratio: 14.18 [ 660.204944] lustre_kcompr_19481: adecompr lz4(15) took 158 us (55 MB/s) [ 660.236438] lustre_kcompr_19481: test_acomp_compress_decompress(lz4,15) ret 0 [ 660.548529] lustre_kcompr_19481: compr lz4hc(1) in 64kB chunks took 276603 us (14 MB/s), compress ratio: 2.54 [ 660.918130] lustre_kcompr_19481: compr lz4hc(1) in 128kB chunks took 354119 us (11 MB/s), compress ratio: 2.61 [ 661.277731] lustre_kcompr_19481: compr lz4hc(1) in 256kB chunks took 353627 us (11 MB/s), compress ratio: 2.64 [ 661.554183] lustre_kcompr_19481: compr lz4hc(1) in 512kB chunks took 271342 us (14 MB/s), compress ratio: 2.66 [ 661.764072] lustre_kcompr_19481: compr lz4hc(1) in 1024kB chunks took 205203 us (19 MB/s), compress ratio: 2.67 [ 662.133483] lustre_kcompr_19481: compr lz4hc(1) in 2048kB chunks took 360240 us (11 MB/s), compress ratio: 2.67 [ 662.532262] lustre_kcompr_19481: compr lz4hc(1) in 4096kB chunks took 388505 us (10 MB/s), compress ratio: 2.67 [ 662.569944] lustre_kcompr_19481: decompr lz4hc(1) took 5580 us (267 MB/s) [ 662.589246] lustre_kcompr_19481: test_comp_compress_decompress(lz4hc,1) ret 0 [ 662.613094] lustre_kcompr_19481: acompr lz4hc(1) of 128kB chunks took 898 us (139 MB/s), compress ratio: 15.97 [ 662.634144] lustre_kcompr_19481: adecompr lz4hc(1) took 190 us (41 MB/s) [ 662.655260] lustre_kcompr_19481: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 662.916139] lustre_kcompr_19481: compr lz4hc(3) in 64kB chunks took 226112 us (17 MB/s), compress ratio: 2.57 [ 663.274945] lustre_kcompr_19481: compr lz4hc(3) in 128kB chunks took 346835 us (11 MB/s), compress ratio: 2.64 [ 663.781508] lustre_kcompr_19481: compr lz4hc(3) in 256kB chunks took 499405 us (8 MB/s), compress ratio: 2.68 [ 664.089267] lustre_kcompr_19481: compr lz4hc(3) in 512kB chunks took 301878 us (13 MB/s), compress ratio: 2.69 [ 664.487475] lustre_kcompr_19481: compr lz4hc(3) in 1024kB chunks took 375671 us (10 MB/s), compress ratio: 2.70 [ 664.707525] lustre_kcompr_19481: compr lz4hc(3) in 2048kB chunks took 214733 us (18 MB/s), compress ratio: 2.71 [ 664.882342] lustre_kcompr_19481: compr lz4hc(3) in 4096kB chunks took 170584 us (23 MB/s), compress ratio: 2.71 [ 664.898412] lustre_kcompr_19481: decompr lz4hc(3) took 3920 us (375 MB/s) [ 664.902667] lustre_kcompr_19481: test_comp_compress_decompress(lz4hc,3) ret 0 [ 664.908533] lustre_kcompr_19481: acompr lz4hc(3) of 128kB chunks took 1200 us (104 MB/s), compress ratio: 16.00 [ 664.974199] lustre_kcompr_19481: adecompr lz4hc(3) took 242 us (32 MB/s) [ 665.032229] lustre_kcompr_19481: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 665.464563] lustre_kcompr_19481: compr lz4hc(8) in 64kB chunks took 393679 us (10 MB/s), compress ratio: 2.60 [ 665.985978] lustre_kcompr_19481: compr lz4hc(8) in 128kB chunks took 511868 us (7 MB/s), compress ratio: 2.66 [ 666.890136] lustre_kcompr_19481: compr lz4hc(8) in 256kB chunks took 892428 us (4 MB/s), compress ratio: 2.70 [ 667.788899] lustre_kcompr_19481: compr lz4hc(8) in 512kB chunks took 889543 us (4 MB/s), compress ratio: 2.71 [ 668.713902] lustre_kcompr_19481: compr lz4hc(8) in 1024kB chunks took 917369 us (4 MB/s), compress ratio: 2.72 [ 669.366935] lustre_kcompr_19481: compr lz4hc(8) in 2048kB chunks took 641900 us (6 MB/s), compress ratio: 2.73 [ 670.247302] lustre_kcompr_19481: compr lz4hc(8) in 4096kB chunks took 873920 us (4 MB/s), compress ratio: 2.73 [ 670.278218] lustre_kcompr_19481: decompr lz4hc(8) took 10476 us (139 MB/s) [ 670.282502] lustre_kcompr_19481: test_comp_compress_decompress(lz4hc,8) ret 0 [ 670.310140] lustre_kcompr_19481: acompr lz4hc(8) of 128kB chunks took 9246 us (13 MB/s), compress ratio: 16.17 [ 670.318929] lustre_kcompr_19481: adecompr lz4hc(8) took 355 us (21 MB/s) [ 670.332793] lustre_kcompr_19481: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 680.604511] lustre_kcompr_19481: compr lz4hc(15) in 64kB chunks took 10242865 us (0 MB/s), compress ratio: 2.61 [ 693.362864] lustre_kcompr_19481: compr lz4hc(15) in 128kB chunks took 12741871 us (0 MB/s), compress ratio: 2.67 [ 706.550485] lustre_kcompr_19481: compr lz4hc(15) in 256kB chunks took 13165804 us (0 MB/s), compress ratio: 2.71 [ 720.628477] lustre_kcompr_19481: compr lz4hc(15) in 512kB chunks took 14070874 us (0 MB/s), compress ratio: 2.72 [ 738.069721] lustre_kcompr_19481: compr lz4hc(15) in 1024kB chunks took 17432791 us (0 MB/s), compress ratio: 2.73 [ 755.304313] lustre_kcompr_19481: compr lz4hc(15) in 2048kB chunks took 17220730 us (0 MB/s), compress ratio: 2.74 [ 771.026628] lustre_kcompr_19481: compr lz4hc(15) in 4096kB chunks took 15719517 us (0 MB/s), compress ratio: 2.74 [ 771.048198] lustre_kcompr_19481: decompr lz4hc(15) took 6022 us (241 MB/s) [ 771.058256] lustre_kcompr_19481: test_comp_compress_decompress(lz4hc,15) ret 0 [ 771.098401] lustre_kcompr_19481: acompr lz4hc(15) of 128kB chunks took 34303 us (3 MB/s), compress ratio: 16.30 [ 771.108560] lustre_kcompr_19481: adecompr lz4hc(15) took 183 us (41 MB/s) [ 771.114154] lustre_kcompr_19481: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 771.149702] lustre_kcompr_19481: compr lzo(-1) in 64kB chunks took 29855 us (133 MB/s), compress ratio: 2.35 [ 771.192445] lustre_kcompr_19481: compr lzo(-1) in 128kB chunks took 33902 us (117 MB/s), compress ratio: 2.35 [ 771.234464] lustre_kcompr_19481: compr lzo(-1) in 256kB chunks took 32703 us (122 MB/s), compress ratio: 2.35 [ 771.262487] lustre_kcompr_19481: compr lzo(-1) in 512kB chunks took 20721 us (193 MB/s), compress ratio: 2.36 [ 771.310239] lustre_kcompr_19481: compr lzo(-1) in 1024kB chunks took 37766 us (105 MB/s), compress ratio: 2.36 [ 771.367578] lustre_kcompr_19481: compr lzo(-1) in 2048kB chunks took 42142 us (94 MB/s), compress ratio: 2.36 [ 771.408506] lustre_kcompr_19481: compr lzo(-1) in 4096kB chunks took 34577 us (115 MB/s), compress ratio: 2.36 [ 771.428511] lustre_kcompr_19481: decompr lzo(-1) took 6736 us (251 MB/s) [ 771.433446] lustre_kcompr_19481: test_comp_compress_decompress(lzo,-1) ret 0 [ 771.441934] lustre_kcompr_19481: acompr lzo(-1) of 128kB chunks took 394 us (317 MB/s), compress ratio: 15.45 [ 771.450908] lustre_kcompr_19481: adecompr lzo(-1) took 252 us (32 MB/s) [ 771.465473] lustre_kcompr_19481: test_acomp_compress_decompress(lzo,-1) ret 0 [ 771.885943] lustre_kcompr_19481: compr deflate(1) in 64kB chunks took 405144 us (9 MB/s), compress ratio: 3.27 [ 772.197081] lustre_kcompr_19481: compr deflate(1) in 128kB chunks took 307475 us (13 MB/s), compress ratio: 3.28 [ 772.697272] lustre_kcompr_19481: compr deflate(1) in 256kB chunks took 494889 us (8 MB/s), compress ratio: 3.28 [ 773.527993] lustre_kcompr_19481: compr deflate(1) in 512kB chunks took 820775 us (4 MB/s), compress ratio: 3.28 [ 773.929915] lustre_kcompr_19481: compr deflate(1) in 1024kB chunks took 392992 us (10 MB/s), compress ratio: 3.28 [ 774.396487] lustre_kcompr_19481: compr deflate(1) in 2048kB chunks took 462004 us (8 MB/s), compress ratio: 3.28 [ 775.081544] lustre_kcompr_19481: compr deflate(1) in 4096kB chunks took 680313 us (5 MB/s), compress ratio: 3.28 [ 775.175636] lustre_kcompr_19481: decompr deflate(1) took 70792 us (17 MB/s) [ 775.196180] lustre_kcompr_19481: test_comp_compress_decompress(deflate,1) ret 0 [ 775.229484] lustre_kcompr_19481: acompr deflate(1) of 128kB chunks took 20619 us (6 MB/s), compress ratio: 21.43 [ 775.241485] lustre_kcompr_19481: adecompr deflate(1) took 593 us (9 MB/s) [ 775.273338] lustre_kcompr_19481: test_acomp_compress_decompress(deflate,1) ret 0 [ 775.980257] lustre_kcompr_19481: compr deflate(6) in 64kB chunks took 674963 us (5 MB/s), compress ratio: 3.27 [ 776.686637] lustre_kcompr_19481: compr deflate(6) in 128kB chunks took 700912 us (5 MB/s), compress ratio: 3.28 [ 777.320760] lustre_kcompr_19481: compr deflate(6) in 256kB chunks took 622629 us (6 MB/s), compress ratio: 3.28 [ 777.842224] lustre_kcompr_19481: compr deflate(6) in 512kB chunks took 515808 us (7 MB/s), compress ratio: 3.28 [ 778.233878] lustre_kcompr_19481: compr deflate(6) in 1024kB chunks took 386109 us (10 MB/s), compress ratio: 3.28 [ 778.774628] lustre_kcompr_19481: compr deflate(6) in 2048kB chunks took 535633 us (7 MB/s), compress ratio: 3.28 [ 779.132422] lustre_kcompr_19481: compr deflate(6) in 4096kB chunks took 353258 us (11 MB/s), compress ratio: 3.28 [ 779.168881] lustre_kcompr_19481: decompr deflate(6) took 27249 us (44 MB/s) [ 779.173250] lustre_kcompr_19481: test_comp_compress_decompress(deflate,6) ret 0 [ 779.187725] lustre_kcompr_19481: acompr deflate(6) of 128kB chunks took 10077 us (12 MB/s), compress ratio: 21.43 [ 779.193849] lustre_kcompr_19481: adecompr deflate(6) took 344 us (16 MB/s) [ 779.199803] lustre_kcompr_19481: test_acomp_compress_decompress(deflate,6) ret 0 [ 779.769503] lustre_kcompr_19481: compr deflate(9) in 64kB chunks took 560046 us (7 MB/s), compress ratio: 3.27 [ 780.383326] lustre_kcompr_19481: compr deflate(9) in 128kB chunks took 606882 us (6 MB/s), compress ratio: 3.28 [ 780.795766] lustre_kcompr_19481: compr deflate(9) in 256kB chunks took 407809 us (9 MB/s), compress ratio: 3.28 [ 781.282260] lustre_kcompr_19481: compr deflate(9) in 512kB chunks took 477887 us (8 MB/s), compress ratio: 3.28 [ 782.181308] lustre_kcompr_19481: compr deflate(9) in 1024kB chunks took 873388 us (4 MB/s), compress ratio: 3.28 [ 782.662822] lustre_kcompr_19481: compr deflate(9) in 2048kB chunks took 467419 us (8 MB/s), compress ratio: 3.28 [ 783.338326] lustre_kcompr_19481: compr deflate(9) in 4096kB chunks took 671295 us (5 MB/s), compress ratio: 3.28 [ 783.388643] lustre_kcompr_19481: decompr deflate(9) took 37997 us (32 MB/s) [ 783.394881] lustre_kcompr_19481: test_comp_compress_decompress(deflate,9) ret 0 [ 783.411263] lustre_kcompr_19481: acompr deflate(9) of 128kB chunks took 11419 us (10 MB/s), compress ratio: 21.43 [ 783.416767] lustre_kcompr_19481: adecompr deflate(9) took 375 us (15 MB/s) [ 783.425233] lustre_kcompr_19481: test_acomp_compress_decompress(deflate,9) ret 0 [ 783.530358] lustre_kcompr_19481: compr zstd(0) in 64kB chunks took 93543 us (42 MB/s), compress ratio: 3.28 [ 783.627639] lustre_kcompr_19481: compr zstd(0) in 128kB chunks took 91911 us (43 MB/s), compress ratio: 3.26 [ 783.797106] lustre_kcompr_19481: compr zstd(0) in 256kB chunks took 163599 us (24 MB/s), compress ratio: 3.31 [ 784.036397] lustre_kcompr_19481: compr zstd(0) in 512kB chunks took 234412 us (17 MB/s), compress ratio: 3.32 [ 784.296867] lustre_kcompr_19481: compr zstd(0) in 1024kB chunks took 249654 us (16 MB/s), compress ratio: 3.32 [ 784.728248] lustre_kcompr_19481: compr zstd(0) in 2048kB chunks took 423786 us (9 MB/s), compress ratio: 3.33 [ 785.294487] lustre_kcompr_19481: compr zstd(0) in 4096kB chunks took 543558 us (7 MB/s), compress ratio: 3.33 [ 785.349692] lustre_kcompr_19481: decompr zstd(0) took 33599 us (35 MB/s) [ 785.365398] lustre_kcompr_19481: test_comp_compress_decompress(zstd,0) ret 0 [ 785.386101] lustre_kcompr_19481: acompr zstd(0) of 128kB chunks took 3017 us (41 MB/s), compress ratio: 22.64 [ 785.398276] lustre_kcompr_19481: adecompr zstd(0) took 557 us (9 MB/s) [ 785.429569] lustre_kcompr_19481: test_acomp_compress_decompress(zstd,0) ret 0 [ 785.523513] lustre_kcompr_19481: compr zstd(1) in 64kB chunks took 74010 us (54 MB/s), compress ratio: 3.22 [ 785.595855] lustre_kcompr_19481: compr zstd(1) in 128kB chunks took 59845 us (66 MB/s), compress ratio: 3.18 [ 785.677939] lustre_kcompr_19481: compr zstd(1) in 256kB chunks took 75541 us (52 MB/s), compress ratio: 3.19 [ 785.803067] lustre_kcompr_19481: compr zstd(1) in 512kB chunks took 118747 us (33 MB/s), compress ratio: 3.19 [ 785.875397] lustre_kcompr_19481: compr zstd(1) in 1024kB chunks took 62954 us (63 MB/s), compress ratio: 3.19 [ 785.977071] lustre_kcompr_19481: compr zstd(1) in 2048kB chunks took 92721 us (43 MB/s), compress ratio: 3.19 [ 786.069779] lustre_kcompr_19481: compr zstd(1) in 4096kB chunks took 80127 us (49 MB/s), compress ratio: 3.19 [ 786.116255] lustre_kcompr_19481: decompr zstd(1) took 30492 us (41 MB/s) [ 786.125795] lustre_kcompr_19481: test_comp_compress_decompress(zstd,1) ret 0 [ 786.143309] lustre_kcompr_19481: acompr zstd(1) of 128kB chunks took 335 us (373 MB/s), compress ratio: 22.79 [ 786.150818] lustre_kcompr_19481: adecompr zstd(1) took 183 us (29 MB/s) [ 786.176823] lustre_kcompr_19481: test_acomp_compress_decompress(zstd,1) ret 0 [ 787.319094] lustre_kcompr_19481: compr zstd(10) in 64kB chunks took 1099521 us (3 MB/s), compress ratio: 3.33 [ 788.870408] lustre_kcompr_19481: compr zstd(10) in 128kB chunks took 1529965 us (2 MB/s), compress ratio: 3.33 [ 789.878404] lustre_kcompr_19481: compr zstd(10) in 256kB chunks took 999744 us (4 MB/s), compress ratio: 3.37 [ 791.259699] lustre_kcompr_19481: compr zstd(10) in 512kB chunks took 1372515 us (2 MB/s), compress ratio: 3.40 [ 792.428747] lustre_kcompr_19481: compr zstd(10) in 1024kB chunks took 1162183 us (3 MB/s), compress ratio: 3.42 [ 793.924288] lustre_kcompr_19481: compr zstd(10) in 2048kB chunks took 1486821 us (2 MB/s), compress ratio: 3.46 [ 795.549459] lustre_kcompr_19481: compr zstd(10) in 4096kB chunks took 1616589 us (2 MB/s), compress ratio: 3.50 [ 795.644719] lustre_kcompr_19481: decompr zstd(10) took 69953 us (16 MB/s) [ 795.657978] lustre_kcompr_19481: test_comp_compress_decompress(zstd,10) ret 0 [ 795.671474] lustre_kcompr_19481: acompr zstd(10) of 128kB chunks took 3911 us (31 MB/s), compress ratio: 22.78 [ 795.685460] lustre_kcompr_19481: adecompr zstd(10) took 274 us (20 MB/s) [ 795.735668] lustre_kcompr_19481: test_acomp_compress_decompress(zstd,10) ret 0 [ 805.616989] lustre_kcompr_19481: compr zstd(15) in 64kB chunks took 9851697 us (0 MB/s), compress ratio: 3.36 [ 816.907432] lustre_kcompr_19481: compr zstd(15) in 128kB chunks took 11275493 us (0 MB/s), compress ratio: 3.39 [ 824.678776] lustre_kcompr_19481: compr zstd(15) in 256kB chunks took 7765874 us (0 MB/s), compress ratio: 3.40 [ 831.317444] lustre_kcompr_19481: compr zstd(15) in 512kB chunks took 6632964 us (0 MB/s), compress ratio: 3.42 [ 837.834187] lustre_kcompr_19481: compr zstd(15) in 1024kB chunks took 6501456 us (0 MB/s), compress ratio: 3.43 [ 843.131389] lustre_kcompr_19481: compr zstd(15) in 2048kB chunks took 5285136 us (0 MB/s), compress ratio: 3.48 [ 848.195021] lustre_kcompr_19481: compr zstd(15) in 4096kB chunks took 5059345 us (0 MB/s), compress ratio: 3.56 [ 848.276220] lustre_kcompr_19481: decompr zstd(15) took 60786 us (18 MB/s) [ 848.283796] lustre_kcompr_19481: test_comp_compress_decompress(zstd,15) ret 0 [ 848.350602] lustre_kcompr_19481: acompr zstd(15) of 128kB chunks took 58895 us (2 MB/s), compress ratio: 23.92 [ 848.368394] lustre_kcompr_19481: adecompr zstd(15) took 188 us (27 MB/s) [ 848.389411] lustre_kcompr_19481: test_acomp_compress_decompress(zstd,15) ret 0 [ 848.488771] lustre_kcompr_19481: compr zstdfast(1) in 64kB chunks took 70431 us (56 MB/s), compress ratio: 2.47 [ 848.558179] lustre_kcompr_19481: compr zstdfast(1) in 128kB chunks took 57622 us (69 MB/s), compress ratio: 2.48 [ 848.607798] lustre_kcompr_19481: compr zstdfast(1) in 256kB chunks took 41923 us (95 MB/s), compress ratio: 2.53 [ 848.700459] lustre_kcompr_19481: compr zstdfast(1) in 512kB chunks took 77771 us (51 MB/s), compress ratio: 2.42 [ 848.756450] lustre_kcompr_19481: compr zstdfast(1) in 1024kB chunks took 45683 us (87 MB/s), compress ratio: 2.42 [ 848.815287] lustre_kcompr_19481: compr zstdfast(1) in 2048kB chunks took 45760 us (87 MB/s), compress ratio: 2.42 [ 848.854600] lustre_kcompr_19481: compr zstdfast(1) in 4096kB chunks took 32734 us (122 MB/s), compress ratio: 2.42 [ 848.882767] lustre_kcompr_19481: decompr zstdfast(1) took 7202 us (229 MB/s) [ 848.907463] lustre_kcompr_19481: test_comp_compress_decompress(zstdfast,1) ret 0 [ 848.913843] lustre_kcompr_19481: acompr zstdfast(1) of 128kB chunks took 243 us (514 MB/s), compress ratio: 17.28 [ 848.925799] lustre_kcompr_19481: adecompr zstdfast(1) took 124 us (58 MB/s) [ 848.948513] lustre_kcompr_19481: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 849.023773] lustre_kcompr_19481: compr zstdfast(5) in 64kB chunks took 36760 us (108 MB/s), compress ratio: 2.38 [ 849.047738] lustre_kcompr_19481: compr zstdfast(5) in 128kB chunks took 18245 us (219 MB/s), compress ratio: 2.38 [ 849.098764] lustre_kcompr_19481: compr zstdfast(5) in 256kB chunks took 44205 us (90 MB/s), compress ratio: 2.40 [ 849.148772] lustre_kcompr_19481: compr zstdfast(5) in 512kB chunks took 30565 us (130 MB/s), compress ratio: 2.36 [ 849.173242] lustre_kcompr_19481: compr zstdfast(5) in 1024kB chunks took 17261 us (231 MB/s), compress ratio: 2.36 [ 849.195559] lustre_kcompr_19481: compr zstdfast(5) in 2048kB chunks took 16077 us (248 MB/s), compress ratio: 2.36 [ 849.220193] lustre_kcompr_19481: compr zstdfast(5) in 4096kB chunks took 18686 us (214 MB/s), compress ratio: 2.36 [ 849.242860] lustre_kcompr_19481: decompr zstdfast(5) took 4851 us (347 MB/s) [ 849.250654] lustre_kcompr_19481: test_comp_compress_decompress(zstdfast,5) ret 0 [ 849.258172] lustre_kcompr_19481: acompr zstdfast(5) of 128kB chunks took 239 us (523 MB/s), compress ratio: 16.12 [ 849.264390] lustre_kcompr_19481: adecompr zstdfast(5) took 341 us (22 MB/s) [ 849.273332] lustre_kcompr_19481: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 849.302783] lustre_kcompr_19481: compr zstdfast(12) in 64kB chunks took 7789 us (513 MB/s), compress ratio: 2.07 [ 849.323931] lustre_kcompr_19481: compr zstdfast(12) in 128kB chunks took 10076 us (396 MB/s), compress ratio: 2.07 [ 849.336121] lustre_kcompr_19481: compr zstdfast(12) in 256kB chunks took 5980 us (668 MB/s), compress ratio: 2.08 [ 849.347334] lustre_kcompr_19481: compr zstdfast(12) in 512kB chunks took 6513 us (614 MB/s), compress ratio: 2.07 [ 849.359367] lustre_kcompr_19481: compr zstdfast(12) in 1024kB chunks took 8626 us (463 MB/s), compress ratio: 2.07 [ 849.380645] lustre_kcompr_19481: compr zstdfast(12) in 2048kB chunks took 16162 us (247 MB/s), compress ratio: 2.07 [ 849.415857] lustre_kcompr_19481: compr zstdfast(12) in 4096kB chunks took 22608 us (176 MB/s), compress ratio: 2.08 [ 849.459232] lustre_kcompr_19481: decompr zstdfast(12) took 10809 us (177 MB/s) [ 849.479893] lustre_kcompr_19481: test_comp_compress_decompress(zstdfast,12) ret 0 [ 849.506311] lustre_kcompr_19481: acompr zstdfast(12) of 128kB chunks took 5491 us (22 MB/s), compress ratio: 13.13 [ 849.516146] lustre_kcompr_19481: adecompr zstdfast(12) took 130 us (73 MB/s) [ 849.543325] lustre_kcompr_19481: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 849.576413] lustre_kcompr_19481: compr zstdfast(15) in 64kB chunks took 12341 us (324 MB/s), compress ratio: 1.82 [ 849.602515] lustre_kcompr_19481: compr zstdfast(15) in 128kB chunks took 6831 us (585 MB/s), compress ratio: 1.83 [ 849.617614] lustre_kcompr_19481: compr zstdfast(15) in 256kB chunks took 10121 us (395 MB/s), compress ratio: 1.83 [ 849.628724] lustre_kcompr_19481: compr zstdfast(15) in 512kB chunks took 5397 us (741 MB/s), compress ratio: 1.83 [ 849.641197] lustre_kcompr_19481: compr zstdfast(15) in 1024kB chunks took 6244 us (640 MB/s), compress ratio: 1.83 [ 849.662637] lustre_kcompr_19481: compr zstdfast(15) in 2048kB chunks took 15213 us (262 MB/s), compress ratio: 1.83 [ 849.683365] lustre_kcompr_19481: compr zstdfast(15) in 4096kB chunks took 9620 us (415 MB/s), compress ratio: 1.84 [ 849.718182] lustre_kcompr_19481: decompr zstdfast(15) took 7115 us (305 MB/s) [ 849.741806] lustre_kcompr_19481: test_comp_compress_decompress(zstdfast,15) ret 0 [ 849.750577] lustre_kcompr_19481: acompr zstdfast(15) of 128kB chunks took 168 us (744 MB/s), compress ratio: 10.73 [ 849.758399] lustre_kcompr_19481: adecompr zstdfast(15) took 182 us (63 MB/s) [ 849.765754] lustre_kcompr_19481: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 849.770263] lustre_kcompr_19481: SUCCESS [ 875.119362] Lustre: DEBUG MARKER: == sanity test complete, duration 531 sec ================ 13:03:31 (1789059811) [ 877.371265] Lustre: DEBUG MARKER: === sanity: start cleanup 13:03:33 (1789059813) === [ 881.686956] Lustre: DEBUG MARKER: === sanity: finish cleanup 13:03:37 (1789059817) === [ 884.529232] LustreError: 13342:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8897507bb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 884.584283] Lustre: Unmounted lustre-client [ 929.905522] Key type lgssc unregistered [ 930.243494] LNet: 13936:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 930.256558] LNetError: 13936:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 930.281434] LNet: Removed LNI 192.168.202.31@tcp [ 931.483241] Key type .llcrypt unregistered [ 931.486591] Key type ._llcrypt unregistered