[ 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 437354635 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 0x1465a2000-0x1465ccfff] [ 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, 524592K 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.001013] APIC: Switch to symmetric I/O mode setup [ 0.003194] x2apic enabled [ 0.004009] Switched APIC routing to physical x2apic. [ 0.005019] kvm-guest: setup PV IPIs [ 0.008557] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010011] pid_max: default: 32768 minimum: 301 [ 0.011183] LSM: Security Framework initializing [ 0.012080] Yama: becoming mindful. [ 0.013063] SELinux: Initializing. [ 0.014061] *** VALIDATE selinux *** [ 0.023059] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028560] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029164] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030111] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031122] *** VALIDATE tmpfs *** [ 0.032415] *** VALIDATE proc *** [ 0.034024] *** VALIDATE cgroup *** [ 0.035010] *** VALIDATE cgroup2 *** [ 0.036260] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037161] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039030] Spectre V2 : User space: Vulnerable [ 0.040006] Speculative Store Bypass: Vulnerable [ 0.042992] debug: unmapping init [mem 0xffffffff95659000-0xffffffff95660fff] [ 0.045393] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046561] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047023] ... version: 2 [ 0.047942] ... bit width: 48 [ 0.048013] ... generic registers: 4 [ 0.049010] ... value mask: 0000ffffffffffff [ 0.050015] ... max period: 00007fffffffffff [ 0.051014] ... fixed-purpose events: 3 [ 0.052013] ... event mask: 000000070000000f [ 0.053236] rcu: Hierarchical SRCU implementation. [ 0.055404] smp: Bringing up secondary CPUs ... [ 0.056585] x86: Booting SMP configuration: [ 0.057026] .... node #0, CPUs: #1 #2 #3 [ 0.060076] smp: Brought up 1 node, 4 CPUs [ 0.062014] smpboot: Max logical packages: 1 [ 0.063019] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.153533] node 0 deferred pages initialised in 88ms [ 0.156614] devtmpfs: initialized [ 0.158285] x86/mm: Memory block size: 128MB [ 0.162324] gcov: version magic: 0x41383552 [ 0.165236] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.168092] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.170301] pinctrl core: initialized pinctrl subsystem [ 0.172172] [ 0.172649] ************************************************************* [ 0.174012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.176009] ** ** [ 0.178012] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.180012] ** ** [ 0.182010] ** This means that this kernel is built to expose internal ** [ 0.184013] ** IOMMU data structures, which may compromise security on ** [ 0.185009] ** your system. ** [ 0.187013] ** ** [ 0.189014] ** If you see this message and you are not debugging the ** [ 0.191021] ** kernel, report this immediately to your vendor! ** [ 0.194024] ** ** [ 0.196010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.198014] ************************************************************* [ 0.201595] NET: Registered protocol family 16 [ 0.203439] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.207078] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.210062] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.213665] cpuidle: using governor menu [ 0.214674] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.216500] PCI: Using configuration type 1 for base access [ 0.219143] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.226159] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.229051] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.232084] cryptd: max_cpu_qlen set to 1000 [ 0.235168] ACPI: Added _OSI(Module Device) [ 0.236010] ACPI: Added _OSI(Processor Device) [ 0.236922] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.237010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.241000] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.245393] ACPI: Interpreter enabled [ 0.247081] ACPI: PM: (supports S0 S3 S4 S5) [ 0.248011] ACPI: Using IOAPIC for interrupt routing [ 0.250153] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.253452] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.261928] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.264045] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.266017] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.269080] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.275273] acpiphp: Slot [2] registered [ 0.276234] acpiphp: Slot [5] registered [ 0.277131] acpiphp: Slot [6] registered [ 0.279149] acpiphp: Slot [3] registered [ 0.279924] acpiphp: Slot [4] registered [ 0.280055] acpiphp: Slot [7] registered [ 0.280858] acpiphp: Slot [8] registered [ 0.282140] acpiphp: Slot [9] registered [ 0.283082] acpiphp: Slot [10] registered [ 0.285101] acpiphp: Slot [11] registered [ 0.286097] acpiphp: Slot [12] registered [ 0.288092] acpiphp: Slot [13] registered [ 0.289107] acpiphp: Slot [14] registered [ 0.290119] acpiphp: Slot [15] registered [ 0.292122] acpiphp: Slot [16] registered [ 0.293134] acpiphp: Slot [17] registered [ 0.295146] acpiphp: Slot [18] registered [ 0.296100] acpiphp: Slot [19] registered [ 0.296928] acpiphp: Slot [20] registered [ 0.298067] acpiphp: Slot [21] registered [ 0.299109] acpiphp: Slot [22] registered [ 0.300089] acpiphp: Slot [23] registered [ 0.302161] acpiphp: Slot [24] registered [ 0.303073] acpiphp: Slot [25] registered [ 0.304097] acpiphp: Slot [26] registered [ 0.306094] acpiphp: Slot [27] registered [ 0.307115] acpiphp: Slot [28] registered [ 0.308088] acpiphp: Slot [29] registered [ 0.309117] acpiphp: Slot [30] registered [ 0.310060] acpiphp: Slot [31] registered [ 0.310807] PCI host bridge to bus 0000:00 [ 0.312019] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.314018] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.315015] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.317031] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.320027] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.323023] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.325171] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.327926] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.331426] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.338690] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.343062] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.345017] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.347021] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.349018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.351824] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.355297] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.357043] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.359651] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.363018] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.373013] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.377014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.381805] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.390015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.394015] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.403014] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.410037] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.416018] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.426016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.439029] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.449079] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.450374] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.452393] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.455366] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.457246] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.461250] iommu: Default domain type: Passthrough [ 0.463502] SCSI subsystem initialized [ 0.465167] ACPI: bus type USB registered [ 0.467120] usbcore: registered new interface driver usbfs [ 0.469081] usbcore: registered new interface driver hub [ 0.470086] usbcore: registered new device driver usb [ 0.472196] pps_core: LinuxPPS API ver. 1 registered [ 0.474012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.478085] PTP clock support registered [ 0.480100] EDAC MC: Ver: 3.0.0 [ 0.482157] PCI: Using ACPI for IRQ routing [ 0.483784] NetLabel: Initializing [ 0.486015] NetLabel: domain hash size = 128 [ 0.487009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.490090] NetLabel: unlabeled traffic allowed by default [ 0.492152] vgaarb: loaded [ 0.494268] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.495007] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.499011] clocksource: Switched to clocksource kvm-clock [ 0.592079] VFS: Disk quotas dquot_6.6.0 [ 0.593437] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.595191] *** VALIDATE ramfs *** [ 0.595963] *** VALIDATE hugetlbfs *** [ 0.597570] pnp: PnP ACPI init [ 0.599419] pnp: PnP ACPI: found 6 devices [ 0.616493] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.619779] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.621883] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.623761] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.625986] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.628161] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.630875] NET: Registered protocol family 2 [ 0.633257] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.637760] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.641699] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.646748] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.650848] TCP: Hash tables configured (established 65536 bind 65536) [ 0.652796] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.654803] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.656593] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.658518] NET: Registered protocol family 1 [ 0.660052] RPC: Registered named UNIX socket transport module. [ 0.661149] RPC: Registered udp transport module. [ 0.662153] RPC: Registered tcp transport module. [ 0.663157] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.664657] NET: Registered protocol family 44 [ 0.666113] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.668467] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.669800] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.671094] PCI: CLS 0 bytes, default 64 [ 0.671974] Unpacking initramfs... [ 2.052817] debug: unmapping init [mem 0xffff94003cc64000-0xffff94003ffcffff] [ 2.056874] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.058912] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.061747] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.530645] Initialise system trusted keyrings [ 2.532131] Key type blacklist registered [ 2.533272] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.543816] zbud: loaded [ 2.547134] *** VALIDATE nfs *** [ 2.547885] *** VALIDATE nfs4 *** [ 2.550031] pstore: using deflate compression [ 2.555874] Platform Keyring initialized [ 2.657474] NET: Registered protocol family 38 [ 2.659118] Key type asymmetric registered [ 2.660430] Asymmetric key parser 'x509' registered [ 2.661887] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.664993] io scheduler mq-deadline registered [ 2.666479] io scheduler kyber registered [ 2.668488] io scheduler bfq registered [ 2.670258] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.673627] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.675956] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.678869] ACPI: Power Button [PWRF] [ 2.682539] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.686862] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.693665] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.720767] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.747799] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.751768] Non-volatile memory driver v1.3 [ 2.753488] Linux agpgart interface v0.103 [ 2.778794] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 2.780732] vda: detected capacity change from 0 to 73097216 [ 2.793131] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.794861] vdb: detected capacity change from 0 to 1073741824 [ 2.799396] libphy: Fixed MDIO Bus: probed [ 2.807890] usbcore: registered new interface driver usbserial_generic [ 2.810434] usbserial: USB Serial support registered for generic [ 2.812344] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.816280] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.817572] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.819427] mousedev: PS/2 mouse device common for all mice [ 2.821305] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.823299] rtc_cmos 00:05: RTC can wake from S4 [ 2.826678] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.830169] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.834243] rtc_cmos 00:05: registered as rtc0 [ 2.837259] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.839227] intel_pstate: CPU model not supported [ 2.841570] hid: raw HID events driver (C) Jiri Kosina [ 2.843118] usbcore: registered new interface driver usbhid [ 2.844682] usbhid: USB HID core driver [ 2.846057] drop_monitor: Initializing network drop monitor service [ 2.847823] Initializing XFRM netlink socket [ 2.849537] NET: Registered protocol family 10 [ 2.851681] Segment Routing with IPv6 [ 2.852897] NET: Registered protocol family 17 [ 2.854253] mpls_gso: MPLS GSO support [ 2.858433] RAS: Correctable Errors collector initialized. [ 2.859771] AVX version of gcm_enc/dec engaged. [ 2.860687] AES CTR mode by8 optimization enabled [ 2.915136] sched_clock: Marking stable (2915116569, 0)->(3846022700, -930906131) [ 2.918267] registered taskstats version 1 [ 2.919465] Loading compiled-in X.509 certificates [ 2.920965] zswap: loaded using pool lzo/zbud [ 2.941154] Key type big_key registered [ 2.951113] Key type encrypted registered [ 2.952564] ima: No TPM chip found, activating TPM-bypass! [ 2.954599] ima: Allocated hash algorithm: sha1 [ 2.955765] ima: No architecture policies found [ 2.957356] evm: Initialising EVM extended attributes: [ 2.958776] evm: security.selinux [ 2.959671] evm: security.ima [ 2.960478] evm: security.capability [ 2.961395] evm: HMAC attrs: 0x1 [ 2.963131] rtc_cmos 00:05: setting system clock to 2026-09-10 16:48:54 UTC (1789058934) [ 2.967955] debug: unmapping init [mem 0xffffffff96603000-0xffffffff967fffff] [ 2.969948] debug: unmapping init [mem 0xffffffff95382000-0xffffffff95658fff] [ 2.976118] Write protecting the kernel read-only data: 28672k [ 2.978121] debug: unmapping init [mem 0xffffffff93a03000-0xffffffff93bfffff] [ 2.979670] debug: unmapping init [mem 0xffffffff94314000-0xffffffff943fffff] [ 3.004262] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.010262] systemd[1]: Detected virtualization kvm. [ 3.011370] systemd[1]: Detected architecture x86-64. [ 3.012413] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.038452] systemd[1]: No hostname configured. [ 3.039450] systemd[1]: Set hostname to . [ 3.041029] random: systemd: uninitialized urandom read (16 bytes read) [ 3.043039] systemd[1]: Initializing machine ID from random generator. [ 3.101938] random: ln: uninitialized urandom read (6 bytes read) [ 3.187528] random: systemd: uninitialized urandom read (16 bytes read) [ 3.189906] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.193887] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.198225] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Reached target Sockets. [ OK ] Reached target Initrd Root Device. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ 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... [ 3.918139] device-mapper: uevent: version 1.0.3 [ 3.919964] 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... [ 4.276582] random: fast init done [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.713161] virtio_net virtio0 ens2: renamed from eth0 [ 4.783595] scsi host0: ata_piix [ 4.808940] scsi host1: ata_piix [ 4.810455] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.813129] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.359881] dracut-initqueue[579]: RTNETLINK answers: File exists [ 9.492756] random: crng init done [ 9.498632] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 11.966671] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 15.145426] printk: systemd: 26 output lines suppressed due to ratelimiting [ 16.046983] SELinux: Disabled at runtime. [ 16.247510] 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) [ 16.267465] systemd[1]: Detected virtualization kvm. [ 16.273136] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 18.558082] systemd[1]: initrd-switch-root.service: Succeeded. [ 18.560817] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 18.566336] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 18.568945] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 18.571784] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 18.589835] systemd[1]: Starting Journal Service... Starting Journal Service... [ 18.596677] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on Process Core Dump Socket. [ 18.788291] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Stopped target Initrd File Systems. Starting Create list of required st…ce nodes for the current kernel... Mounting Huge Pages File System... Starting Apply Kernel Variables... Mounting POSIX Message Queue File System... [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on udev Kernel Socket. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Mounting Kernel Debug File System... [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. 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. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ 20.208864] hrtimer: interrupt took 15849266 ns [ OK ] Mounted /mnt. [ 20.327830] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 21.855773] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 21.869117] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 22.387354] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 22.443589] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (8s / no limit)[ 27.353882] Key type dns_resolver registered [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 28.185285] NFS: Registering the id_resolver key type [ 28.189377] Key type id_resolver registered [ 28.192991] Key type id_legacy registered [ *** ] A start job is running for Configur…only root support (10s / 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 Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started Login Service. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg211-client login: [ 111.058746] libcfs: loading out-of-tree module taints kernel. [ 111.213560] Key type ._llcrypt registered [ 111.219286] Key type .llcrypt registered [ 112.067376] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 112.097124] alg: No test for adler32 (adler32-zlib) [ 113.921487] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 114.623888] LNet: Added LNI 192.168.202.11@tcp [8/256/0/180] [ 116.447182] Key type lgssc registered [ 118.411567] Lustre: Echo OBD driver; http://www.lustre.org/ [ 124.655750] alg: No test for zstdfast (zstdfast-lustre-generic) [ 124.675989] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 273.643209] Lustre: Mounted lustre-client [ 279.930384] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 297.122156] Lustre: DEBUG MARKER: oleg211-client.virtnet: executing check_logdir /tmp/testlogs/ [ 299.501185] Lustre: lustre-OST0000-osc-ffff940091894000: disconnect after 23s idle [ 304.479538] Lustre: DEBUG MARKER: oleg211-client.virtnet: executing yml_node [ 309.264377] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 312.845854] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 316.338363] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 317.967806] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:54:08 EDT 2026 [ 343.039808] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 345.441733] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 347.725856] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a 130b 130c 130d 130e 130f 130g [ 349.371602] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51b 51c 51e 834 [ 351.172500] Lustre: DEBUG MARKER: === sanity: start setup 12:54:41 (1789059281) === [ 355.574516] Lustre: DEBUG MARKER: oleg211-client.virtnet: executing check_config_client /mnt/lustre [ 373.990952] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 387.533769] Lustre: DEBUG MARKER: === sanity: finish setup 12:55:17 (1789059317) === [ 397.311251] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:55:26 (1789059326) [ 398.001434] lustre_kcompr_31696: ***** [ 398.009850] lustre_kcompr_31696: (de)compression test on random binary data [ 398.012108] lustre_kcompr_31696: ***** [ 398.038222] lustre_kcompr_31696: compr lz4(1) in 64kB chunks took 1489 us (2686 MB/s), compress ratio: 96.63 [ 398.050567] lustre_kcompr_31696: compr lz4(1) in 128kB chunks took 2247 us (1780 MB/s), compress ratio: 101.51 [ 398.057412] lustre_kcompr_31696: compr lz4(1) in 256kB chunks took 2090 us (1913 MB/s), compress ratio: 104.70 [ 398.074137] lustre_kcompr_31696: compr lz4(1) in 512kB chunks took 9866 us (405 MB/s), compress ratio: 106.19 [ 398.089571] lustre_kcompr_31696: compr lz4(1) in 1024kB chunks took 4425 us (903 MB/s), compress ratio: 106.85 [ 398.095129] lustre_kcompr_31696: compr lz4(1) in 2048kB chunks took 1447 us (2764 MB/s), compress ratio: 107.29 [ 398.104684] lustre_kcompr_31696: compr lz4(1) in 4096kB chunks took 1877 us (2131 MB/s), compress ratio: 107.37 [ 398.117379] lustre_kcompr_31696: decompr lz4(1) took 2181 us (17 MB/s) [ 398.121413] lustre_kcompr_31696: test_comp_compress_decompress(lz4,1) ret 0 [ 398.125614] lustre_kcompr_31696: acompr lz4(1) of 128kB chunks took 104 us (1201 MB/s), compress ratio: 95.81 [ 398.129424] lustre_kcompr_31696: adecompr lz4(1) took 183 us (7 MB/s) [ 398.134895] lustre_kcompr_31696: test_acomp_compress_decompress(lz4,1) ret 0 [ 398.146634] lustre_kcompr_31696: compr lz4(4) in 64kB chunks took 1871 us (2137 MB/s), compress ratio: 83.17 [ 398.153131] lustre_kcompr_31696: compr lz4(4) in 128kB chunks took 1966 us (2034 MB/s), compress ratio: 93.03 [ 398.162897] lustre_kcompr_31696: compr lz4(4) in 256kB chunks took 1817 us (2201 MB/s), compress ratio: 99.06 [ 398.168908] lustre_kcompr_31696: compr lz4(4) in 512kB chunks took 1583 us (2526 MB/s), compress ratio: 102.63 [ 398.175334] lustre_kcompr_31696: compr lz4(4) in 1024kB chunks took 2170 us (1843 MB/s), compress ratio: 104.39 [ 398.182563] lustre_kcompr_31696: compr lz4(4) in 2048kB chunks took 2050 us (1951 MB/s), compress ratio: 104.83 [ 398.188307] lustre_kcompr_31696: compr lz4(4) in 4096kB chunks took 1708 us (2341 MB/s), compress ratio: 105.38 [ 398.213665] lustre_kcompr_31696: decompr lz4(4) took 3193 us (11 MB/s) [ 398.218461] lustre_kcompr_31696: test_comp_compress_decompress(lz4,4) ret 0 [ 398.223464] lustre_kcompr_31696: acompr lz4(4) of 128kB chunks took 351 us (356 MB/s), compress ratio: 82.64 [ 398.234615] lustre_kcompr_31696: adecompr lz4(4) took 158 us (9 MB/s) [ 398.246302] lustre_kcompr_31696: test_acomp_compress_decompress(lz4,4) ret 0 [ 398.259461] lustre_kcompr_31696: compr lz4(9) in 64kB chunks took 2465 us (1622 MB/s), compress ratio: 61.35 [ 398.277739] lustre_kcompr_31696: compr lz4(9) in 128kB chunks took 11897 us (336 MB/s), compress ratio: 75.96 [ 398.286903] lustre_kcompr_31696: compr lz4(9) in 256kB chunks took 3862 us (1035 MB/s), compress ratio: 86.84 [ 398.297783] lustre_kcompr_31696: compr lz4(9) in 512kB chunks took 1691 us (2365 MB/s), compress ratio: 94.11 [ 398.306787] lustre_kcompr_31696: compr lz4(9) in 1024kB chunks took 4188 us (955 MB/s), compress ratio: 97.50 [ 398.317466] lustre_kcompr_31696: compr lz4(9) in 2048kB chunks took 4287 us (933 MB/s), compress ratio: 100.34 [ 398.325177] lustre_kcompr_31696: compr lz4(9) in 4096kB chunks took 1417 us (2822 MB/s), compress ratio: 101.06 [ 398.337264] lustre_kcompr_31696: decompr lz4(9) took 2455 us (16 MB/s) [ 398.340509] lustre_kcompr_31696: test_comp_compress_decompress(lz4,9) ret 0 [ 398.344446] lustre_kcompr_31696: acompr lz4(9) of 128kB chunks took 476 us (262 MB/s), compress ratio: 69.75 [ 398.347367] lustre_kcompr_31696: adecompr lz4(9) took 195 us (9 MB/s) [ 398.350778] lustre_kcompr_31696: test_acomp_compress_decompress(lz4,9) ret 0 [ 398.364832] lustre_kcompr_31696: compr lz4(15) in 64kB chunks took 2110 us (1895 MB/s), compress ratio: 29.48 [ 398.378298] lustre_kcompr_31696: compr lz4(15) in 128kB chunks took 1790 us (2234 MB/s), compress ratio: 43.77 [ 398.405518] lustre_kcompr_31696: compr lz4(15) in 256kB chunks took 4125 us (969 MB/s), compress ratio: 59.21 [ 398.418438] lustre_kcompr_31696: compr lz4(15) in 512kB chunks took 3760 us (1063 MB/s), compress ratio: 72.50 [ 398.430713] lustre_kcompr_31696: compr lz4(15) in 1024kB chunks took 2992 us (1336 MB/s), compress ratio: 80.33 [ 398.442073] lustre_kcompr_31696: compr lz4(15) in 2048kB chunks took 1446 us (2766 MB/s), compress ratio: 85.46 [ 398.455391] lustre_kcompr_31696: compr lz4(15) in 4096kB chunks took 2315 us (1727 MB/s), compress ratio: 87.91 [ 398.473527] lustre_kcompr_31696: decompr lz4(15) took 2772 us (16 MB/s) [ 398.484716] lustre_kcompr_31696: test_comp_compress_decompress(lz4,15) ret 0 [ 398.492457] lustre_kcompr_31696: acompr lz4(15) of 128kB chunks took 100 us (1250 MB/s), compress ratio: 40.36 [ 398.503929] lustre_kcompr_31696: adecompr lz4(15) took 119 us (26 MB/s) [ 398.514932] lustre_kcompr_31696: test_acomp_compress_decompress(lz4,15) ret 0 [ 398.576550] lustre_kcompr_31696: compr lz4hc(1) in 64kB chunks took 47584 us (84 MB/s), compress ratio: 97.82 [ 398.632726] lustre_kcompr_31696: compr lz4hc(1) in 128kB chunks took 49162 us (81 MB/s), compress ratio: 103.79 [ 398.696228] lustre_kcompr_31696: compr lz4hc(1) in 256kB chunks took 55375 us (72 MB/s), compress ratio: 107.04 [ 398.773636] lustre_kcompr_31696: compr lz4hc(1) in 512kB chunks took 68976 us (57 MB/s), compress ratio: 108.73 [ 398.854173] lustre_kcompr_31696: compr lz4hc(1) in 1024kB chunks took 64228 us (62 MB/s), compress ratio: 109.61 [ 398.908957] lustre_kcompr_31696: compr lz4hc(1) in 2048kB chunks took 39597 us (101 MB/s), compress ratio: 110.05 [ 398.969747] lustre_kcompr_31696: compr lz4hc(1) in 4096kB chunks took 53961 us (74 MB/s), compress ratio: 110.27 [ 398.999815] lustre_kcompr_31696: decompr lz4hc(1) took 4963 us (7 MB/s) [ 399.008602] lustre_kcompr_31696: test_comp_compress_decompress(lz4hc,1) ret 0 [ 399.021610] lustre_kcompr_31696: acompr lz4hc(1) of 128kB chunks took 1057 us (118 MB/s), compress ratio: 93.28 [ 399.039209] lustre_kcompr_31696: adecompr lz4hc(1) took 107 us (12 MB/s) [ 399.082181] lustre_kcompr_31696: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 399.185400] lustre_kcompr_31696: compr lz4hc(3) in 64kB chunks took 71277 us (56 MB/s), compress ratio: 98.34 [ 399.237484] lustre_kcompr_31696: compr lz4hc(3) in 128kB chunks took 45543 us (87 MB/s), compress ratio: 104.33 [ 399.299323] lustre_kcompr_31696: compr lz4hc(3) in 256kB chunks took 56935 us (70 MB/s), compress ratio: 107.60 [ 399.341623] lustre_kcompr_31696: compr lz4hc(3) in 512kB chunks took 37135 us (107 MB/s), compress ratio: 109.31 [ 399.385872] lustre_kcompr_31696: compr lz4hc(3) in 1024kB chunks took 38982 us (102 MB/s), compress ratio: 110.19 [ 399.433479] lustre_kcompr_31696: compr lz4hc(3) in 2048kB chunks took 42348 us (94 MB/s), compress ratio: 110.64 [ 399.499065] lustre_kcompr_31696: compr lz4hc(3) in 4096kB chunks took 59647 us (67 MB/s), compress ratio: 110.87 [ 399.517565] lustre_kcompr_31696: decompr lz4hc(3) took 1694 us (21 MB/s) [ 399.527482] lustre_kcompr_31696: test_comp_compress_decompress(lz4hc,3) ret 0 [ 399.539786] lustre_kcompr_31696: acompr lz4hc(3) of 128kB chunks took 941 us (132 MB/s), compress ratio: 94.02 [ 399.547700] lustre_kcompr_31696: adecompr lz4hc(3) took 104 us (12 MB/s) [ 399.599833] lustre_kcompr_31696: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 400.684198] lustre_kcompr_31696: compr lz4hc(8) in 64kB chunks took 1056182 us (3 MB/s), compress ratio: 104.59 [ 401.972856] lustre_kcompr_31696: compr lz4hc(8) in 128kB chunks took 1279222 us (3 MB/s), compress ratio: 111.76 [ 403.046539] lustre_kcompr_31696: compr lz4hc(8) in 256kB chunks took 1064098 us (3 MB/s), compress ratio: 115.67 [ 404.368870] lustre_kcompr_31696: compr lz4hc(8) in 512kB chunks took 1310274 us (3 MB/s), compress ratio: 117.72 [ 405.616288] lustre_kcompr_31696: compr lz4hc(8) in 1024kB chunks took 1233586 us (3 MB/s), compress ratio: 118.78 [ 406.978304] lustre_kcompr_31696: compr lz4hc(8) in 2048kB chunks took 1334350 us (2 MB/s), compress ratio: 119.34 [ 407.553064] lustre_kcompr_31696: compr lz4hc(8) in 4096kB chunks took 553936 us (7 MB/s), compress ratio: 119.61 [ 407.573336] lustre_kcompr_31696: decompr lz4hc(8) took 1761 us (18 MB/s) [ 407.578980] lustre_kcompr_31696: test_comp_compress_decompress(lz4hc,8) ret 0 [ 407.624676] lustre_kcompr_31696: acompr lz4hc(8) of 128kB chunks took 41262 us (3 MB/s), compress ratio: 101.68 [ 407.631540] lustre_kcompr_31696: adecompr lz4hc(8) took 152 us (8 MB/s) [ 407.671471] lustre_kcompr_31696: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 408.941215] lustre_kcompr_31696: compr lz4hc(15) in 64kB chunks took 1243476 us (3 MB/s), compress ratio: 105.28 [ 410.462611] lustre_kcompr_31696: compr lz4hc(15) in 128kB chunks took 1514661 us (2 MB/s), compress ratio: 113.00 [ 411.923751] lustre_kcompr_31696: compr lz4hc(15) in 256kB chunks took 1456437 us (2 MB/s), compress ratio: 117.20 [ 412.141086] Lustre: lustre-OST0000-osc-ffff940091894000: disconnect after 24s idle [ 412.150768] Lustre: Skipped 1 previous similar message [ 413.413243] lustre_kcompr_31696: compr lz4hc(15) in 512kB chunks took 1479078 us (2 MB/s), compress ratio: 119.46 [ 415.129567] lustre_kcompr_31696: compr lz4hc(15) in 1024kB chunks took 1712060 us (2 MB/s), compress ratio: 120.63 [ 416.359437] lustre_kcompr_31696: compr lz4hc(15) in 2048kB chunks took 1203572 us (3 MB/s), compress ratio: 121.28 [ 417.239994] lustre_kcompr_31696: compr lz4hc(15) in 4096kB chunks took 874523 us (4 MB/s), compress ratio: 121.57 [ 417.263675] lustre_kcompr_31696: decompr lz4hc(15) took 5435 us (6 MB/s) [ 417.269589] lustre_kcompr_31696: test_comp_compress_decompress(lz4hc,15) ret 0 [ 417.361392] lustre_kcompr_31696: acompr lz4hc(15) of 128kB chunks took 80865 us (1 MB/s), compress ratio: 102.80 [ 417.375993] lustre_kcompr_31696: adecompr lz4hc(15) took 108 us (11 MB/s) [ 417.393941] lustre_kcompr_31696: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 417.414684] lustre_kcompr_31696: compr lzo(-1) in 64kB chunks took 6095 us (656 MB/s), compress ratio: 81.79 [ 417.432147] lustre_kcompr_31696: compr lzo(-1) in 128kB chunks took 4684 us (853 MB/s), compress ratio: 86.96 [ 417.449367] lustre_kcompr_31696: compr lzo(-1) in 256kB chunks took 6203 us (644 MB/s), compress ratio: 87.20 [ 417.461469] lustre_kcompr_31696: compr lzo(-1) in 512kB chunks took 1975 us (2025 MB/s), compress ratio: 89.08 [ 417.480397] lustre_kcompr_31696: compr lzo(-1) in 1024kB chunks took 7674 us (521 MB/s), compress ratio: 88.64 [ 417.511826] lustre_kcompr_31696: compr lzo(-1) in 2048kB chunks took 8330 us (480 MB/s), compress ratio: 89.32 [ 417.535050] lustre_kcompr_31696: compr lzo(-1) in 4096kB chunks took 4680 us (854 MB/s), compress ratio: 89.29 [ 417.563628] lustre_kcompr_31696: decompr lzo(-1) took 4201 us (10 MB/s) [ 417.572605] lustre_kcompr_31696: test_comp_compress_decompress(lzo,-1) ret 0 [ 417.583406] lustre_kcompr_31696: acompr lzo(-1) of 128kB chunks took 116 us (1077 MB/s), compress ratio: 80.70 [ 417.593927] lustre_kcompr_31696: adecompr lzo(-1) took 140 us (11 MB/s) [ 417.629689] lustre_kcompr_31696: test_acomp_compress_decompress(lzo,-1) ret 0 [ 418.271622] lustre_kcompr_31696: compr deflate(1) in 64kB chunks took 603574 us (6 MB/s), compress ratio: 98.12 [ 418.900693] lustre_kcompr_31696: compr deflate(1) in 128kB chunks took 605633 us (6 MB/s), compress ratio: 108.57 [ 419.513934] lustre_kcompr_31696: compr deflate(1) in 256kB chunks took 601797 us (6 MB/s), compress ratio: 114.99 [ 420.128273] lustre_kcompr_31696: compr deflate(1) in 512kB chunks took 605950 us (6 MB/s), compress ratio: 118.93 [ 420.809538] lustre_kcompr_31696: compr deflate(1) in 1024kB chunks took 653322 us (6 MB/s), compress ratio: 120.76 [ 421.480463] lustre_kcompr_31696: compr deflate(1) in 2048kB chunks took 649328 us (6 MB/s), compress ratio: 121.70 [ 421.903901] lustre_kcompr_31696: compr deflate(1) in 4096kB chunks took 419039 us (9 MB/s), compress ratio: 121.98 [ 421.924322] lustre_kcompr_31696: decompr deflate(1) took 6099 us (5 MB/s) [ 421.929069] lustre_kcompr_31696: test_comp_compress_decompress(deflate,1) ret 0 [ 421.943157] lustre_kcompr_31696: acompr deflate(1) of 128kB chunks took 10216 us (12 MB/s), compress ratio: 98.03 [ 421.947501] lustre_kcompr_31696: adecompr deflate(1) took 281 us (4 MB/s) [ 421.952186] lustre_kcompr_31696: test_acomp_compress_decompress(deflate,1) ret 0 [ 422.206770] lustre_kcompr_31696: compr deflate(6) in 64kB chunks took 244544 us (16 MB/s), compress ratio: 98.12 [ 422.590432] lustre_kcompr_31696: compr deflate(6) in 128kB chunks took 380255 us (10 MB/s), compress ratio: 108.57 [ 423.143718] lustre_kcompr_31696: compr deflate(6) in 256kB chunks took 548003 us (7 MB/s), compress ratio: 114.99 [ 423.523865] lustre_kcompr_31696: compr deflate(6) in 512kB chunks took 369694 us (10 MB/s), compress ratio: 118.93 [ 423.959524] lustre_kcompr_31696: compr deflate(6) in 1024kB chunks took 429029 us (9 MB/s), compress ratio: 120.76 [ 424.515539] lustre_kcompr_31696: compr deflate(6) in 2048kB chunks took 538070 us (7 MB/s), compress ratio: 121.70 [ 425.045437] lustre_kcompr_31696: compr deflate(6) in 4096kB chunks took 520237 us (7 MB/s), compress ratio: 121.98 [ 425.078841] lustre_kcompr_31696: decompr deflate(6) took 9374 us (3 MB/s) [ 425.102335] lustre_kcompr_31696: test_comp_compress_decompress(deflate,6) ret 0 [ 425.135860] lustre_kcompr_31696: acompr deflate(6) of 128kB chunks took 18328 us (6 MB/s), compress ratio: 98.03 [ 425.145965] lustre_kcompr_31696: adecompr deflate(6) took 210 us (6 MB/s) [ 425.154601] lustre_kcompr_31696: test_acomp_compress_decompress(deflate,6) ret 0 [ 425.594302] lustre_kcompr_31696: compr deflate(9) in 64kB chunks took 427501 us (9 MB/s), compress ratio: 98.12 [ 426.208460] lustre_kcompr_31696: compr deflate(9) in 128kB chunks took 604970 us (6 MB/s), compress ratio: 108.57 [ 426.773226] lustre_kcompr_31696: compr deflate(9) in 256kB chunks took 558302 us (7 MB/s), compress ratio: 114.99 [ 427.544729] lustre_kcompr_31696: compr deflate(9) in 512kB chunks took 760818 us (5 MB/s), compress ratio: 118.93 [ 428.087396] lustre_kcompr_31696: compr deflate(9) in 1024kB chunks took 534916 us (7 MB/s), compress ratio: 120.76 [ 428.751979] lustre_kcompr_31696: compr deflate(9) in 2048kB chunks took 650849 us (6 MB/s), compress ratio: 121.70 [ 429.580627] lustre_kcompr_31696: compr deflate(9) in 4096kB chunks took 814840 us (4 MB/s), compress ratio: 121.98 [ 429.643182] lustre_kcompr_31696: decompr deflate(9) took 18502 us (1 MB/s) [ 429.659234] lustre_kcompr_31696: test_comp_compress_decompress(deflate,9) ret 0 [ 429.708578] lustre_kcompr_31696: acompr deflate(9) of 128kB chunks took 38389 us (3 MB/s), compress ratio: 98.03 [ 429.729774] lustre_kcompr_31696: adecompr deflate(9) took 197 us (6 MB/s) [ 429.755680] lustre_kcompr_31696: test_acomp_compress_decompress(deflate,9) ret 0 [ 429.816680] lustre_kcompr_31696: compr zstd(0) in 64kB chunks took 22172 us (180 MB/s), compress ratio: 159.23 [ 429.878933] lustre_kcompr_31696: compr zstd(0) in 128kB chunks took 39397 us (101 MB/s), compress ratio: 193.60 [ 429.948658] lustre_kcompr_31696: compr zstd(0) in 256kB chunks took 56428 us (70 MB/s), compress ratio: 206.49 [ 430.041045] lustre_kcompr_31696: compr zstd(0) in 512kB chunks took 75870 us (52 MB/s), compress ratio: 213.35 [ 430.073694] lustre_kcompr_31696: compr zstd(0) in 1024kB chunks took 12415 us (322 MB/s), compress ratio: 217.49 [ 430.092803] lustre_kcompr_31696: compr zstd(0) in 2048kB chunks took 8296 us (482 MB/s), compress ratio: 217.71 [ 430.122174] lustre_kcompr_31696: compr zstd(0) in 4096kB chunks took 7113 us (562 MB/s), compress ratio: 215.34 [ 430.178632] lustre_kcompr_31696: decompr zstd(0) took 8320 us (2 MB/s) [ 430.197658] lustre_kcompr_31696: test_comp_compress_decompress(zstd,0) ret 0 [ 430.214221] lustre_kcompr_31696: acompr zstd(0) of 128kB chunks took 2032 us (61 MB/s), compress ratio: 168.47 [ 430.231661] lustre_kcompr_31696: adecompr zstd(0) took 550 us (1 MB/s) [ 430.242716] lustre_kcompr_31696: test_acomp_compress_decompress(zstd,0) ret 0 [ 430.312744] lustre_kcompr_31696: compr zstd(1) in 64kB chunks took 18547 us (215 MB/s), compress ratio: 158.50 [ 430.344952] lustre_kcompr_31696: compr zstd(1) in 128kB chunks took 12586 us (317 MB/s), compress ratio: 191.68 [ 430.375485] lustre_kcompr_31696: compr zstd(1) in 256kB chunks took 12830 us (311 MB/s), compress ratio: 203.81 [ 430.398983] lustre_kcompr_31696: compr zstd(1) in 512kB chunks took 2529 us (1581 MB/s), compress ratio: 211.25 [ 430.435260] lustre_kcompr_31696: compr zstd(1) in 1024kB chunks took 15026 us (266 MB/s), compress ratio: 213.62 [ 430.448743] lustre_kcompr_31696: compr zstd(1) in 2048kB chunks took 2520 us (1587 MB/s), compress ratio: 212.96 [ 430.464253] lustre_kcompr_31696: compr zstd(1) in 4096kB chunks took 5194 us (770 MB/s), compress ratio: 212.72 [ 430.485499] lustre_kcompr_31696: decompr zstd(1) took 3576 us (5 MB/s) [ 430.498164] lustre_kcompr_31696: test_comp_compress_decompress(zstd,1) ret 0 [ 430.510542] lustre_kcompr_31696: acompr zstd(1) of 128kB chunks took 185 us (675 MB/s), compress ratio: 168.47 [ 430.542545] lustre_kcompr_31696: adecompr zstd(1) took 142 us (5 MB/s) [ 430.584986] lustre_kcompr_31696: test_acomp_compress_decompress(zstd,1) ret 0 [ 430.942895] lustre_kcompr_31696: compr zstd(10) in 64kB chunks took 326097 us (12 MB/s), compress ratio: 161.55 [ 431.252791] lustre_kcompr_31696: compr zstd(10) in 128kB chunks took 292765 us (13 MB/s), compress ratio: 184.68 [ 431.677956] lustre_kcompr_31696: compr zstd(10) in 256kB chunks took 406293 us (9 MB/s), compress ratio: 196.71 [ 432.079935] lustre_kcompr_31696: compr zstd(10) in 512kB chunks took 389374 us (10 MB/s), compress ratio: 217.69 [ 432.561941] lustre_kcompr_31696: compr zstd(10) in 1024kB chunks took 472027 us (8 MB/s), compress ratio: 222.07 [ 433.226352] lustre_kcompr_31696: compr zstd(10) in 2048kB chunks took 649863 us (6 MB/s), compress ratio: 224.45 [ 433.326453] lustre_kcompr_31696: compr zstd(10) in 4096kB chunks took 82916 us (48 MB/s), compress ratio: 225.63 [ 433.338530] lustre_kcompr_31696: decompr zstd(10) took 2147 us (8 MB/s) [ 433.344243] lustre_kcompr_31696: test_comp_compress_decompress(zstd,10) ret 0 [ 433.354612] lustre_kcompr_31696: acompr zstd(10) of 128kB chunks took 6052 us (20 MB/s), compress ratio: 158.49 [ 433.359486] lustre_kcompr_31696: adecompr zstd(10) took 114 us (6 MB/s) [ 433.369376] lustre_kcompr_31696: test_acomp_compress_decompress(zstd,10) ret 0 [ 434.509704] lustre_kcompr_31696: compr zstd(15) in 64kB chunks took 1109435 us (3 MB/s), compress ratio: 170.44 [ 435.918045] lustre_kcompr_31696: compr zstd(15) in 128kB chunks took 1396826 us (2 MB/s), compress ratio: 196.43 [ 437.067523] lustre_kcompr_31696: compr zstd(15) in 256kB chunks took 1139713 us (3 MB/s), compress ratio: 210.36 [ 438.116172] lustre_kcompr_31696: compr zstd(15) in 512kB chunks took 1025570 us (3 MB/s), compress ratio: 217.59 [ 439.158229] lustre_kcompr_31696: compr zstd(15) in 1024kB chunks took 1035541 us (3 MB/s), compress ratio: 222.39 [ 441.108997] lustre_kcompr_31696: compr zstd(15) in 2048kB chunks took 1942592 us (2 MB/s), compress ratio: 222.69 [ 443.381392] lustre_kcompr_31696: compr zstd(15) in 4096kB chunks took 2263500 us (1 MB/s), compress ratio: 222.20 [ 443.416843] lustre_kcompr_31696: decompr zstd(15) took 6742 us (2 MB/s) [ 443.426973] lustre_kcompr_31696: test_comp_compress_decompress(zstd,15) ret 0 [ 443.485316] lustre_kcompr_31696: acompr zstd(15) of 128kB chunks took 53801 us (2 MB/s), compress ratio: 168.90 [ 443.494342] lustre_kcompr_31696: adecompr zstd(15) took 129 us (5 MB/s) [ 443.520906] lustre_kcompr_31696: test_acomp_compress_decompress(zstd,15) ret 0 [ 443.567975] lustre_kcompr_31696: compr zstdfast(1) in 64kB chunks took 6505 us (614 MB/s), compress ratio: 158.51 [ 443.585160] lustre_kcompr_31696: compr zstdfast(1) in 128kB chunks took 7234 us (552 MB/s), compress ratio: 191.69 [ 443.610296] lustre_kcompr_31696: compr zstdfast(1) in 256kB chunks took 6619 us (604 MB/s), compress ratio: 203.80 [ 443.619343] lustre_kcompr_31696: compr zstdfast(1) in 512kB chunks took 3215 us (1244 MB/s), compress ratio: 211.25 [ 443.633193] lustre_kcompr_31696: compr zstdfast(1) in 1024kB chunks took 6281 us (636 MB/s), compress ratio: 213.62 [ 443.645903] lustre_kcompr_31696: compr zstdfast(1) in 2048kB chunks took 2017 us (1983 MB/s), compress ratio: 212.96 [ 443.664607] lustre_kcompr_31696: compr zstdfast(1) in 4096kB chunks took 3456 us (1157 MB/s), compress ratio: 212.72 [ 443.697392] lustre_kcompr_31696: decompr zstdfast(1) took 7574 us (2 MB/s) [ 443.710324] lustre_kcompr_31696: test_comp_compress_decompress(zstdfast,1) ret 0 [ 443.716671] lustre_kcompr_31696: acompr zstdfast(1) of 128kB chunks took 148 us (844 MB/s), compress ratio: 168.47 [ 443.726116] lustre_kcompr_31696: adecompr zstdfast(1) took 259 us (2 MB/s) [ 443.747186] lustre_kcompr_31696: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 443.765635] lustre_kcompr_31696: compr zstdfast(5) in 64kB chunks took 5731 us (697 MB/s), compress ratio: 140.09 [ 443.775242] lustre_kcompr_31696: compr zstdfast(5) in 128kB chunks took 2276 us (1757 MB/s), compress ratio: 165.60 [ 443.786461] lustre_kcompr_31696: compr zstdfast(5) in 256kB chunks took 5738 us (697 MB/s), compress ratio: 174.41 [ 443.793996] lustre_kcompr_31696: compr zstdfast(5) in 512kB chunks took 5327 us (750 MB/s), compress ratio: 178.92 [ 443.801181] lustre_kcompr_31696: compr zstdfast(5) in 1024kB chunks took 2482 us (1611 MB/s), compress ratio: 181.46 [ 443.809632] lustre_kcompr_31696: compr zstdfast(5) in 2048kB chunks took 3055 us (1309 MB/s), compress ratio: 184.59 [ 443.819772] lustre_kcompr_31696: compr zstdfast(5) in 4096kB chunks took 4506 us (887 MB/s), compress ratio: 183.07 [ 443.843254] lustre_kcompr_31696: decompr zstdfast(5) took 3516 us (6 MB/s) [ 443.852088] lustre_kcompr_31696: test_comp_compress_decompress(zstdfast,5) ret 0 [ 443.859771] lustre_kcompr_31696: acompr zstdfast(5) of 128kB chunks took 186 us (672 MB/s), compress ratio: 146.61 [ 443.865855] lustre_kcompr_31696: adecompr zstdfast(5) took 271 us (3 MB/s) [ 443.876691] lustre_kcompr_31696: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 443.905331] lustre_kcompr_31696: compr zstdfast(12) in 64kB chunks took 6854 us (583 MB/s), compress ratio: 38.17 [ 443.915448] lustre_kcompr_31696: compr zstdfast(12) in 128kB chunks took 3877 us (1031 MB/s), compress ratio: 43.71 [ 443.930837] lustre_kcompr_31696: compr zstdfast(12) in 256kB chunks took 6489 us (616 MB/s), compress ratio: 47.55 [ 443.957111] lustre_kcompr_31696: compr zstdfast(12) in 512kB chunks took 10539 us (379 MB/s), compress ratio: 51.65 [ 443.982394] lustre_kcompr_31696: compr zstdfast(12) in 1024kB chunks took 8100 us (493 MB/s), compress ratio: 56.88 [ 443.999384] lustre_kcompr_31696: compr zstdfast(12) in 2048kB chunks took 3720 us (1075 MB/s), compress ratio: 78.52 [ 444.013107] lustre_kcompr_31696: compr zstdfast(12) in 4096kB chunks took 4789 us (835 MB/s), compress ratio: 81.62 [ 444.030342] lustre_kcompr_31696: decompr zstdfast(12) took 5757 us (8 MB/s) [ 444.039533] lustre_kcompr_31696: test_comp_compress_decompress(zstdfast,12) ret 0 [ 444.044824] lustre_kcompr_31696: acompr zstdfast(12) of 128kB chunks took 168 us (744 MB/s), compress ratio: 36.72 [ 444.050925] lustre_kcompr_31696: adecompr zstdfast(12) took 135 us (25 MB/s) [ 444.059962] lustre_kcompr_31696: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 444.110683] lustre_kcompr_31696: compr zstdfast(15) in 64kB chunks took 8047 us (497 MB/s), compress ratio: 19.03 [ 444.125465] lustre_kcompr_31696: compr zstdfast(15) in 128kB chunks took 7597 us (526 MB/s), compress ratio: 19.94 [ 444.146333] lustre_kcompr_31696: compr zstdfast(15) in 256kB chunks took 5559 us (719 MB/s), compress ratio: 20.45 [ 444.168236] lustre_kcompr_31696: compr zstdfast(15) in 512kB chunks took 4826 us (828 MB/s), compress ratio: 20.49 [ 444.177486] lustre_kcompr_31696: compr zstdfast(15) in 1024kB chunks took 3186 us (1255 MB/s), compress ratio: 20.54 [ 444.188907] lustre_kcompr_31696: compr zstdfast(15) in 2048kB chunks took 5181 us (772 MB/s), compress ratio: 22.34 [ 444.216556] lustre_kcompr_31696: compr zstdfast(15) in 4096kB chunks took 9659 us (414 MB/s), compress ratio: 28.86 [ 444.248317] lustre_kcompr_31696: decompr zstdfast(15) took 2622 us (52 MB/s) [ 444.254285] lustre_kcompr_31696: test_comp_compress_decompress(zstdfast,15) ret 0 [ 444.259225] lustre_kcompr_31696: acompr zstdfast(15) of 128kB chunks took 246 us (508 MB/s), compress ratio: 15.87 [ 444.264881] lustre_kcompr_31696: adecompr zstdfast(15) took 110 us (71 MB/s) [ 444.275460] lustre_kcompr_31696: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 444.279057] lustre_kcompr_31696: SUCCESS [ 454.556787] lustre_kcompr_9804: ***** [ 454.561561] lustre_kcompr_9804: (de)compression test on provided file /tmp/f84.sanity [ 454.568157] lustre_kcompr_9804: ***** [ 454.619961] lustre_kcompr_9804: compr lz4(1) in 64kB chunks took 36689 us (109 MB/s), compress ratio: 2.93 [ 454.691198] lustre_kcompr_9804: compr lz4(1) in 128kB chunks took 53078 us (75 MB/s), compress ratio: 3.04 [ 454.763750] lustre_kcompr_9804: compr lz4(1) in 256kB chunks took 51094 us (78 MB/s), compress ratio: 3.08 [ 454.827213] lustre_kcompr_9804: compr lz4(1) in 512kB chunks took 53236 us (75 MB/s), compress ratio: 3.10 [ 454.864337] lustre_kcompr_9804: compr lz4(1) in 1024kB chunks took 31181 us (128 MB/s), compress ratio: 3.11 [ 454.915432] lustre_kcompr_9804: compr lz4(1) in 2048kB chunks took 38681 us (103 MB/s), compress ratio: 3.11 [ 454.978988] lustre_kcompr_9804: compr lz4(1) in 4096kB chunks took 54846 us (72 MB/s), compress ratio: 3.12 [ 455.007475] lustre_kcompr_9804: decompr lz4(1) took 12393 us (103 MB/s) [ 455.016555] lustre_kcompr_9804: test_comp_compress_decompress(lz4,1) ret 0 [ 455.032971] lustre_kcompr_9804: acompr lz4(1) of 128kB chunks took 604 us (206 MB/s), compress ratio: 2.68 [ 455.042401] lustre_kcompr_9804: adecompr lz4(1) took 369 us (126 MB/s) [ 455.050239] lustre_kcompr_9804: test_acomp_compress_decompress(lz4,1) ret 0 [ 455.151545] lustre_kcompr_9804: compr lz4(4) in 64kB chunks took 65299 us (61 MB/s), compress ratio: 2.67 [ 455.219309] lustre_kcompr_9804: compr lz4(4) in 128kB chunks took 54169 us (73 MB/s), compress ratio: 2.63 [ 455.290486] lustre_kcompr_9804: compr lz4(4) in 256kB chunks took 49633 us (80 MB/s), compress ratio: 2.68 [ 455.364058] lustre_kcompr_9804: compr lz4(4) in 512kB chunks took 42264 us (94 MB/s), compress ratio: 2.71 [ 455.389210] lustre_kcompr_9804: compr lz4(4) in 1024kB chunks took 19229 us (208 MB/s), compress ratio: 2.72 [ 455.467197] lustre_kcompr_9804: compr lz4(4) in 2048kB chunks took 71938 us (55 MB/s), compress ratio: 2.72 [ 455.529055] lustre_kcompr_9804: compr lz4(4) in 4096kB chunks took 41929 us (95 MB/s), compress ratio: 2.73 [ 455.579233] lustre_kcompr_9804: decompr lz4(4) took 20358 us (71 MB/s) [ 455.588970] lustre_kcompr_9804: test_comp_compress_decompress(lz4,4) ret 0 [ 455.598120] lustre_kcompr_9804: acompr lz4(4) of 128kB chunks took 576 us (217 MB/s), compress ratio: 2.30 [ 455.612081] lustre_kcompr_9804: adecompr lz4(4) took 223 us (243 MB/s) [ 455.636844] lustre_kcompr_9804: test_acomp_compress_decompress(lz4,4) ret 0 [ 455.691292] lustre_kcompr_9804: compr lz4(9) in 64kB chunks took 28690 us (139 MB/s), compress ratio: 2.30 [ 455.735606] lustre_kcompr_9804: compr lz4(9) in 128kB chunks took 30997 us (129 MB/s), compress ratio: 2.15 [ 455.797800] lustre_kcompr_9804: compr lz4(9) in 256kB chunks took 45571 us (87 MB/s), compress ratio: 2.20 [ 455.848903] lustre_kcompr_9804: compr lz4(9) in 512kB chunks took 36227 us (110 MB/s), compress ratio: 2.23 [ 455.897413] lustre_kcompr_9804: compr lz4(9) in 1024kB chunks took 31205 us (128 MB/s), compress ratio: 2.25 [ 455.951302] lustre_kcompr_9804: compr lz4(9) in 2048kB chunks took 33611 us (119 MB/s), compress ratio: 2.25 [ 456.001874] lustre_kcompr_9804: compr lz4(9) in 4096kB chunks took 39008 us (102 MB/s), compress ratio: 2.26 [ 456.034229] lustre_kcompr_9804: decompr lz4(9) took 11371 us (155 MB/s) [ 456.041506] lustre_kcompr_9804: test_comp_compress_decompress(lz4,9) ret 0 [ 456.052174] lustre_kcompr_9804: acompr lz4(9) of 128kB chunks took 696 us (179 MB/s), compress ratio: 1.87 [ 456.061355] lustre_kcompr_9804: adecompr lz4(9) took 975 us (68 MB/s) [ 456.066869] lustre_kcompr_9804: test_acomp_compress_decompress(lz4,9) ret 0 [ 456.123450] lustre_kcompr_9804: compr lz4(15) in 64kB chunks took 24875 us (160 MB/s), compress ratio: 1.63 [ 456.176387] lustre_kcompr_9804: compr lz4(15) in 128kB chunks took 43525 us (91 MB/s), compress ratio: 1.52 [ 456.213273] lustre_kcompr_9804: compr lz4(15) in 256kB chunks took 20465 us (195 MB/s), compress ratio: 1.56 [ 456.249790] lustre_kcompr_9804: compr lz4(15) in 512kB chunks took 24945 us (160 MB/s), compress ratio: 1.58 [ 456.304856] lustre_kcompr_9804: compr lz4(15) in 1024kB chunks took 44392 us (90 MB/s), compress ratio: 1.60 [ 456.375296] lustre_kcompr_9804: compr lz4(15) in 2048kB chunks took 63399 us (63 MB/s), compress ratio: 1.60 [ 456.405405] lustre_kcompr_9804: compr lz4(15) in 4096kB chunks took 19429 us (205 MB/s), compress ratio: 1.60 [ 456.432259] lustre_kcompr_9804: decompr lz4(15) took 7540 us (329 MB/s) [ 456.438659] lustre_kcompr_9804: test_comp_compress_decompress(lz4,15) ret 0 [ 456.450263] lustre_kcompr_9804: acompr lz4(15) of 128kB chunks took 1443 us (86 MB/s), compress ratio: 1.33 [ 456.475227] lustre_kcompr_9804: adecompr lz4(15) took 254 us (369 MB/s) [ 456.507440] lustre_kcompr_9804: test_acomp_compress_decompress(lz4,15) ret 0 [ 456.796073] lustre_kcompr_9804: compr lz4hc(1) in 64kB chunks took 271751 us (14 MB/s), compress ratio: 3.58 [ 457.110487] lustre_kcompr_9804: compr lz4hc(1) in 128kB chunks took 306284 us (13 MB/s), compress ratio: 3.77 [ 457.641076] lustre_kcompr_9804: compr lz4hc(1) in 256kB chunks took 515931 us (7 MB/s), compress ratio: 3.88 [ 457.994826] lustre_kcompr_9804: compr lz4hc(1) in 512kB chunks took 325484 us (12 MB/s), compress ratio: 3.93 [ 458.441028] lustre_kcompr_9804: compr lz4hc(1) in 1024kB chunks took 438077 us (9 MB/s), compress ratio: 3.96 [ 458.770268] lustre_kcompr_9804: compr lz4hc(1) in 2048kB chunks took 319451 us (12 MB/s), compress ratio: 3.97 [ 459.112851] lustre_kcompr_9804: compr lz4hc(1) in 4096kB chunks took 330451 us (12 MB/s), compress ratio: 3.98 [ 459.143313] lustre_kcompr_9804: decompr lz4hc(1) took 12468 us (80 MB/s) [ 459.150804] lustre_kcompr_9804: test_comp_compress_decompress(lz4hc,1) ret 0 [ 459.173505] lustre_kcompr_9804: acompr lz4hc(1) of 128kB chunks took 16221 us (7 MB/s), compress ratio: 3.27 [ 459.219854] lustre_kcompr_9804: adecompr lz4hc(1) took 31364 us (1 MB/s) [ 459.237167] lustre_kcompr_9804: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 459.731927] lustre_kcompr_9804: compr lz4hc(3) in 64kB chunks took 469574 us (8 MB/s), compress ratio: 3.68 [ 460.224239] lustre_kcompr_9804: compr lz4hc(3) in 128kB chunks took 475093 us (8 MB/s), compress ratio: 3.91 [ 460.900959] lustre_kcompr_9804: compr lz4hc(3) in 256kB chunks took 656647 us (6 MB/s), compress ratio: 4.04 [ 461.299470] lustre_kcompr_9804: compr lz4hc(3) in 512kB chunks took 389495 us (10 MB/s), compress ratio: 4.10 [ 461.699218] lustre_kcompr_9804: compr lz4hc(3) in 1024kB chunks took 395403 us (10 MB/s), compress ratio: 4.13 [ 461.886977] lustre_kcompr_9804: compr lz4hc(3) in 2048kB chunks took 181261 us (22 MB/s), compress ratio: 4.15 [ 462.246331] lustre_kcompr_9804: compr lz4hc(3) in 4096kB chunks took 354490 us (11 MB/s), compress ratio: 4.16 [ 462.287237] lustre_kcompr_9804: decompr lz4hc(3) took 15203 us (63 MB/s) [ 462.297462] lustre_kcompr_9804: test_comp_compress_decompress(lz4hc,3) ret 0 [ 462.316661] lustre_kcompr_9804: acompr lz4hc(3) of 128kB chunks took 9915 us (12 MB/s), compress ratio: 3.38 [ 462.329992] lustre_kcompr_9804: adecompr lz4hc(3) took 5456 us (6 MB/s) [ 462.340124] lustre_kcompr_9804: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 462.891164] lustre_kcompr_9804: compr lz4hc(8) in 64kB chunks took 527563 us (7 MB/s), compress ratio: 3.72 [ 463.855947] lustre_kcompr_9804: compr lz4hc(8) in 128kB chunks took 954147 us (4 MB/s), compress ratio: 3.96 [ 464.656697] lustre_kcompr_9804: compr lz4hc(8) in 256kB chunks took 794638 us (5 MB/s), compress ratio: 4.10 [ 465.457931] lustre_kcompr_9804: compr lz4hc(8) in 512kB chunks took 791426 us (5 MB/s), compress ratio: 4.17 [ 466.558416] lustre_kcompr_9804: compr lz4hc(8) in 1024kB chunks took 1093569 us (3 MB/s), compress ratio: 4.21 [ 467.285935] lustre_kcompr_9804: compr lz4hc(8) in 2048kB chunks took 719110 us (5 MB/s), compress ratio: 4.22 [ 467.867221] lustre_kcompr_9804: compr lz4hc(8) in 4096kB chunks took 576152 us (6 MB/s), compress ratio: 4.23 [ 467.881393] lustre_kcompr_9804: decompr lz4hc(8) took 5149 us (183 MB/s) [ 467.885290] lustre_kcompr_9804: test_comp_compress_decompress(lz4hc,8) ret 0 [ 467.901724] lustre_kcompr_9804: acompr lz4hc(8) of 128kB chunks took 12121 us (10 MB/s), compress ratio: 3.42 [ 467.907995] lustre_kcompr_9804: adecompr lz4hc(8) took 211 us (172 MB/s) [ 467.916862] lustre_kcompr_9804: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 468.200997] lustre_kcompr_9804: compr lz4hc(15) in 64kB chunks took 268457 us (14 MB/s), compress ratio: 3.72 [ 468.638778] lustre_kcompr_9804: compr lz4hc(15) in 128kB chunks took 433179 us (9 MB/s), compress ratio: 3.96 [ 469.598073] lustre_kcompr_9804: compr lz4hc(15) in 256kB chunks took 949957 us (4 MB/s), compress ratio: 4.10 [ 470.309298] lustre_kcompr_9804: compr lz4hc(15) in 512kB chunks took 704552 us (5 MB/s), compress ratio: 4.17 [ 470.951819] lustre_kcompr_9804: compr lz4hc(15) in 1024kB chunks took 636528 us (6 MB/s), compress ratio: 4.21 [ 472.030393] lustre_kcompr_9804: compr lz4hc(15) in 2048kB chunks took 1063284 us (3 MB/s), compress ratio: 4.22 [ 472.962371] lustre_kcompr_9804: compr lz4hc(15) in 4096kB chunks took 919166 us (4 MB/s), compress ratio: 4.23 [ 472.995654] lustre_kcompr_9804: decompr lz4hc(15) took 9789 us (96 MB/s) [ 473.006391] lustre_kcompr_9804: test_comp_compress_decompress(lz4hc,15) ret 0 [ 473.048658] lustre_kcompr_9804: acompr lz4hc(15) of 128kB chunks took 30758 us (4 MB/s), compress ratio: 3.42 [ 473.061280] lustre_kcompr_9804: adecompr lz4hc(15) took 817 us (44 MB/s) [ 473.082351] lustre_kcompr_9804: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 473.105762] lustre_kcompr_9804: compr lzo(-1) in 64kB chunks took 18515 us (216 MB/s), compress ratio: 2.90 [ 473.128965] lustre_kcompr_9804: compr lzo(-1) in 128kB chunks took 17980 us (222 MB/s), compress ratio: 2.95 [ 473.177330] lustre_kcompr_9804: compr lzo(-1) in 256kB chunks took 44133 us (90 MB/s), compress ratio: 2.96 [ 473.214927] lustre_kcompr_9804: compr lzo(-1) in 512kB chunks took 32317 us (123 MB/s), compress ratio: 2.98 [ 473.261349] lustre_kcompr_9804: compr lzo(-1) in 1024kB chunks took 41574 us (96 MB/s), compress ratio: 2.97 [ 473.311722] lustre_kcompr_9804: compr lzo(-1) in 2048kB chunks took 45408 us (88 MB/s), compress ratio: 2.97 [ 473.360433] lustre_kcompr_9804: compr lzo(-1) in 4096kB chunks took 36329 us (110 MB/s), compress ratio: 2.96 [ 473.406586] lustre_kcompr_9804: decompr lzo(-1) took 25536 us (52 MB/s) [ 473.413374] lustre_kcompr_9804: test_comp_compress_decompress(lzo,-1) ret 0 [ 473.419572] lustre_kcompr_9804: acompr lzo(-1) of 128kB chunks took 712 us (175 MB/s), compress ratio: 2.62 [ 473.436532] lustre_kcompr_9804: adecompr lzo(-1) took 502 us (95 MB/s) [ 473.466107] lustre_kcompr_9804: test_acomp_compress_decompress(lzo,-1) ret 0 [ 474.294235] lustre_kcompr_9804: compr deflate(1) in 64kB chunks took 815040 us (4 MB/s), compress ratio: 3.51 [ 475.049265] lustre_kcompr_9804: compr deflate(1) in 128kB chunks took 748808 us (5 MB/s), compress ratio: 3.53 [ 475.858760] lustre_kcompr_9804: compr deflate(1) in 256kB chunks took 801392 us (4 MB/s), compress ratio: 3.53 [ 476.502361] lustre_kcompr_9804: compr deflate(1) in 512kB chunks took 632624 us (6 MB/s), compress ratio: 3.54 [ 476.915932] lustre_kcompr_9804: compr deflate(1) in 1024kB chunks took 408996 us (9 MB/s), compress ratio: 3.54 [ 477.465929] lustre_kcompr_9804: compr deflate(1) in 2048kB chunks took 544568 us (7 MB/s), compress ratio: 3.54 [ 478.050316] lustre_kcompr_9804: compr deflate(1) in 4096kB chunks took 578579 us (6 MB/s), compress ratio: 3.54 [ 478.122611] lustre_kcompr_9804: decompr deflate(1) took 50162 us (22 MB/s) [ 478.132597] lustre_kcompr_9804: test_comp_compress_decompress(deflate,1) ret 0 [ 478.152214] lustre_kcompr_9804: acompr deflate(1) of 128kB chunks took 13775 us (9 MB/s), compress ratio: 3.09 [ 478.160465] lustre_kcompr_9804: adecompr deflate(1) took 1065 us (37 MB/s) [ 478.167581] lustre_kcompr_9804: test_acomp_compress_decompress(deflate,1) ret 0 [ 478.836435] lustre_kcompr_9804: compr deflate(6) in 64kB chunks took 653384 us (6 MB/s), compress ratio: 3.51 [ 479.481304] lustre_kcompr_9804: compr deflate(6) in 128kB chunks took 637036 us (6 MB/s), compress ratio: 3.53 [ 480.173938] lustre_kcompr_9804: compr deflate(6) in 256kB chunks took 681717 us (5 MB/s), compress ratio: 3.53 [ 480.909960] lustre_kcompr_9804: compr deflate(6) in 512kB chunks took 729776 us (5 MB/s), compress ratio: 3.54 [ 481.658890] lustre_kcompr_9804: compr deflate(6) in 1024kB chunks took 733057 us (5 MB/s), compress ratio: 3.54 [ 482.520699] lustre_kcompr_9804: compr deflate(6) in 2048kB chunks took 850830 us (4 MB/s), compress ratio: 3.54 [ 483.272579] lustre_kcompr_9804: compr deflate(6) in 4096kB chunks took 735121 us (5 MB/s), compress ratio: 3.54 [ 483.367806] lustre_kcompr_9804: decompr deflate(6) took 74425 us (15 MB/s) [ 483.388996] lustre_kcompr_9804: test_comp_compress_decompress(deflate,6) ret 0 [ 483.437099] lustre_kcompr_9804: acompr deflate(6) of 128kB chunks took 42367 us (2 MB/s), compress ratio: 3.09 [ 483.457996] lustre_kcompr_9804: adecompr deflate(6) took 1580 us (25 MB/s) [ 483.469993] lustre_kcompr_9804: test_acomp_compress_decompress(deflate,6) ret 0 [ 484.406791] lustre_kcompr_9804: compr deflate(9) in 64kB chunks took 911975 us (4 MB/s), compress ratio: 3.51 [ 485.439071] lustre_kcompr_9804: compr deflate(9) in 128kB chunks took 1024887 us (3 MB/s), compress ratio: 3.53 [ 486.390964] lustre_kcompr_9804: compr deflate(9) in 256kB chunks took 937207 us (4 MB/s), compress ratio: 3.53 [ 487.484572] lustre_kcompr_9804: compr deflate(9) in 512kB chunks took 1089084 us (3 MB/s), compress ratio: 3.54 [ 488.527300] lustre_kcompr_9804: compr deflate(9) in 1024kB chunks took 1027062 us (3 MB/s), compress ratio: 3.54 [ 489.549935] lustre_kcompr_9804: compr deflate(9) in 2048kB chunks took 1003844 us (3 MB/s), compress ratio: 3.54 [ 490.395247] lustre_kcompr_9804: compr deflate(9) in 4096kB chunks took 830120 us (4 MB/s), compress ratio: 3.54 [ 490.506466] lustre_kcompr_9804: decompr deflate(9) took 87921 us (12 MB/s) [ 490.533080] lustre_kcompr_9804: test_comp_compress_decompress(deflate,9) ret 0 [ 490.580072] lustre_kcompr_9804: acompr deflate(9) of 128kB chunks took 42282 us (2 MB/s), compress ratio: 3.09 [ 490.597482] lustre_kcompr_9804: adecompr deflate(9) took 6771 us (5 MB/s) [ 490.623048] lustre_kcompr_9804: test_acomp_compress_decompress(deflate,9) ret 0 [ 490.779440] lustre_kcompr_9804: compr zstd(0) in 64kB chunks took 128846 us (31 MB/s), compress ratio: 4.28 [ 490.857374] lustre_kcompr_9804: compr zstd(0) in 128kB chunks took 70166 us (57 MB/s), compress ratio: 4.46 [ 491.044877] lustre_kcompr_9804: compr zstd(0) in 256kB chunks took 183313 us (21 MB/s), compress ratio: 4.61 [ 491.375653] lustre_kcompr_9804: compr zstd(0) in 512kB chunks took 311744 us (12 MB/s), compress ratio: 4.72 [ 491.591577] lustre_kcompr_9804: compr zstd(0) in 1024kB chunks took 208756 us (19 MB/s), compress ratio: 4.80 [ 491.911410] lustre_kcompr_9804: compr zstd(0) in 2048kB chunks took 310264 us (12 MB/s), compress ratio: 4.85 [ 492.314635] lustre_kcompr_9804: compr zstd(0) in 4096kB chunks took 383435 us (10 MB/s), compress ratio: 4.88 [ 492.375372] lustre_kcompr_9804: decompr zstd(0) took 43073 us (19 MB/s) [ 492.381959] lustre_kcompr_9804: test_comp_compress_decompress(zstd,0) ret 0 [ 492.394125] lustre_kcompr_9804: acompr zstd(0) of 128kB chunks took 4416 us (28 MB/s), compress ratio: 3.98 [ 492.404148] lustre_kcompr_9804: adecompr zstd(0) took 2013 us (15 MB/s) [ 492.417355] lustre_kcompr_9804: test_acomp_compress_decompress(zstd,0) ret 0 [ 492.593372] lustre_kcompr_9804: compr zstd(1) in 64kB chunks took 153154 us (26 MB/s), compress ratio: 4.06 [ 492.674785] lustre_kcompr_9804: compr zstd(1) in 128kB chunks took 74244 us (53 MB/s), compress ratio: 4.20 [ 492.753524] lustre_kcompr_9804: compr zstd(1) in 256kB chunks took 71054 us (56 MB/s), compress ratio: 4.34 [ 492.832399] lustre_kcompr_9804: compr zstd(1) in 512kB chunks took 73570 us (54 MB/s), compress ratio: 4.34 [ 492.909444] lustre_kcompr_9804: compr zstd(1) in 1024kB chunks took 71918 us (55 MB/s), compress ratio: 4.37 [ 493.010111] lustre_kcompr_9804: compr zstd(1) in 2048kB chunks took 92193 us (43 MB/s), compress ratio: 4.39 [ 493.138780] lustre_kcompr_9804: compr zstd(1) in 4096kB chunks took 113713 us (35 MB/s), compress ratio: 4.40 [ 493.197858] lustre_kcompr_9804: decompr zstd(1) took 31997 us (28 MB/s) [ 493.208984] lustre_kcompr_9804: test_comp_compress_decompress(zstd,1) ret 0 [ 493.220397] lustre_kcompr_9804: acompr zstd(1) of 128kB chunks took 4105 us (30 MB/s), compress ratio: 3.73 [ 493.228249] lustre_kcompr_9804: adecompr zstd(1) took 1093 us (30 MB/s) [ 493.241702] lustre_kcompr_9804: test_acomp_compress_decompress(zstd,1) ret 0 [ 494.941454] lustre_kcompr_9804: compr zstd(10) in 64kB chunks took 1686904 us (2 MB/s), compress ratio: 4.80 [ 497.308155] lustre_kcompr_9804: compr zstd(10) in 128kB chunks took 2355700 us (1 MB/s), compress ratio: 5.09 [ 500.231913] lustre_kcompr_9804: compr zstd(10) in 256kB chunks took 2918094 us (1 MB/s), compress ratio: 5.34 [ 501.644810] lustre_kcompr_9804: compr zstd(10) in 512kB chunks took 1405341 us (2 MB/s), compress ratio: 5.45 [ 503.893860] lustre_kcompr_9804: compr zstd(10) in 1024kB chunks took 2237809 us (1 MB/s), compress ratio: 5.62 [ 506.416276] lustre_kcompr_9804: compr zstd(10) in 2048kB chunks took 2514462 us (1 MB/s), compress ratio: 5.76 [ 508.806910] lustre_kcompr_9804: compr zstd(10) in 4096kB chunks took 2386534 us (1 MB/s), compress ratio: 5.89 [ 508.889092] lustre_kcompr_9804: decompr zstd(10) took 64155 us (10 MB/s) [ 508.899365] lustre_kcompr_9804: test_comp_compress_decompress(zstd,10) ret 0 [ 508.994369] lustre_kcompr_9804: acompr zstd(10) of 128kB chunks took 80807 us (1 MB/s), compress ratio: 4.46 [ 509.007444] lustre_kcompr_9804: adecompr zstd(10) took 597 us (46 MB/s) [ 509.026599] lustre_kcompr_9804: test_acomp_compress_decompress(zstd,10) ret 0 [ 526.815686] lustre_kcompr_9804: compr zstd(15) in 64kB chunks took 17760017 us (0 MB/s), compress ratio: 4.96 [ 546.265391] lustre_kcompr_9804: compr zstd(15) in 128kB chunks took 19435916 us (0 MB/s), compress ratio: 5.28 [ 564.896540] lustre_kcompr_9804: compr zstd(15) in 256kB chunks took 18617915 us (0 MB/s), compress ratio: 5.57 [ 578.499756] lustre_kcompr_9804: compr zstd(15) in 512kB chunks took 13592281 us (0 MB/s), compress ratio: 5.83 [ 594.474261] lustre_kcompr_9804: compr zstd(15) in 1024kB chunks took 15969516 us (0 MB/s), compress ratio: 6.06 [ 607.631864] lustre_kcompr_9804: compr zstd(15) in 2048kB chunks took 13152240 us (0 MB/s), compress ratio: 6.26 [ 625.550323] lustre_kcompr_9804: compr zstd(15) in 4096kB chunks took 17908948 us (0 MB/s), compress ratio: 6.46 [ 625.688195] lustre_kcompr_9804: decompr zstd(15) took 98111 us (6 MB/s) [ 625.703197] lustre_kcompr_9804: test_comp_compress_decompress(zstd,15) ret 0 [ 626.550546] lustre_kcompr_9804: acompr zstd(15) of 128kB chunks took 833588 us (0 MB/s), compress ratio: 4.64 [ 626.564081] lustre_kcompr_9804: adecompr zstd(15) took 1724 us (15 MB/s) [ 626.642516] lustre_kcompr_9804: test_acomp_compress_decompress(zstd,15) ret 0 [ 626.779734] lustre_kcompr_9804: compr zstdfast(1) in 64kB chunks took 110788 us (36 MB/s), compress ratio: 3.49 [ 626.928811] lustre_kcompr_9804: compr zstdfast(1) in 128kB chunks took 130080 us (30 MB/s), compress ratio: 3.62 [ 626.985791] lustre_kcompr_9804: compr zstdfast(1) in 256kB chunks took 50326 us (79 MB/s), compress ratio: 3.84 [ 627.025586] lustre_kcompr_9804: compr zstdfast(1) in 512kB chunks took 35759 us (111 MB/s), compress ratio: 3.73 [ 627.077517] lustre_kcompr_9804: compr zstdfast(1) in 1024kB chunks took 47543 us (84 MB/s), compress ratio: 3.76 [ 627.135773] lustre_kcompr_9804: compr zstdfast(1) in 2048kB chunks took 52836 us (75 MB/s), compress ratio: 3.77 [ 627.177609] lustre_kcompr_9804: compr zstdfast(1) in 4096kB chunks took 35969 us (111 MB/s), compress ratio: 3.78 [ 627.215850] lustre_kcompr_9804: decompr zstdfast(1) took 28987 us (36 MB/s) [ 627.223885] lustre_kcompr_9804: test_comp_compress_decompress(zstdfast,1) ret 0 [ 627.259587] lustre_kcompr_9804: acompr zstdfast(1) of 128kB chunks took 8078 us (15 MB/s), compress ratio: 3.19 [ 627.270583] lustre_kcompr_9804: adecompr zstdfast(1) took 1082 us (36 MB/s) [ 627.307733] lustre_kcompr_9804: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 627.482072] lustre_kcompr_9804: compr zstdfast(5) in 64kB chunks took 163220 us (24 MB/s), compress ratio: 2.81 [ 627.567996] lustre_kcompr_9804: compr zstdfast(5) in 128kB chunks took 67589 us (59 MB/s), compress ratio: 2.93 [ 627.734115] lustre_kcompr_9804: compr zstdfast(5) in 256kB chunks took 135032 us (29 MB/s), compress ratio: 3.16 [ 627.850159] lustre_kcompr_9804: compr zstdfast(5) in 512kB chunks took 99120 us (40 MB/s), compress ratio: 3.04 [ 627.996643] lustre_kcompr_9804: compr zstdfast(5) in 1024kB chunks took 126485 us (31 MB/s), compress ratio: 3.07 [ 628.118249] lustre_kcompr_9804: compr zstdfast(5) in 2048kB chunks took 95398 us (41 MB/s), compress ratio: 3.08 [ 628.321865] lustre_kcompr_9804: compr zstdfast(5) in 4096kB chunks took 192376 us (20 MB/s), compress ratio: 3.09 [ 628.394817] lustre_kcompr_9804: decompr zstdfast(5) took 25149 us (51 MB/s) [ 628.422899] lustre_kcompr_9804: test_comp_compress_decompress(zstdfast,5) ret 0 [ 628.435270] lustre_kcompr_9804: acompr zstdfast(5) of 128kB chunks took 1153 us (108 MB/s), compress ratio: 2.56 [ 628.451529] lustre_kcompr_9804: adecompr zstdfast(5) took 767 us (63 MB/s) [ 628.466441] lustre_kcompr_9804: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 628.577592] lustre_kcompr_9804: compr zstdfast(12) in 64kB chunks took 89341 us (44 MB/s), compress ratio: 1.43 [ 628.690778] lustre_kcompr_9804: compr zstdfast(12) in 128kB chunks took 93463 us (42 MB/s), compress ratio: 1.50 [ 628.863160] lustre_kcompr_9804: compr zstdfast(12) in 256kB chunks took 138903 us (28 MB/s), compress ratio: 1.62 [ 628.974701] lustre_kcompr_9804: compr zstdfast(12) in 512kB chunks took 98097 us (40 MB/s), compress ratio: 1.55 [ 629.092254] lustre_kcompr_9804: compr zstdfast(12) in 1024kB chunks took 89790 us (44 MB/s), compress ratio: 1.58 [ 629.154855] lustre_kcompr_9804: compr zstdfast(12) in 2048kB chunks took 49630 us (80 MB/s), compress ratio: 1.60 [ 629.254996] lustre_kcompr_9804: compr zstdfast(12) in 4096kB chunks took 86056 us (46 MB/s), compress ratio: 1.60 [ 629.291276] lustre_kcompr_9804: decompr zstdfast(12) took 19012 us (131 MB/s) [ 629.306597] lustre_kcompr_9804: test_comp_compress_decompress(zstdfast,12) ret 0 [ 629.322406] lustre_kcompr_9804: acompr zstdfast(12) of 128kB chunks took 3990 us (31 MB/s), compress ratio: 1.37 [ 629.332563] lustre_kcompr_9804: adecompr zstdfast(12) took 678 us (134 MB/s) [ 629.348585] lustre_kcompr_9804: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 629.425617] lustre_kcompr_9804: compr zstdfast(15) in 64kB chunks took 29915 us (133 MB/s), compress ratio: 1.12 [ 629.481385] lustre_kcompr_9804: compr zstdfast(15) in 128kB chunks took 35743 us (111 MB/s), compress ratio: 1.16 [ 629.521842] lustre_kcompr_9804: compr zstdfast(15) in 256kB chunks took 33341 us (119 MB/s), compress ratio: 1.22 [ 629.583539] lustre_kcompr_9804: compr zstdfast(15) in 512kB chunks took 39779 us (100 MB/s), compress ratio: 1.20 [ 629.672154] lustre_kcompr_9804: compr zstdfast(15) in 1024kB chunks took 57436 us (69 MB/s), compress ratio: 1.22 [ 629.746858] lustre_kcompr_9804: compr zstdfast(15) in 2048kB chunks took 39370 us (101 MB/s), compress ratio: 1.23 [ 629.840022] lustre_kcompr_9804: compr zstdfast(15) in 4096kB chunks took 80544 us (49 MB/s), compress ratio: 1.23 [ 629.904224] lustre_kcompr_9804: decompr zstdfast(15) took 34395 us (94 MB/s) [ 629.926134] lustre_kcompr_9804: test_comp_compress_decompress(zstdfast,15) ret 0 [ 629.934962] lustre_kcompr_9804: acompr zstdfast(15) of 128kB chunks took 1068 us (117 MB/s), compress ratio: 1.08 [ 629.947685] lustre_kcompr_9804: adecompr zstdfast(15) took 388 us (297 MB/s) [ 629.976084] lustre_kcompr_9804: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 629.985216] lustre_kcompr_9804: SUCCESS [ 638.020385] lustre_kcompr_30384: ***** [ 638.023123] lustre_kcompr_30384: (de)compression test on provided file /tmp/f84.sanity [ 638.025134] lustre_kcompr_30384: ***** [ 638.090420] lustre_kcompr_30384: compr lz4(1) in 64kB chunks took 23007 us (173 MB/s), compress ratio: 2.45 [ 638.117490] lustre_kcompr_30384: compr lz4(1) in 128kB chunks took 21060 us (189 MB/s), compress ratio: 2.39 [ 638.152297] lustre_kcompr_30384: compr lz4(1) in 256kB chunks took 28844 us (138 MB/s), compress ratio: 2.39 [ 638.201828] lustre_kcompr_30384: compr lz4(1) in 512kB chunks took 42837 us (93 MB/s), compress ratio: 2.39 [ 638.245496] lustre_kcompr_30384: compr lz4(1) in 1024kB chunks took 32180 us (124 MB/s), compress ratio: 2.39 [ 638.337302] lustre_kcompr_30384: compr lz4(1) in 2048kB chunks took 80654 us (49 MB/s), compress ratio: 2.39 [ 638.396395] lustre_kcompr_30384: compr lz4(1) in 4096kB chunks took 41546 us (96 MB/s), compress ratio: 2.39 [ 638.432498] lustre_kcompr_30384: decompr lz4(1) took 8961 us (186 MB/s) [ 638.445650] lustre_kcompr_30384: test_comp_compress_decompress(lz4,1) ret 0 [ 638.459305] lustre_kcompr_30384: acompr lz4(1) of 128kB chunks took 828 us (150 MB/s), compress ratio: 15.67 [ 638.469259] lustre_kcompr_30384: adecompr lz4(1) took 132 us (60 MB/s) [ 638.486334] lustre_kcompr_30384: test_acomp_compress_decompress(lz4,1) ret 0 [ 638.543854] lustre_kcompr_30384: compr lz4(4) in 64kB chunks took 9303 us (429 MB/s), compress ratio: 2.36 [ 638.567552] lustre_kcompr_30384: compr lz4(4) in 128kB chunks took 15718 us (254 MB/s), compress ratio: 2.35 [ 638.605431] lustre_kcompr_30384: compr lz4(4) in 256kB chunks took 24015 us (166 MB/s), compress ratio: 2.35 [ 638.636231] lustre_kcompr_30384: compr lz4(4) in 512kB chunks took 20445 us (195 MB/s), compress ratio: 2.35 [ 638.664514] lustre_kcompr_30384: compr lz4(4) in 1024kB chunks took 22575 us (177 MB/s), compress ratio: 2.35 [ 638.716915] lustre_kcompr_30384: compr lz4(4) in 2048kB chunks took 38924 us (102 MB/s), compress ratio: 2.35 [ 638.754354] lustre_kcompr_30384: compr lz4(4) in 4096kB chunks took 33957 us (117 MB/s), compress ratio: 2.35 [ 638.797581] lustre_kcompr_30384: decompr lz4(4) took 12772 us (133 MB/s) [ 638.811717] lustre_kcompr_30384: test_comp_compress_decompress(lz4,4) ret 0 [ 638.826102] lustre_kcompr_30384: acompr lz4(4) of 128kB chunks took 184 us (679 MB/s), compress ratio: 15.30 [ 638.836072] lustre_kcompr_30384: adecompr lz4(4) took 103 us (79 MB/s) [ 638.849236] lustre_kcompr_30384: test_acomp_compress_decompress(lz4,4) ret 0 [ 638.897772] lustre_kcompr_30384: compr lz4(9) in 64kB chunks took 11518 us (347 MB/s), compress ratio: 2.32 [ 638.922842] lustre_kcompr_30384: compr lz4(9) in 128kB chunks took 18532 us (215 MB/s), compress ratio: 2.31 [ 638.956189] lustre_kcompr_30384: compr lz4(9) in 256kB chunks took 21677 us (184 MB/s), compress ratio: 2.31 [ 638.984248] lustre_kcompr_30384: compr lz4(9) in 512kB chunks took 12980 us (308 MB/s), compress ratio: 2.31 [ 639.013428] lustre_kcompr_30384: compr lz4(9) in 1024kB chunks took 19104 us (209 MB/s), compress ratio: 2.31 [ 639.037087] lustre_kcompr_30384: compr lz4(9) in 2048kB chunks took 16755 us (238 MB/s), compress ratio: 2.32 [ 639.073354] lustre_kcompr_30384: compr lz4(9) in 4096kB chunks took 28126 us (142 MB/s), compress ratio: 2.32 [ 639.113681] lustre_kcompr_30384: decompr lz4(9) took 12417 us (138 MB/s) [ 639.126871] lustre_kcompr_30384: test_comp_compress_decompress(lz4,9) ret 0 [ 639.143752] lustre_kcompr_30384: acompr lz4(9) of 128kB chunks took 146 us (856 MB/s), compress ratio: 14.81 [ 639.154298] lustre_kcompr_30384: adecompr lz4(9) took 175 us (48 MB/s) [ 639.184368] lustre_kcompr_30384: test_acomp_compress_decompress(lz4,9) ret 0 [ 639.227790] lustre_kcompr_30384: compr lz4(15) in 64kB chunks took 18551 us (215 MB/s), compress ratio: 2.23 [ 639.264817] lustre_kcompr_30384: compr lz4(15) in 128kB chunks took 20745 us (192 MB/s), compress ratio: 2.23 [ 639.315617] lustre_kcompr_30384: compr lz4(15) in 256kB chunks took 25524 us (156 MB/s), compress ratio: 2.23 [ 639.359973] lustre_kcompr_30384: compr lz4(15) in 512kB chunks took 28113 us (142 MB/s), compress ratio: 2.23 [ 639.445265] lustre_kcompr_30384: compr lz4(15) in 1024kB chunks took 63796 us (62 MB/s), compress ratio: 2.23 [ 639.502599] lustre_kcompr_30384: compr lz4(15) in 2048kB chunks took 36354 us (110 MB/s), compress ratio: 2.23 [ 639.561077] lustre_kcompr_30384: compr lz4(15) in 4096kB chunks took 30063 us (133 MB/s), compress ratio: 2.23 [ 639.618142] lustre_kcompr_30384: decompr lz4(15) took 13810 us (129 MB/s) [ 639.629231] lustre_kcompr_30384: test_comp_compress_decompress(lz4,15) ret 0 [ 639.642620] lustre_kcompr_30384: acompr lz4(15) of 128kB chunks took 110 us (1136 MB/s), compress ratio: 14.18 [ 639.666845] lustre_kcompr_30384: adecompr lz4(15) took 11908 us (0 MB/s) [ 639.693352] lustre_kcompr_30384: test_acomp_compress_decompress(lz4,15) ret 0 [ 640.009607] lustre_kcompr_30384: compr lz4hc(1) in 64kB chunks took 286893 us (13 MB/s), compress ratio: 2.54 [ 640.319533] lustre_kcompr_30384: compr lz4hc(1) in 128kB chunks took 297549 us (13 MB/s), compress ratio: 2.61 [ 640.583804] lustre_kcompr_30384: compr lz4hc(1) in 256kB chunks took 249806 us (16 MB/s), compress ratio: 2.64 [ 641.011084] lustre_kcompr_30384: compr lz4hc(1) in 512kB chunks took 400493 us (9 MB/s), compress ratio: 2.66 [ 641.381340] lustre_kcompr_30384: compr lz4hc(1) in 1024kB chunks took 352659 us (11 MB/s), compress ratio: 2.67 [ 641.642890] lustre_kcompr_30384: compr lz4hc(1) in 2048kB chunks took 244902 us (16 MB/s), compress ratio: 2.67 [ 642.091608] lustre_kcompr_30384: compr lz4hc(1) in 4096kB chunks took 444077 us (9 MB/s), compress ratio: 2.67 [ 642.123841] lustre_kcompr_30384: decompr lz4hc(1) took 7576 us (197 MB/s) [ 642.130855] lustre_kcompr_30384: test_comp_compress_decompress(lz4hc,1) ret 0 [ 642.148365] lustre_kcompr_30384: acompr lz4hc(1) of 128kB chunks took 8527 us (14 MB/s), compress ratio: 15.97 [ 642.153654] lustre_kcompr_30384: adecompr lz4hc(1) took 162 us (48 MB/s) [ 642.167490] lustre_kcompr_30384: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 642.515439] lustre_kcompr_30384: compr lz4hc(3) in 64kB chunks took 297673 us (13 MB/s), compress ratio: 2.57 [ 642.917417] lustre_kcompr_30384: compr lz4hc(3) in 128kB chunks took 385520 us (10 MB/s), compress ratio: 2.64 [ 643.305196] lustre_kcompr_30384: compr lz4hc(3) in 256kB chunks took 371071 us (10 MB/s), compress ratio: 2.68 [ 643.720851] lustre_kcompr_30384: compr lz4hc(3) in 512kB chunks took 408939 us (9 MB/s), compress ratio: 2.69 [ 644.131384] lustre_kcompr_30384: compr lz4hc(3) in 1024kB chunks took 391576 us (10 MB/s), compress ratio: 2.70 [ 644.634062] lustre_kcompr_30384: compr lz4hc(3) in 2048kB chunks took 489743 us (8 MB/s), compress ratio: 2.71 [ 645.083335] lustre_kcompr_30384: compr lz4hc(3) in 4096kB chunks took 422912 us (9 MB/s), compress ratio: 2.71 [ 645.099666] lustre_kcompr_30384: decompr lz4hc(3) took 5878 us (250 MB/s) [ 645.105360] lustre_kcompr_30384: test_comp_compress_decompress(lz4hc,3) ret 0 [ 645.112439] lustre_kcompr_30384: acompr lz4hc(3) of 128kB chunks took 1646 us (75 MB/s), compress ratio: 16.00 [ 645.123993] lustre_kcompr_30384: adecompr lz4hc(3) took 168 us (46 MB/s) [ 645.136595] lustre_kcompr_30384: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 646.036450] lustre_kcompr_30384: compr lz4hc(8) in 64kB chunks took 840250 us (4 MB/s), compress ratio: 2.60 [ 647.244459] lustre_kcompr_30384: compr lz4hc(8) in 128kB chunks took 1201591 us (3 MB/s), compress ratio: 2.66 [ 648.121717] lustre_kcompr_30384: compr lz4hc(8) in 256kB chunks took 846928 us (4 MB/s), compress ratio: 2.70 [ 649.130465] lustre_kcompr_30384: compr lz4hc(8) in 512kB chunks took 1002468 us (3 MB/s), compress ratio: 2.71 [ 650.005649] lustre_kcompr_30384: compr lz4hc(8) in 1024kB chunks took 862782 us (4 MB/s), compress ratio: 2.72 [ 651.105679] lustre_kcompr_30384: compr lz4hc(8) in 2048kB chunks took 1086588 us (3 MB/s), compress ratio: 2.73 [ 652.260617] lustre_kcompr_30384: compr lz4hc(8) in 4096kB chunks took 1146789 us (3 MB/s), compress ratio: 2.73 [ 652.291163] lustre_kcompr_30384: decompr lz4hc(8) took 9237 us (158 MB/s) [ 652.308396] lustre_kcompr_30384: test_comp_compress_decompress(lz4hc,8) ret 0 [ 652.326891] lustre_kcompr_30384: acompr lz4hc(8) of 128kB chunks took 6354 us (19 MB/s), compress ratio: 16.17 [ 652.336223] lustre_kcompr_30384: adecompr lz4hc(8) took 148 us (52 MB/s) [ 652.392251] lustre_kcompr_30384: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 662.588097] lustre_kcompr_30384: compr lz4hc(15) in 64kB chunks took 10155311 us (0 MB/s), compress ratio: 2.61 [ 676.881463] lustre_kcompr_30384: compr lz4hc(15) in 128kB chunks took 14289327 us (0 MB/s), compress ratio: 2.67 [ 690.274373] lustre_kcompr_30384: compr lz4hc(15) in 256kB chunks took 13382615 us (0 MB/s), compress ratio: 2.71 [ 707.726335] lustre_kcompr_30384: compr lz4hc(15) in 512kB chunks took 17440255 us (0 MB/s), compress ratio: 2.72 [ 725.232329] lustre_kcompr_30384: compr lz4hc(15) in 1024kB chunks took 17495241 us (0 MB/s), compress ratio: 2.73 [ 743.384057] lustre_kcompr_30384: compr lz4hc(15) in 2048kB chunks took 18141690 us (0 MB/s), compress ratio: 2.74 [ 763.600107] lustre_kcompr_30384: compr lz4hc(15) in 4096kB chunks took 20193998 us (0 MB/s), compress ratio: 2.74 [ 763.611271] lustre_kcompr_30384: decompr lz4hc(15) took 3212 us (453 MB/s) [ 763.619662] lustre_kcompr_30384: test_comp_compress_decompress(lz4hc,15) ret 0 [ 763.682315] lustre_kcompr_30384: acompr lz4hc(15) of 128kB chunks took 59846 us (2 MB/s), compress ratio: 16.30 [ 763.700654] lustre_kcompr_30384: adecompr lz4hc(15) took 377 us (20 MB/s) [ 763.729339] lustre_kcompr_30384: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 763.756443] lustre_kcompr_30384: compr lzo(-1) in 64kB chunks took 18032 us (221 MB/s), compress ratio: 2.35 [ 763.786682] lustre_kcompr_30384: compr lzo(-1) in 128kB chunks took 24305 us (164 MB/s), compress ratio: 2.35 [ 763.808672] lustre_kcompr_30384: compr lzo(-1) in 256kB chunks took 17957 us (222 MB/s), compress ratio: 2.35 [ 763.828432] lustre_kcompr_30384: compr lzo(-1) in 512kB chunks took 15220 us (262 MB/s), compress ratio: 2.36 [ 763.868914] lustre_kcompr_30384: compr lzo(-1) in 1024kB chunks took 31744 us (126 MB/s), compress ratio: 2.36 [ 763.907910] lustre_kcompr_30384: compr lzo(-1) in 2048kB chunks took 24728 us (161 MB/s), compress ratio: 2.36 [ 763.934293] lustre_kcompr_30384: compr lzo(-1) in 4096kB chunks took 19979 us (200 MB/s), compress ratio: 2.36 [ 763.956165] lustre_kcompr_30384: decompr lzo(-1) took 7264 us (233 MB/s) [ 763.965671] lustre_kcompr_30384: test_comp_compress_decompress(lzo,-1) ret 0 [ 763.973402] lustre_kcompr_30384: acompr lzo(-1) of 128kB chunks took 370 us (337 MB/s), compress ratio: 15.45 [ 763.979359] lustre_kcompr_30384: adecompr lzo(-1) took 191 us (42 MB/s) [ 763.987129] lustre_kcompr_30384: test_acomp_compress_decompress(lzo,-1) ret 0 [ 764.596685] lustre_kcompr_30384: compr deflate(1) in 64kB chunks took 585899 us (6 MB/s), compress ratio: 3.27 [ 765.348575] lustre_kcompr_30384: compr deflate(1) in 128kB chunks took 747272 us (5 MB/s), compress ratio: 3.28 [ 766.345667] lustre_kcompr_30384: compr deflate(1) in 256kB chunks took 979358 us (4 MB/s), compress ratio: 3.28 [ 767.080197] lustre_kcompr_30384: compr deflate(1) in 512kB chunks took 726880 us (5 MB/s), compress ratio: 3.28 [ 768.229278] lustre_kcompr_30384: compr deflate(1) in 1024kB chunks took 1142518 us (3 MB/s), compress ratio: 3.28 [ 769.423807] lustre_kcompr_30384: compr deflate(1) in 2048kB chunks took 1180529 us (3 MB/s), compress ratio: 3.28 [ 770.147172] lustre_kcompr_30384: compr deflate(1) in 4096kB chunks took 704452 us (5 MB/s), compress ratio: 3.28 [ 770.218274] lustre_kcompr_30384: decompr deflate(1) took 50363 us (24 MB/s) [ 770.232105] lustre_kcompr_30384: test_comp_compress_decompress(deflate,1) ret 0 [ 770.267955] lustre_kcompr_30384: acompr deflate(1) of 128kB chunks took 28370 us (4 MB/s), compress ratio: 21.43 [ 770.274960] lustre_kcompr_30384: adecompr deflate(1) took 915 us (6 MB/s) [ 770.281543] lustre_kcompr_30384: test_acomp_compress_decompress(deflate,1) ret 0 [ 770.832744] lustre_kcompr_30384: compr deflate(6) in 64kB chunks took 538160 us (7 MB/s), compress ratio: 3.27 [ 771.496538] lustre_kcompr_30384: compr deflate(6) in 128kB chunks took 659035 us (6 MB/s), compress ratio: 3.28 [ 772.368144] lustre_kcompr_30384: compr deflate(6) in 256kB chunks took 863584 us (4 MB/s), compress ratio: 3.28 [ 773.348034] lustre_kcompr_30384: compr deflate(6) in 512kB chunks took 967697 us (4 MB/s), compress ratio: 3.28 [ 774.216245] lustre_kcompr_30384: compr deflate(6) in 1024kB chunks took 850068 us (4 MB/s), compress ratio: 3.28 [ 775.291816] lustre_kcompr_30384: compr deflate(6) in 2048kB chunks took 1063042 us (3 MB/s), compress ratio: 3.28 [ 776.440512] lustre_kcompr_30384: compr deflate(6) in 4096kB chunks took 1142204 us (3 MB/s), compress ratio: 3.28 [ 776.597334] lustre_kcompr_30384: decompr deflate(6) took 117696 us (10 MB/s) [ 776.615410] lustre_kcompr_30384: test_comp_compress_decompress(deflate,6) ret 0 [ 776.664724] lustre_kcompr_30384: acompr deflate(6) of 128kB chunks took 30568 us (4 MB/s), compress ratio: 21.43 [ 776.673273] lustre_kcompr_30384: adecompr deflate(6) took 381 us (15 MB/s) [ 776.689162] lustre_kcompr_30384: test_acomp_compress_decompress(deflate,6) ret 0 [ 777.744496] lustre_kcompr_30384: compr deflate(9) in 64kB chunks took 1019693 us (3 MB/s), compress ratio: 3.27 [ 778.604621] lustre_kcompr_30384: compr deflate(9) in 128kB chunks took 848957 us (4 MB/s), compress ratio: 3.28 [ 779.532368] lustre_kcompr_30384: compr deflate(9) in 256kB chunks took 919200 us (4 MB/s), compress ratio: 3.28 [ 780.309308] lustre_kcompr_30384: compr deflate(9) in 512kB chunks took 753523 us (5 MB/s), compress ratio: 3.28 [ 780.799195] lustre_kcompr_30384: compr deflate(9) in 1024kB chunks took 485047 us (8 MB/s), compress ratio: 3.28 [ 781.494652] lustre_kcompr_30384: compr deflate(9) in 2048kB chunks took 689634 us (5 MB/s), compress ratio: 3.28 [ 782.454981] lustre_kcompr_30384: compr deflate(9) in 4096kB chunks took 949986 us (4 MB/s), compress ratio: 3.28 [ 782.516868] lustre_kcompr_30384: decompr deflate(9) took 45199 us (26 MB/s) [ 782.536457] lustre_kcompr_30384: test_comp_compress_decompress(deflate,9) ret 0 [ 782.567354] lustre_kcompr_30384: acompr deflate(9) of 128kB chunks took 17456 us (7 MB/s), compress ratio: 21.43 [ 782.583855] lustre_kcompr_30384: adecompr deflate(9) took 1330 us (4 MB/s) [ 782.608704] lustre_kcompr_30384: test_acomp_compress_decompress(deflate,9) ret 0 [ 782.837713] lustre_kcompr_30384: compr zstd(0) in 64kB chunks took 203462 us (19 MB/s), compress ratio: 3.28 [ 783.113417] lustre_kcompr_30384: compr zstd(0) in 128kB chunks took 257226 us (15 MB/s), compress ratio: 3.26 [ 783.415476] lustre_kcompr_30384: compr zstd(0) in 256kB chunks took 289371 us (13 MB/s), compress ratio: 3.31 [ 783.764895] lustre_kcompr_30384: compr zstd(0) in 512kB chunks took 341748 us (11 MB/s), compress ratio: 3.32 [ 784.035304] lustre_kcompr_30384: compr zstd(0) in 1024kB chunks took 256096 us (15 MB/s), compress ratio: 3.32 [ 784.418866] lustre_kcompr_30384: compr zstd(0) in 2048kB chunks took 371208 us (10 MB/s), compress ratio: 3.33 [ 784.830938] lustre_kcompr_30384: compr zstd(0) in 4096kB chunks took 400683 us (9 MB/s), compress ratio: 3.33 [ 784.893392] lustre_kcompr_30384: decompr zstd(0) took 26269 us (45 MB/s) [ 784.904616] lustre_kcompr_30384: test_comp_compress_decompress(zstd,0) ret 0 [ 784.910571] lustre_kcompr_30384: acompr zstd(0) of 128kB chunks took 661 us (189 MB/s), compress ratio: 22.64 [ 784.919311] lustre_kcompr_30384: adecompr zstd(0) took 256 us (21 MB/s) [ 784.923760] lustre_kcompr_30384: test_acomp_compress_decompress(zstd,0) ret 0 [ 784.978459] lustre_kcompr_30384: compr zstd(1) in 64kB chunks took 35767 us (111 MB/s), compress ratio: 3.22 [ 785.010772] lustre_kcompr_30384: compr zstd(1) in 128kB chunks took 27163 us (147 MB/s), compress ratio: 3.18 [ 785.054329] lustre_kcompr_30384: compr zstd(1) in 256kB chunks took 37626 us (106 MB/s), compress ratio: 3.19 [ 785.177842] lustre_kcompr_30384: compr zstd(1) in 512kB chunks took 118398 us (33 MB/s), compress ratio: 3.19 [ 785.308711] lustre_kcompr_30384: compr zstd(1) in 1024kB chunks took 120823 us (33 MB/s), compress ratio: 3.19 [ 785.460833] lustre_kcompr_30384: compr zstd(1) in 2048kB chunks took 136907 us (29 MB/s), compress ratio: 3.19 [ 785.524404] lustre_kcompr_30384: compr zstd(1) in 4096kB chunks took 48423 us (82 MB/s), compress ratio: 3.19 [ 785.550074] lustre_kcompr_30384: decompr zstd(1) took 12921 us (97 MB/s) [ 785.569666] lustre_kcompr_30384: test_comp_compress_decompress(zstd,1) ret 0 [ 785.591936] lustre_kcompr_30384: acompr zstd(1) of 128kB chunks took 591 us (211 MB/s), compress ratio: 22.79 [ 785.609160] lustre_kcompr_30384: adecompr zstd(1) took 1572 us (3 MB/s) [ 785.625329] lustre_kcompr_30384: test_acomp_compress_decompress(zstd,1) ret 0 [ 786.864855] lustre_kcompr_30384: compr zstd(10) in 64kB chunks took 1207849 us (3 MB/s), compress ratio: 3.33 [ 788.226853] lustre_kcompr_30384: compr zstd(10) in 128kB chunks took 1323157 us (3 MB/s), compress ratio: 3.33 [ 790.193708] lustre_kcompr_30384: compr zstd(10) in 256kB chunks took 1953479 us (2 MB/s), compress ratio: 3.37 [ 791.636656] lustre_kcompr_30384: compr zstd(10) in 512kB chunks took 1413737 us (2 MB/s), compress ratio: 3.40 [ 792.596785] lustre_kcompr_30384: compr zstd(10) in 1024kB chunks took 941924 us (4 MB/s), compress ratio: 3.42 [ 793.550882] lustre_kcompr_30384: compr zstd(10) in 2048kB chunks took 925689 us (4 MB/s), compress ratio: 3.46 [ 794.541876] lustre_kcompr_30384: compr zstd(10) in 4096kB chunks took 987075 us (4 MB/s), compress ratio: 3.50 [ 794.639247] lustre_kcompr_30384: decompr zstd(10) took 82000 us (13 MB/s) [ 794.645674] lustre_kcompr_30384: test_comp_compress_decompress(zstd,10) ret 0 [ 794.654981] lustre_kcompr_30384: acompr zstd(10) of 128kB chunks took 1739 us (71 MB/s), compress ratio: 22.78 [ 794.660498] lustre_kcompr_30384: adecompr zstd(10) took 256 us (21 MB/s) [ 794.666346] lustre_kcompr_30384: test_acomp_compress_decompress(zstd,10) ret 0 [ 806.402440] lustre_kcompr_30384: compr zstd(15) in 64kB chunks took 11721662 us (0 MB/s), compress ratio: 3.36 [ 816.263037] lustre_kcompr_30384: compr zstd(15) in 128kB chunks took 9852208 us (0 MB/s), compress ratio: 3.39 [ 826.543332] lustre_kcompr_30384: compr zstd(15) in 256kB chunks took 10263802 us (0 MB/s), compress ratio: 3.40 [ 833.841181] lustre_kcompr_30384: compr zstd(15) in 512kB chunks took 7282811 us (0 MB/s), compress ratio: 3.42 [ 840.886038] lustre_kcompr_30384: compr zstd(15) in 1024kB chunks took 7027766 us (0 MB/s), compress ratio: 3.43 [ 846.918672] lustre_kcompr_30384: compr zstd(15) in 2048kB chunks took 6010711 us (0 MB/s), compress ratio: 3.48 [ 853.100280] lustre_kcompr_30384: compr zstd(15) in 4096kB chunks took 6170547 us (0 MB/s), compress ratio: 3.56 [ 853.143622] lustre_kcompr_30384: decompr zstd(15) took 33199 us (33 MB/s) [ 853.152642] lustre_kcompr_30384: test_comp_compress_decompress(zstd,15) ret 0 [ 853.211830] lustre_kcompr_30384: acompr zstd(15) of 128kB chunks took 48881 us (2 MB/s), compress ratio: 23.92 [ 853.217494] lustre_kcompr_30384: adecompr zstd(15) took 326 us (16 MB/s) [ 853.222754] lustre_kcompr_30384: test_acomp_compress_decompress(zstd,15) ret 0 [ 853.269600] lustre_kcompr_30384: compr zstdfast(1) in 64kB chunks took 32950 us (121 MB/s), compress ratio: 2.47 [ 853.300476] lustre_kcompr_30384: compr zstdfast(1) in 128kB chunks took 25043 us (159 MB/s), compress ratio: 2.48 [ 853.340766] lustre_kcompr_30384: compr zstdfast(1) in 256kB chunks took 35946 us (111 MB/s), compress ratio: 2.53 [ 853.372622] lustre_kcompr_30384: compr zstdfast(1) in 512kB chunks took 24428 us (163 MB/s), compress ratio: 2.42 [ 853.403519] lustre_kcompr_30384: compr zstdfast(1) in 1024kB chunks took 25269 us (158 MB/s), compress ratio: 2.42 [ 853.438713] lustre_kcompr_30384: compr zstdfast(1) in 2048kB chunks took 30365 us (131 MB/s), compress ratio: 2.42 [ 853.495329] lustre_kcompr_30384: compr zstdfast(1) in 4096kB chunks took 43170 us (92 MB/s), compress ratio: 2.42 [ 853.517759] lustre_kcompr_30384: decompr zstdfast(1) took 4985 us (330 MB/s) [ 853.540811] lustre_kcompr_30384: test_comp_compress_decompress(zstdfast,1) ret 0 [ 853.552078] lustre_kcompr_30384: acompr zstdfast(1) of 128kB chunks took 582 us (214 MB/s), compress ratio: 17.28 [ 853.571961] lustre_kcompr_30384: adecompr zstdfast(1) took 174 us (41 MB/s) [ 853.588319] lustre_kcompr_30384: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 853.661139] lustre_kcompr_30384: compr zstdfast(5) in 64kB chunks took 45690 us (87 MB/s), compress ratio: 2.38 [ 853.707893] lustre_kcompr_30384: compr zstdfast(5) in 128kB chunks took 37057 us (107 MB/s), compress ratio: 2.38 [ 853.745618] lustre_kcompr_30384: compr zstdfast(5) in 256kB chunks took 31655 us (126 MB/s), compress ratio: 2.40 [ 853.808728] lustre_kcompr_30384: compr zstdfast(5) in 512kB chunks took 45451 us (88 MB/s), compress ratio: 2.36 [ 853.880489] lustre_kcompr_30384: compr zstdfast(5) in 1024kB chunks took 55178 us (72 MB/s), compress ratio: 2.36 [ 853.921912] lustre_kcompr_30384: compr zstdfast(5) in 2048kB chunks took 27530 us (145 MB/s), compress ratio: 2.36 [ 853.952521] lustre_kcompr_30384: compr zstdfast(5) in 4096kB chunks took 25253 us (158 MB/s), compress ratio: 2.36 [ 853.979490] lustre_kcompr_30384: decompr zstdfast(5) took 7490 us (225 MB/s) [ 853.999105] lustre_kcompr_30384: test_comp_compress_decompress(zstdfast,5) ret 0 [ 854.009904] lustre_kcompr_30384: acompr zstdfast(5) of 128kB chunks took 2281 us (54 MB/s), compress ratio: 16.12 [ 854.017181] lustre_kcompr_30384: adecompr zstdfast(5) took 482 us (16 MB/s) [ 854.027621] lustre_kcompr_30384: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 854.048504] lustre_kcompr_30384: compr zstdfast(12) in 64kB chunks took 7242 us (552 MB/s), compress ratio: 2.07 [ 854.060733] lustre_kcompr_30384: compr zstdfast(12) in 128kB chunks took 8106 us (493 MB/s), compress ratio: 2.07 [ 854.074650] lustre_kcompr_30384: compr zstdfast(12) in 256kB chunks took 8854 us (451 MB/s), compress ratio: 2.08 [ 854.094791] lustre_kcompr_30384: compr zstdfast(12) in 512kB chunks took 11689 us (342 MB/s), compress ratio: 2.07 [ 854.150616] lustre_kcompr_30384: compr zstdfast(12) in 1024kB chunks took 38121 us (104 MB/s), compress ratio: 2.07 [ 854.169673] lustre_kcompr_30384: compr zstdfast(12) in 2048kB chunks took 9708 us (412 MB/s), compress ratio: 2.07 [ 854.200258] lustre_kcompr_30384: compr zstdfast(12) in 4096kB chunks took 15455 us (258 MB/s), compress ratio: 2.08 [ 854.223773] lustre_kcompr_30384: decompr zstdfast(12) took 3116 us (616 MB/s) [ 854.229580] lustre_kcompr_30384: test_comp_compress_decompress(zstdfast,12) ret 0 [ 854.236153] lustre_kcompr_30384: acompr zstdfast(12) of 128kB chunks took 362 us (345 MB/s), compress ratio: 13.13 [ 854.242213] lustre_kcompr_30384: adecompr zstdfast(12) took 277 us (34 MB/s) [ 854.248736] lustre_kcompr_30384: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 854.263812] lustre_kcompr_30384: compr zstdfast(15) in 64kB chunks took 5243 us (762 MB/s), compress ratio: 1.82 [ 854.277785] lustre_kcompr_30384: compr zstdfast(15) in 128kB chunks took 10375 us (385 MB/s), compress ratio: 1.83 [ 854.286408] lustre_kcompr_30384: compr zstdfast(15) in 256kB chunks took 4779 us (836 MB/s), compress ratio: 1.83 [ 854.295482] lustre_kcompr_30384: compr zstdfast(15) in 512kB chunks took 4680 us (854 MB/s), compress ratio: 1.83 [ 854.316946] lustre_kcompr_30384: compr zstdfast(15) in 1024kB chunks took 12415 us (322 MB/s), compress ratio: 1.83 [ 854.330773] lustre_kcompr_30384: compr zstdfast(15) in 2048kB chunks took 7284 us (549 MB/s), compress ratio: 1.83 [ 854.352559] lustre_kcompr_30384: compr zstdfast(15) in 4096kB chunks took 6277 us (637 MB/s), compress ratio: 1.84 [ 854.377716] lustre_kcompr_30384: decompr zstdfast(15) took 5500 us (394 MB/s) [ 854.386589] lustre_kcompr_30384: test_comp_compress_decompress(zstdfast,15) ret 0 [ 854.392330] lustre_kcompr_30384: acompr zstdfast(15) of 128kB chunks took 153 us (816 MB/s), compress ratio: 10.73 [ 854.400467] lustre_kcompr_30384: adecompr zstdfast(15) took 100 us (116 MB/s) [ 854.412310] lustre_kcompr_30384: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 854.417426] lustre_kcompr_30384: SUCCESS [ 880.616906] Lustre: DEBUG MARKER: == sanity test complete, duration 561 sec ================ 13:03:30 (1789059810) [ 883.692057] Lustre: DEBUG MARKER: === sanity: start cleanup 13:03:32 (1789059812) === [ 889.155509] Lustre: DEBUG MARKER: === sanity: finish cleanup 13:03:38 (1789059818) === [ 892.078742] LustreError: 13379:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff940091894000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 892.141905] Lustre: Unmounted lustre-client [ 925.998964] Key type lgssc unregistered [ 926.334176] LNet: 13863:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 926.346937] LNetError: 13863:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 926.361779] LNet: Removed LNI 192.168.202.11@tcp [ 927.118369] Key type .llcrypt unregistered [ 927.120408] Key type ._llcrypt unregistered