[ 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 443204687 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003071] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005013] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008018] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009012] pid_max: default: 32768 minimum: 301 [ 0.010129] LSM: Security Framework initializing [ 0.011052] Yama: becoming mindful. [ 0.012035] SELinux: Initializing. [ 0.013070] *** VALIDATE selinux *** [ 0.021436] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026374] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027158] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028100] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029096] *** VALIDATE tmpfs *** [ 0.031189] *** VALIDATE proc *** [ 0.032197] *** VALIDATE cgroup *** [ 0.033008] *** VALIDATE cgroup2 *** [ 0.034232] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035132] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037025] Spectre V2 : User space: Vulnerable [ 0.038008] Speculative Store Bypass: Vulnerable [ 0.041514] debug: unmapping init [mem 0xffffffffa1a59000-0xffffffffa1a60fff] [ 0.043164] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044701] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045021] ... version: 2 [ 0.046010] ... bit width: 48 [ 0.047008] ... generic registers: 4 [ 0.048008] ... value mask: 0000ffffffffffff [ 0.049011] ... max period: 00007fffffffffff [ 0.050011] ... fixed-purpose events: 3 [ 0.051010] ... event mask: 000000070000000f [ 0.052317] rcu: Hierarchical SRCU implementation. [ 0.054474] smp: Bringing up secondary CPUs ... [ 0.055618] x86: Booting SMP configuration: [ 0.056026] .... node #0, CPUs: #1 #2 #3 [ 0.059734] smp: Brought up 1 node, 4 CPUs [ 0.061012] smpboot: Max logical packages: 1 [ 0.062013] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.140692] node 0 deferred pages initialised in 76ms [ 0.142112] devtmpfs: initialized [ 0.143222] x86/mm: Memory block size: 128MB [ 0.145949] gcov: version magic: 0x41383552 [ 0.147345] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.148075] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.149387] pinctrl core: initialized pinctrl subsystem [ 0.150172] [ 0.150578] ************************************************************* [ 0.151013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.152013] ** ** [ 0.153013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.154013] ** ** [ 0.155012] ** This means that this kernel is built to expose internal ** [ 0.156010] ** IOMMU data structures, which may compromise security on ** [ 0.157013] ** your system. ** [ 0.158009] ** ** [ 0.159013] ** If you see this message and you are not debugging the ** [ 0.160016] ** kernel, report this immediately to your vendor! ** [ 0.161010] ** ** [ 0.162020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.163012] ************************************************************* [ 0.164745] NET: Registered protocol family 16 [ 0.165491] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.166062] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.167051] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.168490] cpuidle: using governor menu [ 0.171256] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.172406] PCI: Using configuration type 1 for base access [ 0.173132] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.179196] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.180043] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.182111] cryptd: max_cpu_qlen set to 1000 [ 0.184233] ACPI: Added _OSI(Module Device) [ 0.185015] ACPI: Added _OSI(Processor Device) [ 0.187011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.188015] ACPI: Added _OSI(Processor Aggregator Device) [ 0.193418] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.200566] ACPI: Interpreter enabled [ 0.201073] ACPI: PM: (supports S0 S3 S4 S5) [ 0.202016] ACPI: Using IOAPIC for interrupt routing [ 0.203082] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.204445] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.214652] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.215035] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.216017] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.217146] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.219508] acpiphp: Slot [2] registered [ 0.220102] acpiphp: Slot [5] registered [ 0.221107] acpiphp: Slot [6] registered [ 0.222084] acpiphp: Slot [3] registered [ 0.223124] acpiphp: Slot [4] registered [ 0.224079] acpiphp: Slot [7] registered [ 0.225076] acpiphp: Slot [8] registered [ 0.226087] acpiphp: Slot [9] registered [ 0.227090] acpiphp: Slot [10] registered [ 0.228083] acpiphp: Slot [11] registered [ 0.229089] acpiphp: Slot [12] registered [ 0.230121] acpiphp: Slot [13] registered [ 0.231082] acpiphp: Slot [14] registered [ 0.232089] acpiphp: Slot [15] registered [ 0.233117] acpiphp: Slot [16] registered [ 0.234077] acpiphp: Slot [17] registered [ 0.235075] acpiphp: Slot [18] registered [ 0.236102] acpiphp: Slot [19] registered [ 0.237095] acpiphp: Slot [20] registered [ 0.238075] acpiphp: Slot [21] registered [ 0.239089] acpiphp: Slot [22] registered [ 0.240140] acpiphp: Slot [23] registered [ 0.241078] acpiphp: Slot [24] registered [ 0.242100] acpiphp: Slot [25] registered [ 0.243088] acpiphp: Slot [26] registered [ 0.244082] acpiphp: Slot [27] registered [ 0.245072] acpiphp: Slot [28] registered [ 0.246072] acpiphp: Slot [29] registered [ 0.247069] acpiphp: Slot [30] registered [ 0.248131] acpiphp: Slot [31] registered [ 0.249047] PCI host bridge to bus 0000:00 [ 0.250015] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.251016] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.252016] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.253018] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.254017] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.255018] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.256149] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.257895] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.259345] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.263980] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.265942] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.266016] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.267017] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.268015] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.269539] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.270624] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.271034] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.272731] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.274758] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.279910] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.281013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.284678] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.294015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.306013] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.333017] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.348219] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.360015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.372014] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.402013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.421079] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.423372] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.427375] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.430346] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.433252] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.438070] iommu: Default domain type: Passthrough [ 0.440400] SCSI subsystem initialized [ 0.442132] ACPI: bus type USB registered [ 0.444125] usbcore: registered new interface driver usbfs [ 0.446083] usbcore: registered new interface driver hub [ 0.448131] usbcore: registered new device driver usb [ 0.450238] pps_core: LinuxPPS API ver. 1 registered [ 0.452012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.456056] PTP clock support registered [ 0.458052] EDAC MC: Ver: 3.0.0 [ 0.460191] PCI: Using ACPI for IRQ routing [ 0.462773] NetLabel: Initializing [ 0.464009] NetLabel: domain hash size = 128 [ 0.465009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.467076] NetLabel: unlabeled traffic allowed by default [ 0.470136] vgaarb: loaded [ 0.471255] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.473013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.480559] clocksource: Switched to clocksource kvm-clock [ 0.599784] VFS: Disk quotas dquot_6.6.0 [ 0.602162] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.605653] *** VALIDATE ramfs *** [ 0.607158] *** VALIDATE hugetlbfs *** [ 0.609299] pnp: PnP ACPI init [ 0.612767] pnp: PnP ACPI: found 6 devices [ 0.629644] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.633168] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.635509] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.637859] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.640351] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.642790] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.645719] NET: Registered protocol family 2 [ 0.648288] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.653636] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.657480] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.663036] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.666695] TCP: Hash tables configured (established 65536 bind 65536) [ 0.669655] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.672859] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.675928] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.678996] NET: Registered protocol family 1 [ 0.682077] RPC: Registered named UNIX socket transport module. [ 0.684281] RPC: Registered udp transport module. [ 0.686038] RPC: Registered tcp transport module. [ 0.687840] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.690508] NET: Registered protocol family 44 [ 0.692314] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.694661] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.696911] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.699114] PCI: CLS 0 bytes, default 64 [ 0.700885] Unpacking initramfs... [ 2.132515] debug: unmapping init [mem 0xffff9b51bcc64000-0xffff9b51bffcffff] [ 2.136863] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.139265] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.142310] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.643421] Initialise system trusted keyrings [ 2.645136] Key type blacklist registered [ 2.647035] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.659348] zbud: loaded [ 2.662470] *** VALIDATE nfs *** [ 2.663670] *** VALIDATE nfs4 *** [ 2.665234] pstore: using deflate compression [ 2.669289] Platform Keyring initialized [ 2.776277] NET: Registered protocol family 38 [ 2.780311] Key type asymmetric registered [ 2.782268] Asymmetric key parser 'x509' registered [ 2.784558] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.788439] io scheduler mq-deadline registered [ 2.790868] io scheduler kyber registered [ 2.792876] io scheduler bfq registered [ 2.794879] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.798261] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.802901] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.806099] ACPI: Power Button [PWRF] [ 2.812726] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.821957] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.832948] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.863679] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.893483] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.898937] Non-volatile memory driver v1.3 [ 2.900569] Linux agpgart interface v0.103 [ 2.933340] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 2.935725] vda: detected capacity change from 0 to 73097216 [ 2.955171] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.958337] vdb: detected capacity change from 0 to 1073741824 [ 2.968289] libphy: Fixed MDIO Bus: probed [ 2.973823] usbcore: registered new interface driver usbserial_generic [ 2.976032] usbserial: USB Serial support registered for generic [ 2.977954] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.981963] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.983853] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.986328] mousedev: PS/2 mouse device common for all mice [ 2.989444] rtc_cmos 00:05: RTC can wake from S4 [ 2.992861] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.996141] rtc_cmos 00:05: registered as rtc0 [ 2.997874] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.000848] intel_pstate: CPU model not supported [ 3.002181] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.008277] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.009985] hid: raw HID events driver (C) Jiri Kosina [ 3.013973] usbcore: registered new interface driver usbhid [ 3.016220] usbhid: USB HID core driver [ 3.017954] drop_monitor: Initializing network drop monitor service [ 3.020509] Initializing XFRM netlink socket [ 3.022559] NET: Registered protocol family 10 [ 3.026503] Segment Routing with IPv6 [ 3.028024] NET: Registered protocol family 17 [ 3.030298] mpls_gso: MPLS GSO support [ 3.035713] RAS: Correctable Errors collector initialized. [ 3.037802] AVX version of gcm_enc/dec engaged. [ 3.039770] AES CTR mode by8 optimization enabled [ 3.107430] sched_clock: Marking stable (3107409369, 0)->(4078588706, -971179337) [ 3.110326] registered taskstats version 1 [ 3.112442] Loading compiled-in X.509 certificates [ 3.114282] zswap: loaded using pool lzo/zbud [ 3.137920] Key type big_key registered [ 3.152087] Key type encrypted registered [ 3.154574] ima: No TPM chip found, activating TPM-bypass! [ 3.156750] ima: Allocated hash algorithm: sha1 [ 3.158420] ima: No architecture policies found [ 3.160326] evm: Initialising EVM extended attributes: [ 3.162339] evm: security.selinux [ 3.163547] evm: security.ima [ 3.165102] evm: security.capability [ 3.166691] evm: HMAC attrs: 0x1 [ 3.169194] rtc_cmos 00:05: setting system clock to 2026-09-10 16:29:43 UTC (1789057783) [ 3.175564] debug: unmapping init [mem 0xffffffffa2a03000-0xffffffffa2bfffff] [ 3.179856] debug: unmapping init [mem 0xffffffffa1782000-0xffffffffa1a58fff] [ 3.187259] Write protecting the kernel read-only data: 28672k [ 3.190491] debug: unmapping init [mem 0xffffffff9fe03000-0xffffffff9fffffff] [ 3.193395] debug: unmapping init [mem 0xffffffffa0714000-0xffffffffa07fffff] [ 3.226164] 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.234368] systemd[1]: Detected virtualization kvm. [ 3.236384] systemd[1]: Detected architecture x86-64. [ 3.238464] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.264304] systemd[1]: No hostname configured. [ 3.266408] systemd[1]: Set hostname to . [ 3.268616] random: systemd: uninitialized urandom read (16 bytes read) [ 3.270975] systemd[1]: Initializing machine ID from random generator. [ 3.424560] random: systemd: uninitialized urandom read (16 bytes read) [ 3.426939] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.431944] random: systemd: uninitialized urandom read (16 bytes read) [ 3.434669] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.439885] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Slices. [ OK ] Reached target Swap. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.196562] device-mapper: uevent: version 1.0.3 [ 4.198816] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 5.066099] virtio_net virtio0 ens2: renamed from eth0 [ 5.112751] scsi host0: ata_piix [ 5.134389] scsi host1: ata_piix [ 5.138359] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.141463] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.672270] random: crng init done [ 9.676076] random: 7 urandom warning(s) missed due to ratelimiting [ 9.678070] dracut-initqueue[589]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.302309] 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 target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target 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 Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.429759] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.685979] SELinux: Disabled at runtime. [ 11.748623] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.758323] systemd[1]: Detected virtualization kvm. [ 11.760554] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.307687] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.312189] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.318622] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.323949] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.328129] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.336225] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.342172] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. Mounting Huge Pages File System... Mounting Kernel Debug File System... Mounting POSIX Message Queue File System... Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Control Socket. Starting Apply Kernel Variables... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target Paths. [ OK ] Created slice system-serial\x2dgetty.slice. [ 12.466278] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ 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 ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.783142] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.044404] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.067456] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.164532] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.179924] EDAC sbridge: Ver: 1.1.2 [ 14.410226] Key type dns_resolver registered [ 14.734691] NFS: Registering the id_resolver key type [ 14.736807] Key type id_resolver registered [ 14.738342] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ 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 Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg321-client login: [ 65.768736] libcfs: loading out-of-tree module taints kernel. [ 66.148462] Key type ._llcrypt registered [ 66.156221] Key type .llcrypt registered [ 66.902717] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 66.956597] alg: No test for adler32 (adler32-zlib) [ 68.522454] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 69.492271] LNet: Added LNI 192.168.203.21@tcp [8/256/0/180] [ 71.423179] Key type lgssc registered [ 73.800345] Lustre: Echo OBD driver; http://www.lustre.org/ [ 75.058112] hrtimer: interrupt took 3213169 ns [ 84.028968] alg: No test for zstdfast (zstdfast-lustre-generic) [ 84.042688] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 238.397198] Lustre: Mounted lustre-client [ 243.278440] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 259.327790] Lustre: DEBUG MARKER: oleg321-client.virtnet: executing check_logdir /tmp/testlogs/ [ 262.929453] Lustre: DEBUG MARKER: oleg321-client.virtnet: executing yml_node [ 264.162269] Lustre: lustre-OST0000-osc-ffff9b5207e0e800: disconnect after 23s idle [ 267.334450] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 269.515335] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 271.490276] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 272.913315] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:34:12 EDT 2026 [ 288.376990] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 290.102790] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 291.508686] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a [ 292.993262] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51c 51e 834 [ 294.422445] Lustre: DEBUG MARKER: === sanity: start setup 12:34:33 (1789058073) === [ 298.114069] Lustre: DEBUG MARKER: oleg321-client.virtnet: executing check_config_client /mnt/lustre [ 317.244630] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 328.910172] Lustre: DEBUG MARKER: === sanity: finish setup 12:35:08 (1789058108) === [ 336.390642] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:35:15 (1789058115) [ 336.869992] lustre_kcompr_32603: ***** [ 336.874648] lustre_kcompr_32603: (de)compression test on random binary data [ 336.877670] lustre_kcompr_32603: ***** [ 336.887890] lustre_kcompr_32603: compr lz4(1) in 64kB chunks took 1567 us (2552 MB/s), compress ratio: 96.36 [ 336.894030] lustre_kcompr_32603: compr lz4(1) in 128kB chunks took 1701 us (2351 MB/s), compress ratio: 101.87 [ 336.898840] lustre_kcompr_32603: compr lz4(1) in 256kB chunks took 2181 us (1834 MB/s), compress ratio: 104.98 [ 336.904941] lustre_kcompr_32603: compr lz4(1) in 512kB chunks took 1572 us (2544 MB/s), compress ratio: 106.53 [ 336.912565] lustre_kcompr_32603: compr lz4(1) in 1024kB chunks took 1954 us (2047 MB/s), compress ratio: 107.32 [ 336.920312] lustre_kcompr_32603: compr lz4(1) in 2048kB chunks took 2747 us (1456 MB/s), compress ratio: 107.79 [ 336.926886] lustre_kcompr_32603: compr lz4(1) in 4096kB chunks took 2974 us (1344 MB/s), compress ratio: 107.98 [ 336.952908] lustre_kcompr_32603: decompr lz4(1) took 6036 us (6 MB/s) [ 336.959287] lustre_kcompr_32603: test_comp_compress_decompress(lz4,1) ret 0 [ 336.963710] lustre_kcompr_32603: acompr lz4(1) of 128kB chunks took 92 us (1358 MB/s), compress ratio: 110.98 [ 336.967987] lustre_kcompr_32603: adecompr lz4(1) took 167 us (6 MB/s) [ 336.973554] lustre_kcompr_32603: test_acomp_compress_decompress(lz4,1) ret 0 [ 336.983622] lustre_kcompr_32603: compr lz4(4) in 64kB chunks took 1791 us (2233 MB/s), compress ratio: 82.94 [ 336.988745] lustre_kcompr_32603: compr lz4(4) in 128kB chunks took 1196 us (3344 MB/s), compress ratio: 92.26 [ 337.000435] lustre_kcompr_32603: compr lz4(4) in 256kB chunks took 2064 us (1937 MB/s), compress ratio: 98.87 [ 337.010404] lustre_kcompr_32603: compr lz4(4) in 512kB chunks took 1916 us (2087 MB/s), compress ratio: 102.28 [ 337.020886] lustre_kcompr_32603: compr lz4(4) in 1024kB chunks took 3387 us (1180 MB/s), compress ratio: 104.25 [ 337.031635] lustre_kcompr_32603: compr lz4(4) in 2048kB chunks took 1934 us (2068 MB/s), compress ratio: 105.59 [ 337.045721] lustre_kcompr_32603: compr lz4(4) in 4096kB chunks took 2398 us (1668 MB/s), compress ratio: 106.08 [ 337.066847] lustre_kcompr_32603: decompr lz4(4) took 6509 us (5 MB/s) [ 337.072384] lustre_kcompr_32603: test_comp_compress_decompress(lz4,4) ret 0 [ 337.077845] lustre_kcompr_32603: acompr lz4(4) of 128kB chunks took 85 us (1470 MB/s), compress ratio: 95.88 [ 337.084837] lustre_kcompr_32603: adecompr lz4(4) took 97 us (13 MB/s) [ 337.123183] lustre_kcompr_32603: test_acomp_compress_decompress(lz4,4) ret 0 [ 337.152392] lustre_kcompr_32603: compr lz4(9) in 64kB chunks took 5534 us (722 MB/s), compress ratio: 60.97 [ 337.167679] lustre_kcompr_32603: compr lz4(9) in 128kB chunks took 3793 us (1054 MB/s), compress ratio: 74.79 [ 337.175448] lustre_kcompr_32603: compr lz4(9) in 256kB chunks took 1677 us (2385 MB/s), compress ratio: 86.02 [ 337.180746] lustre_kcompr_32603: compr lz4(9) in 512kB chunks took 1939 us (2062 MB/s), compress ratio: 92.37 [ 337.189933] lustre_kcompr_32603: compr lz4(9) in 1024kB chunks took 3993 us (1001 MB/s), compress ratio: 96.40 [ 337.199871] lustre_kcompr_32603: compr lz4(9) in 2048kB chunks took 2073 us (1929 MB/s), compress ratio: 99.11 [ 337.207936] lustre_kcompr_32603: compr lz4(9) in 4096kB chunks took 2145 us (1864 MB/s), compress ratio: 100.41 [ 337.221600] lustre_kcompr_32603: decompr lz4(9) took 1755 us (22 MB/s) [ 337.226203] lustre_kcompr_32603: test_comp_compress_decompress(lz4,9) ret 0 [ 337.230708] lustre_kcompr_32603: acompr lz4(9) of 128kB chunks took 81 us (1543 MB/s), compress ratio: 80.46 [ 337.235909] lustre_kcompr_32603: adecompr lz4(9) took 95 us (16 MB/s) [ 337.243252] lustre_kcompr_32603: test_acomp_compress_decompress(lz4,9) ret 0 [ 337.263395] lustre_kcompr_32603: compr lz4(15) in 64kB chunks took 1370 us (2919 MB/s), compress ratio: 29.52 [ 337.272253] lustre_kcompr_32603: compr lz4(15) in 128kB chunks took 2301 us (1738 MB/s), compress ratio: 44.10 [ 337.279282] lustre_kcompr_32603: compr lz4(15) in 256kB chunks took 1802 us (2219 MB/s), compress ratio: 59.56 [ 337.288274] lustre_kcompr_32603: compr lz4(15) in 512kB chunks took 1891 us (2115 MB/s), compress ratio: 72.51 [ 337.295428] lustre_kcompr_32603: compr lz4(15) in 1024kB chunks took 1974 us (2026 MB/s), compress ratio: 80.20 [ 337.302825] lustre_kcompr_32603: compr lz4(15) in 2048kB chunks took 1621 us (2467 MB/s), compress ratio: 85.91 [ 337.314908] lustre_kcompr_32603: compr lz4(15) in 4096kB chunks took 3016 us (1326 MB/s), compress ratio: 89.01 [ 337.340304] lustre_kcompr_32603: decompr lz4(15) took 3232 us (13 MB/s) [ 337.349707] lustre_kcompr_32603: test_comp_compress_decompress(lz4,15) ret 0 [ 337.356453] lustre_kcompr_32603: acompr lz4(15) of 128kB chunks took 112 us (1116 MB/s), compress ratio: 44.35 [ 337.364787] lustre_kcompr_32603: adecompr lz4(15) took 174 us (16 MB/s) [ 337.372686] lustre_kcompr_32603: test_acomp_compress_decompress(lz4,15) ret 0 [ 337.418027] lustre_kcompr_32603: compr lz4hc(1) in 64kB chunks took 34095 us (117 MB/s), compress ratio: 98.10 [ 337.455734] lustre_kcompr_32603: compr lz4hc(1) in 128kB chunks took 30223 us (132 MB/s), compress ratio: 104.11 [ 337.476848] lustre_kcompr_32603: compr lz4hc(1) in 256kB chunks took 17290 us (231 MB/s), compress ratio: 107.38 [ 337.502150] lustre_kcompr_32603: compr lz4hc(1) in 512kB chunks took 20769 us (192 MB/s), compress ratio: 109.11 [ 337.522197] lustre_kcompr_32603: compr lz4hc(1) in 1024kB chunks took 17006 us (235 MB/s), compress ratio: 110.00 [ 337.540937] lustre_kcompr_32603: compr lz4hc(1) in 2048kB chunks took 15907 us (251 MB/s), compress ratio: 110.45 [ 337.561750] lustre_kcompr_32603: compr lz4hc(1) in 4096kB chunks took 16871 us (237 MB/s), compress ratio: 110.67 [ 337.575388] lustre_kcompr_32603: decompr lz4hc(1) took 1376 us (26 MB/s) [ 337.579485] lustre_kcompr_32603: test_comp_compress_decompress(lz4hc,1) ret 0 [ 337.583706] lustre_kcompr_32603: acompr lz4hc(1) of 128kB chunks took 592 us (211 MB/s), compress ratio: 109.95 [ 337.587288] lustre_kcompr_32603: adecompr lz4hc(1) took 130 us (8 MB/s) [ 337.591189] lustre_kcompr_32603: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 337.628189] lustre_kcompr_32603: compr lz4hc(3) in 64kB chunks took 27900 us (143 MB/s), compress ratio: 98.45 [ 337.661974] lustre_kcompr_32603: compr lz4hc(3) in 128kB chunks took 30431 us (131 MB/s), compress ratio: 104.51 [ 337.720077] lustre_kcompr_32603: compr lz4hc(3) in 256kB chunks took 52440 us (76 MB/s), compress ratio: 107.80 [ 337.755653] lustre_kcompr_32603: compr lz4hc(3) in 512kB chunks took 30467 us (131 MB/s), compress ratio: 109.52 [ 337.795254] lustre_kcompr_32603: compr lz4hc(3) in 1024kB chunks took 34613 us (115 MB/s), compress ratio: 110.42 [ 337.835583] lustre_kcompr_32603: compr lz4hc(3) in 2048kB chunks took 37033 us (108 MB/s), compress ratio: 110.87 [ 337.897500] lustre_kcompr_32603: compr lz4hc(3) in 4096kB chunks took 55257 us (72 MB/s), compress ratio: 111.10 [ 337.926430] lustre_kcompr_32603: decompr lz4hc(3) took 3048 us (11 MB/s) [ 337.935224] lustre_kcompr_32603: test_comp_compress_decompress(lz4hc,3) ret 0 [ 337.954641] lustre_kcompr_32603: acompr lz4hc(3) of 128kB chunks took 904 us (138 MB/s), compress ratio: 110.32 [ 337.964676] lustre_kcompr_32603: adecompr lz4hc(3) took 89 us (12 MB/s) [ 337.983832] lustre_kcompr_32603: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 338.692359] lustre_kcompr_32603: compr lz4hc(8) in 64kB chunks took 682674 us (5 MB/s), compress ratio: 104.86 [ 339.243589] lustre_kcompr_32603: compr lz4hc(8) in 128kB chunks took 546374 us (7 MB/s), compress ratio: 112.12 [ 339.897218] lustre_kcompr_32603: compr lz4hc(8) in 256kB chunks took 647852 us (6 MB/s), compress ratio: 116.05 [ 340.422204] lustre_kcompr_32603: compr lz4hc(8) in 512kB chunks took 522217 us (7 MB/s), compress ratio: 118.11 [ 341.154155] lustre_kcompr_32603: compr lz4hc(8) in 1024kB chunks took 727799 us (5 MB/s), compress ratio: 119.16 [ 341.899756] lustre_kcompr_32603: compr lz4hc(8) in 2048kB chunks took 738544 us (5 MB/s), compress ratio: 119.69 [ 342.801985] lustre_kcompr_32603: compr lz4hc(8) in 4096kB chunks took 896132 us (4 MB/s), compress ratio: 119.94 [ 342.829836] lustre_kcompr_32603: decompr lz4hc(8) took 3669 us (9 MB/s) [ 342.838665] lustre_kcompr_32603: test_comp_compress_decompress(lz4hc,8) ret 0 [ 342.880813] lustre_kcompr_32603: acompr lz4hc(8) of 128kB chunks took 28437 us (4 MB/s), compress ratio: 117.76 [ 342.894381] lustre_kcompr_32603: adecompr lz4hc(8) took 126 us (8 MB/s) [ 342.904313] lustre_kcompr_32603: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 343.741871] lustre_kcompr_32603: compr lz4hc(15) in 64kB chunks took 820447 us (4 MB/s), compress ratio: 105.59 [ 344.813988] lustre_kcompr_32603: compr lz4hc(15) in 128kB chunks took 1068326 us (3 MB/s), compress ratio: 113.34 [ 346.040255] lustre_kcompr_32603: compr lz4hc(15) in 256kB chunks took 1201317 us (3 MB/s), compress ratio: 117.62 [ 346.859474] lustre_kcompr_32603: compr lz4hc(15) in 512kB chunks took 815431 us (4 MB/s), compress ratio: 119.86 [ 347.761908] lustre_kcompr_32603: compr lz4hc(15) in 1024kB chunks took 897528 us (4 MB/s), compress ratio: 120.99 [ 349.577171] lustre_kcompr_32603: compr lz4hc(15) in 2048kB chunks took 1790520 us (2 MB/s), compress ratio: 121.56 [ 350.177803] Lustre: lustre-OST0001-osc-ffff9b5207e0e800: disconnect after 21s idle [ 350.194431] Lustre: Skipped 1 previous similar message [ 350.712210] lustre_kcompr_32603: compr lz4hc(15) in 4096kB chunks took 1121241 us (3 MB/s), compress ratio: 121.85 [ 350.756310] lustre_kcompr_32603: decompr lz4hc(15) took 3436 us (9 MB/s) [ 350.766705] lustre_kcompr_32603: test_comp_compress_decompress(lz4hc,15) ret 0 [ 350.882478] lustre_kcompr_32603: acompr lz4hc(15) of 128kB chunks took 99125 us (1 MB/s), compress ratio: 118.50 [ 350.889797] lustre_kcompr_32603: adecompr lz4hc(15) took 106 us (9 MB/s) [ 350.956496] lustre_kcompr_32603: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 350.965712] lustre_kcompr_32603: compr lzo(-1) in 64kB chunks took 1893 us (2113 MB/s), compress ratio: 81.72 [ 350.973536] lustre_kcompr_32603: compr lzo(-1) in 128kB chunks took 2240 us (1785 MB/s), compress ratio: 87.37 [ 351.005452] lustre_kcompr_32603: compr lzo(-1) in 256kB chunks took 14147 us (282 MB/s), compress ratio: 87.26 [ 351.023182] lustre_kcompr_32603: compr lzo(-1) in 512kB chunks took 2662 us (1502 MB/s), compress ratio: 89.16 [ 351.038733] lustre_kcompr_32603: compr lzo(-1) in 1024kB chunks took 2607 us (1534 MB/s), compress ratio: 89.02 [ 351.054116] lustre_kcompr_32603: compr lzo(-1) in 2048kB chunks took 9935 us (402 MB/s), compress ratio: 88.80 [ 351.086519] lustre_kcompr_32603: compr lzo(-1) in 4096kB chunks took 5995 us (667 MB/s), compress ratio: 89.19 [ 351.123349] lustre_kcompr_32603: decompr lzo(-1) took 1814 us (24 MB/s) [ 351.127375] lustre_kcompr_32603: test_comp_compress_decompress(lzo,-1) ret 0 [ 351.137533] lustre_kcompr_32603: acompr lzo(-1) of 128kB chunks took 101 us (1237 MB/s), compress ratio: 92.69 [ 351.146413] lustre_kcompr_32603: adecompr lzo(-1) took 85 us (15 MB/s) [ 351.157743] lustre_kcompr_32603: test_acomp_compress_decompress(lzo,-1) ret 0 [ 351.857057] lustre_kcompr_32603: compr deflate(1) in 64kB chunks took 671632 us (5 MB/s), compress ratio: 98.48 [ 352.146596] lustre_kcompr_32603: compr deflate(1) in 128kB chunks took 282997 us (14 MB/s), compress ratio: 108.82 [ 352.890771] lustre_kcompr_32603: compr deflate(1) in 256kB chunks took 720468 us (5 MB/s), compress ratio: 115.35 [ 353.500973] lustre_kcompr_32603: compr deflate(1) in 512kB chunks took 594624 us (6 MB/s), compress ratio: 119.21 [ 354.043917] lustre_kcompr_32603: compr deflate(1) in 1024kB chunks took 534974 us (7 MB/s), compress ratio: 121.20 [ 354.641279] lustre_kcompr_32603: compr deflate(1) in 2048kB chunks took 589536 us (6 MB/s), compress ratio: 122.14 [ 355.495871] lustre_kcompr_32603: compr deflate(1) in 4096kB chunks took 843136 us (4 MB/s), compress ratio: 122.42 [ 355.543199] lustre_kcompr_32603: decompr deflate(1) took 18497 us (1 MB/s) [ 355.568978] lustre_kcompr_32603: test_comp_compress_decompress(deflate,1) ret 0 [ 355.626493] lustre_kcompr_32603: acompr deflate(1) of 128kB chunks took 38325 us (3 MB/s), compress ratio: 113.97 [ 355.652627] lustre_kcompr_32603: adecompr deflate(1) took 180 us (6 MB/s) [ 355.689332] lustre_kcompr_32603: test_acomp_compress_decompress(deflate,1) ret 0 [ 356.544792] lustre_kcompr_32603: compr deflate(6) in 64kB chunks took 825328 us (4 MB/s), compress ratio: 98.48 [ 357.329732] lustre_kcompr_32603: compr deflate(6) in 128kB chunks took 774558 us (5 MB/s), compress ratio: 108.82 [ 358.211307] lustre_kcompr_32603: compr deflate(6) in 256kB chunks took 845884 us (4 MB/s), compress ratio: 115.35 [ 358.869976] lustre_kcompr_32603: compr deflate(6) in 512kB chunks took 619782 us (6 MB/s), compress ratio: 119.21 [ 359.969553] lustre_kcompr_32603: compr deflate(6) in 1024kB chunks took 1083938 us (3 MB/s), compress ratio: 121.20 [ 360.955470] lustre_kcompr_32603: compr deflate(6) in 2048kB chunks took 956430 us (4 MB/s), compress ratio: 122.14 [ 361.868346] lustre_kcompr_32603: compr deflate(6) in 4096kB chunks took 906173 us (4 MB/s), compress ratio: 122.42 [ 361.937307] lustre_kcompr_32603: decompr deflate(6) took 20633 us (1 MB/s) [ 361.992645] lustre_kcompr_32603: test_comp_compress_decompress(deflate,6) ret 0 [ 362.038841] lustre_kcompr_32603: acompr deflate(6) of 128kB chunks took 28154 us (4 MB/s), compress ratio: 113.97 [ 362.050515] lustre_kcompr_32603: adecompr deflate(6) took 166 us (6 MB/s) [ 362.091565] lustre_kcompr_32603: test_acomp_compress_decompress(deflate,6) ret 0 [ 362.762238] lustre_kcompr_32603: compr deflate(9) in 64kB chunks took 644300 us (6 MB/s), compress ratio: 98.48 [ 363.822251] lustre_kcompr_32603: compr deflate(9) in 128kB chunks took 1045330 us (3 MB/s), compress ratio: 108.82 [ 364.694792] lustre_kcompr_32603: compr deflate(9) in 256kB chunks took 864721 us (4 MB/s), compress ratio: 115.35 [ 365.647765] lustre_kcompr_32603: compr deflate(9) in 512kB chunks took 898364 us (4 MB/s), compress ratio: 119.21 [ 366.468379] lustre_kcompr_32603: compr deflate(9) in 1024kB chunks took 814527 us (4 MB/s), compress ratio: 121.20 [ 367.398710] lustre_kcompr_32603: compr deflate(9) in 2048kB chunks took 919774 us (4 MB/s), compress ratio: 122.14 [ 368.243714] lustre_kcompr_32603: compr deflate(9) in 4096kB chunks took 834115 us (4 MB/s), compress ratio: 122.42 [ 368.282625] lustre_kcompr_32603: decompr deflate(9) took 17958 us (1 MB/s) [ 368.318361] lustre_kcompr_32603: test_comp_compress_decompress(deflate,9) ret 0 [ 368.367670] lustre_kcompr_32603: acompr deflate(9) of 128kB chunks took 36132 us (3 MB/s), compress ratio: 113.97 [ 368.373735] lustre_kcompr_32603: adecompr deflate(9) took 169 us (6 MB/s) [ 368.400740] lustre_kcompr_32603: test_acomp_compress_decompress(deflate,9) ret 0 [ 368.453201] lustre_kcompr_32603: compr zstd(0) in 64kB chunks took 16641 us (240 MB/s), compress ratio: 159.71 [ 368.541352] lustre_kcompr_32603: compr zstd(0) in 128kB chunks took 61379 us (65 MB/s), compress ratio: 193.46 [ 368.613261] lustre_kcompr_32603: compr zstd(0) in 256kB chunks took 59235 us (67 MB/s), compress ratio: 206.38 [ 368.712178] lustre_kcompr_32603: compr zstd(0) in 512kB chunks took 66515 us (60 MB/s), compress ratio: 212.30 [ 368.759281] lustre_kcompr_32603: compr zstd(0) in 1024kB chunks took 5638 us (709 MB/s), compress ratio: 216.55 [ 368.775455] lustre_kcompr_32603: compr zstd(0) in 2048kB chunks took 6885 us (580 MB/s), compress ratio: 218.13 [ 368.787833] lustre_kcompr_32603: compr zstd(0) in 4096kB chunks took 4009 us (997 MB/s), compress ratio: 217.81 [ 368.821921] lustre_kcompr_32603: decompr zstd(0) took 7996 us (2 MB/s) [ 368.828179] lustre_kcompr_32603: test_comp_compress_decompress(zstd,0) ret 0 [ 368.834910] lustre_kcompr_32603: acompr zstd(0) of 128kB chunks took 1276 us (97 MB/s), compress ratio: 212.09 [ 368.842315] lustre_kcompr_32603: adecompr zstd(0) took 112 us (5 MB/s) [ 368.861814] lustre_kcompr_32603: test_acomp_compress_decompress(zstd,0) ret 0 [ 368.908523] lustre_kcompr_32603: compr zstd(1) in 64kB chunks took 10991 us (363 MB/s), compress ratio: 158.76 [ 368.942657] lustre_kcompr_32603: compr zstd(1) in 128kB chunks took 15071 us (265 MB/s), compress ratio: 190.78 [ 368.967792] lustre_kcompr_32603: compr zstd(1) in 256kB chunks took 9152 us (437 MB/s), compress ratio: 203.06 [ 369.001583] lustre_kcompr_32603: compr zstd(1) in 512kB chunks took 20668 us (193 MB/s), compress ratio: 210.65 [ 369.032596] lustre_kcompr_32603: compr zstd(1) in 1024kB chunks took 12888 us (310 MB/s), compress ratio: 213.50 [ 369.076299] lustre_kcompr_32603: compr zstd(1) in 2048kB chunks took 1934 us (2068 MB/s), compress ratio: 215.13 [ 369.083529] lustre_kcompr_32603: compr zstd(1) in 4096kB chunks took 2551 us (1568 MB/s), compress ratio: 215.31 [ 369.104258] lustre_kcompr_32603: decompr zstd(1) took 6396 us (2 MB/s) [ 369.110606] lustre_kcompr_32603: test_comp_compress_decompress(zstd,1) ret 0 [ 369.120380] lustre_kcompr_32603: acompr zstd(1) of 128kB chunks took 158 us (791 MB/s), compress ratio: 199.50 [ 369.130212] lustre_kcompr_32603: adecompr zstd(1) took 115 us (5 MB/s) [ 369.138751] lustre_kcompr_32603: test_acomp_compress_decompress(zstd,1) ret 0 [ 369.471516] lustre_kcompr_32603: compr zstd(10) in 64kB chunks took 316662 us (12 MB/s), compress ratio: 162.30 [ 369.801237] lustre_kcompr_32603: compr zstd(10) in 128kB chunks took 318670 us (12 MB/s), compress ratio: 185.38 [ 370.056204] lustre_kcompr_32603: compr zstd(10) in 256kB chunks took 244594 us (16 MB/s), compress ratio: 197.51 [ 370.152804] lustre_kcompr_32603: compr zstd(10) in 512kB chunks took 92487 us (43 MB/s), compress ratio: 218.82 [ 370.444128] lustre_kcompr_32603: compr zstd(10) in 1024kB chunks took 283179 us (14 MB/s), compress ratio: 223.08 [ 370.855559] lustre_kcompr_32603: compr zstd(10) in 2048kB chunks took 397522 us (10 MB/s), compress ratio: 225.22 [ 370.945330] lustre_kcompr_32603: compr zstd(10) in 4096kB chunks took 73043 us (54 MB/s), compress ratio: 226.25 [ 370.968171] lustre_kcompr_32603: decompr zstd(10) took 5340 us (3 MB/s) [ 370.986556] lustre_kcompr_32603: test_comp_compress_decompress(zstd,10) ret 0 [ 371.006516] lustre_kcompr_32603: acompr zstd(10) of 128kB chunks took 7001 us (17 MB/s), compress ratio: 201.03 [ 371.024110] lustre_kcompr_32603: adecompr zstd(10) took 1554 us (0 MB/s) [ 371.057496] lustre_kcompr_32603: test_acomp_compress_decompress(zstd,10) ret 0 [ 372.251759] lustre_kcompr_32603: compr zstd(15) in 64kB chunks took 1167339 us (3 MB/s), compress ratio: 170.70 [ 372.788326] lustre_kcompr_32603: compr zstd(15) in 128kB chunks took 532884 us (7 MB/s), compress ratio: 197.61 [ 373.204791] lustre_kcompr_32603: compr zstd(15) in 256kB chunks took 408436 us (9 MB/s), compress ratio: 210.49 [ 373.657200] lustre_kcompr_32603: compr zstd(15) in 512kB chunks took 439993 us (9 MB/s), compress ratio: 218.29 [ 374.208876] lustre_kcompr_32603: compr zstd(15) in 1024kB chunks took 535986 us (7 MB/s), compress ratio: 220.55 [ 374.931094] lustre_kcompr_32603: compr zstd(15) in 2048kB chunks took 715983 us (5 MB/s), compress ratio: 220.63 [ 376.129464] lustre_kcompr_32603: compr zstd(15) in 4096kB chunks took 1192193 us (3 MB/s), compress ratio: 221.24 [ 376.140707] lustre_kcompr_32603: decompr zstd(15) took 1691 us (10 MB/s) [ 376.144130] lustre_kcompr_32603: test_comp_compress_decompress(zstd,15) ret 0 [ 376.165674] lustre_kcompr_32603: acompr zstd(15) of 128kB chunks took 18744 us (6 MB/s), compress ratio: 209.38 [ 376.176293] lustre_kcompr_32603: adecompr zstd(15) took 103 us (5 MB/s) [ 376.182699] lustre_kcompr_32603: test_acomp_compress_decompress(zstd,15) ret 0 [ 376.199327] lustre_kcompr_32603: compr zstdfast(1) in 64kB chunks took 3859 us (1036 MB/s), compress ratio: 158.74 [ 376.211019] lustre_kcompr_32603: compr zstdfast(1) in 128kB chunks took 2742 us (1458 MB/s), compress ratio: 190.63 [ 376.225646] lustre_kcompr_32603: compr zstdfast(1) in 256kB chunks took 5543 us (721 MB/s), compress ratio: 203.06 [ 376.238974] lustre_kcompr_32603: compr zstdfast(1) in 512kB chunks took 6542 us (611 MB/s), compress ratio: 210.65 [ 376.244870] lustre_kcompr_32603: compr zstdfast(1) in 1024kB chunks took 2147 us (1863 MB/s), compress ratio: 213.50 [ 376.253294] lustre_kcompr_32603: compr zstdfast(1) in 2048kB chunks took 2626 us (1523 MB/s), compress ratio: 215.13 [ 376.262939] lustre_kcompr_32603: compr zstdfast(1) in 4096kB chunks took 3475 us (1151 MB/s), compress ratio: 215.31 [ 376.282544] lustre_kcompr_32603: decompr zstdfast(1) took 3780 us (4 MB/s) [ 376.287579] lustre_kcompr_32603: test_comp_compress_decompress(zstdfast,1) ret 0 [ 376.292899] lustre_kcompr_32603: acompr zstdfast(1) of 128kB chunks took 142 us (880 MB/s), compress ratio: 199.50 [ 376.300611] lustre_kcompr_32603: adecompr zstdfast(1) took 155 us (4 MB/s) [ 376.307852] lustre_kcompr_32603: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 376.323333] lustre_kcompr_32603: compr zstdfast(5) in 64kB chunks took 4069 us (983 MB/s), compress ratio: 140.08 [ 376.332486] lustre_kcompr_32603: compr zstdfast(5) in 128kB chunks took 2870 us (1393 MB/s), compress ratio: 166.11 [ 376.340324] lustre_kcompr_32603: compr zstdfast(5) in 256kB chunks took 2093 us (1911 MB/s), compress ratio: 175.19 [ 376.345509] lustre_kcompr_32603: compr zstdfast(5) in 512kB chunks took 1995 us (2005 MB/s), compress ratio: 179.92 [ 376.350616] lustre_kcompr_32603: compr zstdfast(5) in 1024kB chunks took 1705 us (2346 MB/s), compress ratio: 182.85 [ 376.356341] lustre_kcompr_32603: compr zstdfast(5) in 2048kB chunks took 1874 us (2134 MB/s), compress ratio: 185.69 [ 376.361760] lustre_kcompr_32603: compr zstdfast(5) in 4096kB chunks took 2042 us (1958 MB/s), compress ratio: 185.05 [ 376.392366] lustre_kcompr_32603: decompr zstdfast(5) took 1753 us (12 MB/s) [ 376.408537] lustre_kcompr_32603: test_comp_compress_decompress(zstdfast,5) ret 0 [ 376.413882] lustre_kcompr_32603: acompr zstdfast(5) of 128kB chunks took 161 us (776 MB/s), compress ratio: 177.60 [ 376.423967] lustre_kcompr_32603: adecompr zstdfast(5) took 97 us (7 MB/s) [ 376.430490] lustre_kcompr_32603: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 376.447059] lustre_kcompr_32603: compr zstdfast(12) in 64kB chunks took 3695 us (1082 MB/s), compress ratio: 38.14 [ 376.453594] lustre_kcompr_32603: compr zstdfast(12) in 128kB chunks took 2301 us (1738 MB/s), compress ratio: 42.77 [ 376.460454] lustre_kcompr_32603: compr zstdfast(12) in 256kB chunks took 1994 us (2006 MB/s), compress ratio: 45.40 [ 376.466978] lustre_kcompr_32603: compr zstdfast(12) in 512kB chunks took 2505 us (1596 MB/s), compress ratio: 46.76 [ 376.473766] lustre_kcompr_32603: compr zstdfast(12) in 1024kB chunks took 1801 us (2220 MB/s), compress ratio: 47.46 [ 376.486994] lustre_kcompr_32603: compr zstdfast(12) in 2048kB chunks took 7858 us (509 MB/s), compress ratio: 47.84 [ 376.496494] lustre_kcompr_32603: compr zstdfast(12) in 4096kB chunks took 2183 us (1832 MB/s), compress ratio: 48.03 [ 376.512201] lustre_kcompr_32603: decompr zstdfast(12) took 3475 us (23 MB/s) [ 376.517916] lustre_kcompr_32603: test_comp_compress_decompress(zstdfast,12) ret 0 [ 376.521119] lustre_kcompr_32603: acompr zstdfast(12) of 128kB chunks took 340 us (367 MB/s), compress ratio: 47.19 [ 376.525882] lustre_kcompr_32603: adecompr zstdfast(12) took 111 us (23 MB/s) [ 376.537467] lustre_kcompr_32603: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 376.554201] lustre_kcompr_32603: compr zstdfast(15) in 64kB chunks took 3987 us (1003 MB/s), compress ratio: 19.27 [ 376.564790] lustre_kcompr_32603: compr zstdfast(15) in 128kB chunks took 2132 us (1876 MB/s), compress ratio: 19.99 [ 376.572575] lustre_kcompr_32603: compr zstdfast(15) in 256kB chunks took 2571 us (1555 MB/s), compress ratio: 20.80 [ 376.580879] lustre_kcompr_32603: compr zstdfast(15) in 512kB chunks took 1998 us (2002 MB/s), compress ratio: 22.20 [ 376.589915] lustre_kcompr_32603: compr zstdfast(15) in 1024kB chunks took 1951 us (2050 MB/s), compress ratio: 23.76 [ 376.598598] lustre_kcompr_32603: compr zstdfast(15) in 2048kB chunks took 1787 us (2238 MB/s), compress ratio: 23.20 [ 376.608364] lustre_kcompr_32603: compr zstdfast(15) in 4096kB chunks took 2584 us (1547 MB/s), compress ratio: 29.39 [ 376.624127] lustre_kcompr_32603: decompr zstdfast(15) took 1684 us (80 MB/s) [ 376.633047] lustre_kcompr_32603: test_comp_compress_decompress(zstdfast,15) ret 0 [ 376.637321] lustre_kcompr_32603: acompr zstdfast(15) of 128kB chunks took 323 us (386 MB/s), compress ratio: 20.29 [ 376.643798] lustre_kcompr_32603: adecompr zstdfast(15) took 115 us (53 MB/s) [ 376.649577] lustre_kcompr_32603: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 376.656559] lustre_kcompr_32603: SUCCESS [ 383.782160] lustre_kcompr_13060: ***** [ 383.787746] lustre_kcompr_13060: (de)compression test on provided file /tmp/f84.sanity [ 383.792529] lustre_kcompr_13060: ***** [ 383.835406] lustre_kcompr_13060: compr lz4(1) in 64kB chunks took 23005 us (173 MB/s), compress ratio: 2.93 [ 383.880150] lustre_kcompr_13060: compr lz4(1) in 128kB chunks took 38619 us (103 MB/s), compress ratio: 3.04 [ 383.936550] lustre_kcompr_13060: compr lz4(1) in 256kB chunks took 50514 us (79 MB/s), compress ratio: 3.08 [ 384.003962] lustre_kcompr_13060: compr lz4(1) in 512kB chunks took 59343 us (67 MB/s), compress ratio: 3.10 [ 384.072358] lustre_kcompr_13060: compr lz4(1) in 1024kB chunks took 55692 us (71 MB/s), compress ratio: 3.11 [ 384.141498] lustre_kcompr_13060: compr lz4(1) in 2048kB chunks took 55397 us (72 MB/s), compress ratio: 3.11 [ 384.211625] lustre_kcompr_13060: compr lz4(1) in 4096kB chunks took 58635 us (68 MB/s), compress ratio: 3.12 [ 384.238340] lustre_kcompr_13060: decompr lz4(1) took 5610 us (228 MB/s) [ 384.242958] lustre_kcompr_13060: test_comp_compress_decompress(lz4,1) ret 0 [ 384.250470] lustre_kcompr_13060: acompr lz4(1) of 128kB chunks took 1787 us (69 MB/s), compress ratio: 2.68 [ 384.255624] lustre_kcompr_13060: adecompr lz4(1) took 169 us (275 MB/s) [ 384.268361] lustre_kcompr_13060: test_acomp_compress_decompress(lz4,1) ret 0 [ 384.317554] lustre_kcompr_13060: compr lz4(4) in 64kB chunks took 23934 us (167 MB/s), compress ratio: 2.67 [ 384.352236] lustre_kcompr_13060: compr lz4(4) in 128kB chunks took 29244 us (136 MB/s), compress ratio: 2.63 [ 384.393655] lustre_kcompr_13060: compr lz4(4) in 256kB chunks took 35901 us (111 MB/s), compress ratio: 2.68 [ 384.438702] lustre_kcompr_13060: compr lz4(4) in 512kB chunks took 28819 us (138 MB/s), compress ratio: 2.71 [ 384.475902] lustre_kcompr_13060: compr lz4(4) in 1024kB chunks took 32567 us (122 MB/s), compress ratio: 2.72 [ 384.505289] lustre_kcompr_13060: compr lz4(4) in 2048kB chunks took 21975 us (182 MB/s), compress ratio: 2.72 [ 384.548855] lustre_kcompr_13060: compr lz4(4) in 4096kB chunks took 38162 us (104 MB/s), compress ratio: 2.73 [ 384.567224] lustre_kcompr_13060: decompr lz4(4) took 6719 us (217 MB/s) [ 384.576502] lustre_kcompr_13060: test_comp_compress_decompress(lz4,4) ret 0 [ 384.581850] lustre_kcompr_13060: acompr lz4(4) of 128kB chunks took 525 us (238 MB/s), compress ratio: 2.30 [ 384.587443] lustre_kcompr_13060: adecompr lz4(4) took 186 us (291 MB/s) [ 384.617912] lustre_kcompr_13060: test_acomp_compress_decompress(lz4,4) ret 0 [ 384.656534] lustre_kcompr_13060: compr lz4(9) in 64kB chunks took 21032 us (190 MB/s), compress ratio: 2.30 [ 384.693892] lustre_kcompr_13060: compr lz4(9) in 128kB chunks took 25494 us (156 MB/s), compress ratio: 2.15 [ 384.746627] lustre_kcompr_13060: compr lz4(9) in 256kB chunks took 34566 us (115 MB/s), compress ratio: 2.20 [ 384.784264] lustre_kcompr_13060: compr lz4(9) in 512kB chunks took 30329 us (131 MB/s), compress ratio: 2.23 [ 384.808248] lustre_kcompr_13060: compr lz4(9) in 1024kB chunks took 17831 us (224 MB/s), compress ratio: 2.25 [ 384.841774] lustre_kcompr_13060: compr lz4(9) in 2048kB chunks took 24138 us (165 MB/s), compress ratio: 2.25 [ 384.869263] lustre_kcompr_13060: compr lz4(9) in 4096kB chunks took 21834 us (183 MB/s), compress ratio: 2.26 [ 384.893650] lustre_kcompr_13060: decompr lz4(9) took 13353 us (132 MB/s) [ 384.898254] lustre_kcompr_13060: test_comp_compress_decompress(lz4,9) ret 0 [ 384.906621] lustre_kcompr_13060: acompr lz4(9) of 128kB chunks took 2106 us (59 MB/s), compress ratio: 1.87 [ 384.914464] lustre_kcompr_13060: adecompr lz4(9) took 276 us (241 MB/s) [ 384.927946] lustre_kcompr_13060: test_acomp_compress_decompress(lz4,9) ret 0 [ 384.971590] lustre_kcompr_13060: compr lz4(15) in 64kB chunks took 19492 us (205 MB/s), compress ratio: 1.63 [ 385.000049] lustre_kcompr_13060: compr lz4(15) in 128kB chunks took 20891 us (191 MB/s), compress ratio: 1.52 [ 385.039183] lustre_kcompr_13060: compr lz4(15) in 256kB chunks took 33250 us (120 MB/s), compress ratio: 1.56 [ 385.066901] lustre_kcompr_13060: compr lz4(15) in 512kB chunks took 22002 us (181 MB/s), compress ratio: 1.58 [ 385.093414] lustre_kcompr_13060: compr lz4(15) in 1024kB chunks took 15025 us (266 MB/s), compress ratio: 1.60 [ 385.114249] lustre_kcompr_13060: compr lz4(15) in 2048kB chunks took 17100 us (233 MB/s), compress ratio: 1.60 [ 385.143971] lustre_kcompr_13060: compr lz4(15) in 4096kB chunks took 19888 us (201 MB/s), compress ratio: 1.60 [ 385.164361] lustre_kcompr_13060: decompr lz4(15) took 2941 us (845 MB/s) [ 385.171296] lustre_kcompr_13060: test_comp_compress_decompress(lz4,15) ret 0 [ 385.176555] lustre_kcompr_13060: acompr lz4(15) of 128kB chunks took 308 us (405 MB/s), compress ratio: 1.33 [ 385.183516] lustre_kcompr_13060: adecompr lz4(15) took 160 us (587 MB/s) [ 385.189606] lustre_kcompr_13060: test_acomp_compress_decompress(lz4,15) ret 0 [ 385.372676] lustre_kcompr_13060: compr lz4hc(1) in 64kB chunks took 161103 us (24 MB/s), compress ratio: 3.58 [ 385.585393] lustre_kcompr_13060: compr lz4hc(1) in 128kB chunks took 205245 us (19 MB/s), compress ratio: 3.77 [ 385.835594] lustre_kcompr_13060: compr lz4hc(1) in 256kB chunks took 244292 us (16 MB/s), compress ratio: 3.88 [ 386.079480] lustre_kcompr_13060: compr lz4hc(1) in 512kB chunks took 238698 us (16 MB/s), compress ratio: 3.93 [ 386.381471] lustre_kcompr_13060: compr lz4hc(1) in 1024kB chunks took 294380 us (13 MB/s), compress ratio: 3.96 [ 386.534179] lustre_kcompr_13060: compr lz4hc(1) in 2048kB chunks took 134275 us (29 MB/s), compress ratio: 3.97 [ 386.749052] lustre_kcompr_13060: compr lz4hc(1) in 4096kB chunks took 210329 us (19 MB/s), compress ratio: 3.98 [ 386.795675] lustre_kcompr_13060: decompr lz4hc(1) took 19183 us (52 MB/s) [ 386.815001] lustre_kcompr_13060: test_comp_compress_decompress(lz4hc,1) ret 0 [ 386.846850] lustre_kcompr_13060: acompr lz4hc(1) of 128kB chunks took 15907 us (7 MB/s), compress ratio: 3.27 [ 386.867624] lustre_kcompr_13060: adecompr lz4hc(1) took 266 us (143 MB/s) [ 386.900880] lustre_kcompr_13060: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 387.178735] lustre_kcompr_13060: compr lz4hc(3) in 64kB chunks took 247296 us (16 MB/s), compress ratio: 3.68 [ 387.460390] lustre_kcompr_13060: compr lz4hc(3) in 128kB chunks took 254127 us (15 MB/s), compress ratio: 3.91 [ 387.655967] lustre_kcompr_13060: compr lz4hc(3) in 256kB chunks took 181673 us (22 MB/s), compress ratio: 4.04 [ 387.806243] lustre_kcompr_13060: compr lz4hc(3) in 512kB chunks took 146002 us (27 MB/s), compress ratio: 4.10 [ 387.984620] lustre_kcompr_13060: compr lz4hc(3) in 1024kB chunks took 171217 us (23 MB/s), compress ratio: 4.13 [ 388.328178] lustre_kcompr_13060: compr lz4hc(3) in 2048kB chunks took 337008 us (11 MB/s), compress ratio: 4.15 [ 388.543332] lustre_kcompr_13060: compr lz4hc(3) in 4096kB chunks took 208542 us (19 MB/s), compress ratio: 4.16 [ 388.578515] lustre_kcompr_13060: decompr lz4hc(3) took 10914 us (88 MB/s) [ 388.584428] lustre_kcompr_13060: test_comp_compress_decompress(lz4hc,3) ret 0 [ 388.597027] lustre_kcompr_13060: acompr lz4hc(3) of 128kB chunks took 4894 us (25 MB/s), compress ratio: 3.38 [ 388.601931] lustre_kcompr_13060: adecompr lz4hc(3) took 260 us (141 MB/s) [ 388.605836] lustre_kcompr_13060: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 388.832379] lustre_kcompr_13060: compr lz4hc(8) in 64kB chunks took 217657 us (18 MB/s), compress ratio: 3.72 [ 389.103472] lustre_kcompr_13060: compr lz4hc(8) in 128kB chunks took 266165 us (15 MB/s), compress ratio: 3.96 [ 389.430100] lustre_kcompr_13060: compr lz4hc(8) in 256kB chunks took 317653 us (12 MB/s), compress ratio: 4.10 [ 389.948958] lustre_kcompr_13060: compr lz4hc(8) in 512kB chunks took 510172 us (7 MB/s), compress ratio: 4.17 [ 390.531545] lustre_kcompr_13060: compr lz4hc(8) in 1024kB chunks took 570114 us (7 MB/s), compress ratio: 4.21 [ 391.170243] lustre_kcompr_13060: compr lz4hc(8) in 2048kB chunks took 622091 us (6 MB/s), compress ratio: 4.22 [ 391.643933] lustre_kcompr_13060: compr lz4hc(8) in 4096kB chunks took 458379 us (8 MB/s), compress ratio: 4.23 [ 391.684924] lustre_kcompr_13060: decompr lz4hc(8) took 13199 us (71 MB/s) [ 391.690593] lustre_kcompr_13060: test_comp_compress_decompress(lz4hc,8) ret 0 [ 391.712815] lustre_kcompr_13060: acompr lz4hc(8) of 128kB chunks took 14745 us (8 MB/s), compress ratio: 3.42 [ 391.727764] lustre_kcompr_13060: adecompr lz4hc(8) took 2475 us (14 MB/s) [ 391.738691] lustre_kcompr_13060: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 392.132995] lustre_kcompr_13060: compr lz4hc(15) in 64kB chunks took 379169 us (10 MB/s), compress ratio: 3.72 [ 392.617834] lustre_kcompr_13060: compr lz4hc(15) in 128kB chunks took 477974 us (8 MB/s), compress ratio: 3.96 [ 393.150129] lustre_kcompr_13060: compr lz4hc(15) in 256kB chunks took 520965 us (7 MB/s), compress ratio: 4.10 [ 393.837824] lustre_kcompr_13060: compr lz4hc(15) in 512kB chunks took 675985 us (5 MB/s), compress ratio: 4.17 [ 394.450184] lustre_kcompr_13060: compr lz4hc(15) in 1024kB chunks took 600830 us (6 MB/s), compress ratio: 4.21 [ 395.172738] lustre_kcompr_13060: compr lz4hc(15) in 2048kB chunks took 714146 us (5 MB/s), compress ratio: 4.22 [ 395.797229] lustre_kcompr_13060: compr lz4hc(15) in 4096kB chunks took 617231 us (6 MB/s), compress ratio: 4.23 [ 395.827091] lustre_kcompr_13060: decompr lz4hc(15) took 11246 us (84 MB/s) [ 395.838791] lustre_kcompr_13060: test_comp_compress_decompress(lz4hc,15) ret 0 [ 395.864250] lustre_kcompr_13060: acompr lz4hc(15) of 128kB chunks took 14521 us (8 MB/s), compress ratio: 3.42 [ 395.874415] lustre_kcompr_13060: adecompr lz4hc(15) took 492 us (74 MB/s) [ 395.889199] lustre_kcompr_13060: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 395.980479] lustre_kcompr_13060: compr lzo(-1) in 64kB chunks took 69492 us (57 MB/s), compress ratio: 2.90 [ 396.038608] lustre_kcompr_13060: compr lzo(-1) in 128kB chunks took 46343 us (86 MB/s), compress ratio: 2.95 [ 396.079302] lustre_kcompr_13060: compr lzo(-1) in 256kB chunks took 30312 us (131 MB/s), compress ratio: 2.96 [ 396.127600] lustre_kcompr_13060: compr lzo(-1) in 512kB chunks took 39477 us (101 MB/s), compress ratio: 2.98 [ 396.172699] lustre_kcompr_13060: compr lzo(-1) in 1024kB chunks took 37729 us (106 MB/s), compress ratio: 2.97 [ 396.207889] lustre_kcompr_13060: compr lzo(-1) in 2048kB chunks took 27424 us (145 MB/s), compress ratio: 2.97 [ 396.255360] lustre_kcompr_13060: compr lzo(-1) in 4096kB chunks took 37879 us (105 MB/s), compress ratio: 2.96 [ 396.295747] lustre_kcompr_13060: decompr lzo(-1) took 13387 us (100 MB/s) [ 396.301662] lustre_kcompr_13060: test_comp_compress_decompress(lzo,-1) ret 0 [ 396.311441] lustre_kcompr_13060: acompr lzo(-1) of 128kB chunks took 2087 us (59 MB/s), compress ratio: 2.62 [ 396.318521] lustre_kcompr_13060: adecompr lzo(-1) took 776 us (61 MB/s) [ 396.329387] lustre_kcompr_13060: test_acomp_compress_decompress(lzo,-1) ret 0 [ 397.087925] lustre_kcompr_13060: compr deflate(1) in 64kB chunks took 739608 us (5 MB/s), compress ratio: 3.51 [ 397.749492] lustre_kcompr_13060: compr deflate(1) in 128kB chunks took 654757 us (6 MB/s), compress ratio: 3.53 [ 398.451715] lustre_kcompr_13060: compr deflate(1) in 256kB chunks took 684891 us (5 MB/s), compress ratio: 3.53 [ 399.076584] lustre_kcompr_13060: compr deflate(1) in 512kB chunks took 620471 us (6 MB/s), compress ratio: 3.54 [ 399.751825] lustre_kcompr_13060: compr deflate(1) in 1024kB chunks took 662594 us (6 MB/s), compress ratio: 3.54 [ 400.492925] lustre_kcompr_13060: compr deflate(1) in 2048kB chunks took 735107 us (5 MB/s), compress ratio: 3.54 [ 401.280523] lustre_kcompr_13060: compr deflate(1) in 4096kB chunks took 775134 us (5 MB/s), compress ratio: 3.54 [ 401.346522] lustre_kcompr_13060: decompr deflate(1) took 44393 us (25 MB/s) [ 401.354545] lustre_kcompr_13060: test_comp_compress_decompress(deflate,1) ret 0 [ 401.384923] lustre_kcompr_13060: acompr deflate(1) of 128kB chunks took 24068 us (5 MB/s), compress ratio: 3.09 [ 401.398776] lustre_kcompr_13060: adecompr deflate(1) took 2291 us (17 MB/s) [ 401.410928] lustre_kcompr_13060: test_acomp_compress_decompress(deflate,1) ret 0 [ 402.225942] lustre_kcompr_13060: compr deflate(6) in 64kB chunks took 802143 us (4 MB/s), compress ratio: 3.51 [ 402.952201] lustre_kcompr_13060: compr deflate(6) in 128kB chunks took 706788 us (5 MB/s), compress ratio: 3.53 [ 403.729953] lustre_kcompr_13060: compr deflate(6) in 256kB chunks took 768853 us (5 MB/s), compress ratio: 3.53 [ 404.512370] lustre_kcompr_13060: compr deflate(6) in 512kB chunks took 768956 us (5 MB/s), compress ratio: 3.54 [ 405.261868] lustre_kcompr_13060: compr deflate(6) in 1024kB chunks took 740925 us (5 MB/s), compress ratio: 3.54 [ 406.189847] lustre_kcompr_13060: compr deflate(6) in 2048kB chunks took 918024 us (4 MB/s), compress ratio: 3.54 [ 406.973835] lustre_kcompr_13060: compr deflate(6) in 4096kB chunks took 764015 us (5 MB/s), compress ratio: 3.54 [ 407.054788] lustre_kcompr_13060: decompr deflate(6) took 63804 us (17 MB/s) [ 407.062201] lustre_kcompr_13060: test_comp_compress_decompress(deflate,6) ret 0 [ 407.084237] lustre_kcompr_13060: acompr deflate(6) of 128kB chunks took 15015 us (8 MB/s), compress ratio: 3.09 [ 407.091877] lustre_kcompr_13060: adecompr deflate(6) took 1566 us (25 MB/s) [ 407.114236] lustre_kcompr_13060: test_acomp_compress_decompress(deflate,6) ret 0 [ 407.712370] lustre_kcompr_13060: compr deflate(9) in 64kB chunks took 567417 us (7 MB/s), compress ratio: 3.51 [ 408.357140] lustre_kcompr_13060: compr deflate(9) in 128kB chunks took 634847 us (6 MB/s), compress ratio: 3.53 [ 409.028259] lustre_kcompr_13060: compr deflate(9) in 256kB chunks took 663275 us (6 MB/s), compress ratio: 3.53 [ 409.676423] lustre_kcompr_13060: compr deflate(9) in 512kB chunks took 638100 us (6 MB/s), compress ratio: 3.54 [ 410.365846] lustre_kcompr_13060: compr deflate(9) in 1024kB chunks took 680417 us (5 MB/s), compress ratio: 3.54 [ 411.007882] lustre_kcompr_13060: compr deflate(9) in 2048kB chunks took 635411 us (6 MB/s), compress ratio: 3.54 [ 411.641719] lustre_kcompr_13060: compr deflate(9) in 4096kB chunks took 620588 us (6 MB/s), compress ratio: 3.54 [ 411.708338] lustre_kcompr_13060: decompr deflate(9) took 48559 us (23 MB/s) [ 411.720067] lustre_kcompr_13060: test_comp_compress_decompress(deflate,9) ret 0 [ 411.758317] lustre_kcompr_13060: acompr deflate(9) of 128kB chunks took 27037 us (4 MB/s), compress ratio: 3.09 [ 411.778394] lustre_kcompr_13060: adecompr deflate(9) took 2949 us (13 MB/s) [ 411.806501] lustre_kcompr_13060: test_acomp_compress_decompress(deflate,9) ret 0 [ 411.957716] lustre_kcompr_13060: compr zstd(0) in 64kB chunks took 130476 us (30 MB/s), compress ratio: 4.28 [ 412.055403] lustre_kcompr_13060: compr zstd(0) in 128kB chunks took 87941 us (45 MB/s), compress ratio: 4.46 [ 412.173589] lustre_kcompr_13060: compr zstd(0) in 256kB chunks took 111448 us (35 MB/s), compress ratio: 4.61 [ 412.334828] lustre_kcompr_13060: compr zstd(0) in 512kB chunks took 153076 us (26 MB/s), compress ratio: 4.72 [ 412.490816] lustre_kcompr_13060: compr zstd(0) in 1024kB chunks took 147573 us (27 MB/s), compress ratio: 4.80 [ 412.659614] lustre_kcompr_13060: compr zstd(0) in 2048kB chunks took 160901 us (24 MB/s), compress ratio: 4.85 [ 412.867774] lustre_kcompr_13060: compr zstd(0) in 4096kB chunks took 201484 us (19 MB/s), compress ratio: 4.88 [ 412.918604] lustre_kcompr_13060: decompr zstd(0) took 35091 us (23 MB/s) [ 412.922771] lustre_kcompr_13060: test_comp_compress_decompress(zstd,0) ret 0 [ 412.931218] lustre_kcompr_13060: acompr zstd(0) of 128kB chunks took 2901 us (43 MB/s), compress ratio: 3.98 [ 412.937126] lustre_kcompr_13060: adecompr zstd(0) took 824 us (38 MB/s) [ 412.950796] lustre_kcompr_13060: test_acomp_compress_decompress(zstd,0) ret 0 [ 413.057681] lustre_kcompr_13060: compr zstd(1) in 64kB chunks took 73924 us (54 MB/s), compress ratio: 4.06 [ 413.134858] lustre_kcompr_13060: compr zstd(1) in 128kB chunks took 67846 us (58 MB/s), compress ratio: 4.20 [ 413.212673] lustre_kcompr_13060: compr zstd(1) in 256kB chunks took 71512 us (55 MB/s), compress ratio: 4.34 [ 413.334380] lustre_kcompr_13060: compr zstd(1) in 512kB chunks took 116397 us (34 MB/s), compress ratio: 4.34 [ 413.451025] lustre_kcompr_13060: compr zstd(1) in 1024kB chunks took 96760 us (41 MB/s), compress ratio: 4.37 [ 413.565963] lustre_kcompr_13060: compr zstd(1) in 2048kB chunks took 107647 us (37 MB/s), compress ratio: 4.39 [ 413.659317] lustre_kcompr_13060: compr zstd(1) in 4096kB chunks took 87070 us (45 MB/s), compress ratio: 4.40 [ 413.716979] lustre_kcompr_13060: decompr zstd(1) took 34348 us (26 MB/s) [ 413.724903] lustre_kcompr_13060: test_comp_compress_decompress(zstd,1) ret 0 [ 413.735976] lustre_kcompr_13060: acompr zstd(1) of 128kB chunks took 2020 us (61 MB/s), compress ratio: 3.73 [ 413.743179] lustre_kcompr_13060: adecompr zstd(1) took 555 us (60 MB/s) [ 413.752951] lustre_kcompr_13060: test_acomp_compress_decompress(zstd,1) ret 0 [ 414.775263] lustre_kcompr_13060: compr zstd(10) in 64kB chunks took 1008851 us (3 MB/s), compress ratio: 4.80 [ 415.905873] lustre_kcompr_13060: compr zstd(10) in 128kB chunks took 1124452 us (3 MB/s), compress ratio: 5.09 [ 417.407156] lustre_kcompr_13060: compr zstd(10) in 256kB chunks took 1492410 us (2 MB/s), compress ratio: 5.34 [ 418.385926] lustre_kcompr_13060: compr zstd(10) in 512kB chunks took 971325 us (4 MB/s), compress ratio: 5.45 [ 419.495902] lustre_kcompr_13060: compr zstd(10) in 1024kB chunks took 1104609 us (3 MB/s), compress ratio: 5.62 [ 420.675515] lustre_kcompr_13060: compr zstd(10) in 2048kB chunks took 1173845 us (3 MB/s), compress ratio: 5.76 [ 422.116173] lustre_kcompr_13060: compr zstd(10) in 4096kB chunks took 1427114 us (2 MB/s), compress ratio: 5.89 [ 422.174678] lustre_kcompr_13060: decompr zstd(10) took 40167 us (16 MB/s) [ 422.181574] lustre_kcompr_13060: test_comp_compress_decompress(zstd,10) ret 0 [ 422.238387] lustre_kcompr_13060: acompr zstd(10) of 128kB chunks took 47282 us (2 MB/s), compress ratio: 4.46 [ 422.245676] lustre_kcompr_13060: adecompr zstd(10) took 1615 us (17 MB/s) [ 422.251810] lustre_kcompr_13060: test_acomp_compress_decompress(zstd,10) ret 0 [ 435.312747] lustre_kcompr_13060: compr zstd(15) in 64kB chunks took 13049813 us (0 MB/s), compress ratio: 4.96 [ 450.691825] lustre_kcompr_13060: compr zstd(15) in 128kB chunks took 15374724 us (0 MB/s), compress ratio: 5.28 [ 463.008270] lustre_kcompr_13060: compr zstd(15) in 256kB chunks took 12302859 us (0 MB/s), compress ratio: 5.57 [ 473.352499] lustre_kcompr_13060: compr zstd(15) in 512kB chunks took 10337053 us (0 MB/s), compress ratio: 5.83 [ 482.819266] lustre_kcompr_13060: compr zstd(15) in 1024kB chunks took 9462316 us (0 MB/s), compress ratio: 6.06 [ 492.503053] lustre_kcompr_13060: compr zstd(15) in 2048kB chunks took 9678143 us (0 MB/s), compress ratio: 6.26 [ 504.632709] lustre_kcompr_13060: compr zstd(15) in 4096kB chunks took 12120742 us (0 MB/s), compress ratio: 6.46 [ 504.681110] lustre_kcompr_13060: decompr zstd(15) took 31466 us (19 MB/s) [ 504.686328] lustre_kcompr_13060: test_comp_compress_decompress(zstd,15) ret 0 [ 505.075290] lustre_kcompr_13060: acompr zstd(15) of 128kB chunks took 378695 us (0 MB/s), compress ratio: 4.64 [ 505.083042] lustre_kcompr_13060: adecompr zstd(15) took 1782 us (15 MB/s) [ 505.112514] lustre_kcompr_13060: test_acomp_compress_decompress(zstd,15) ret 0 [ 505.253984] lustre_kcompr_13060: compr zstdfast(1) in 64kB chunks took 111529 us (35 MB/s), compress ratio: 3.49 [ 505.341933] lustre_kcompr_13060: compr zstdfast(1) in 128kB chunks took 82132 us (48 MB/s), compress ratio: 3.62 [ 505.415154] lustre_kcompr_13060: compr zstdfast(1) in 256kB chunks took 69037 us (57 MB/s), compress ratio: 3.84 [ 505.499697] lustre_kcompr_13060: compr zstdfast(1) in 512kB chunks took 77523 us (51 MB/s), compress ratio: 3.73 [ 505.595333] lustre_kcompr_13060: compr zstdfast(1) in 1024kB chunks took 76175 us (52 MB/s), compress ratio: 3.76 [ 505.668777] lustre_kcompr_13060: compr zstdfast(1) in 2048kB chunks took 68026 us (58 MB/s), compress ratio: 3.77 [ 505.754992] lustre_kcompr_13060: compr zstdfast(1) in 4096kB chunks took 79010 us (50 MB/s), compress ratio: 3.78 [ 505.803974] lustre_kcompr_13060: decompr zstdfast(1) took 30440 us (34 MB/s) [ 505.818168] lustre_kcompr_13060: test_comp_compress_decompress(zstdfast,1) ret 0 [ 505.825553] lustre_kcompr_13060: acompr zstdfast(1) of 128kB chunks took 1286 us (97 MB/s), compress ratio: 3.19 [ 505.833844] lustre_kcompr_13060: adecompr zstdfast(1) took 1202 us (32 MB/s) [ 505.844446] lustre_kcompr_13060: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 505.918639] lustre_kcompr_13060: compr zstdfast(5) in 64kB chunks took 61990 us (64 MB/s), compress ratio: 2.81 [ 505.985421] lustre_kcompr_13060: compr zstdfast(5) in 128kB chunks took 53920 us (74 MB/s), compress ratio: 2.93 [ 506.050833] lustre_kcompr_13060: compr zstdfast(5) in 256kB chunks took 53417 us (74 MB/s), compress ratio: 3.16 [ 506.133279] lustre_kcompr_13060: compr zstdfast(5) in 512kB chunks took 63252 us (63 MB/s), compress ratio: 3.04 [ 506.200224] lustre_kcompr_13060: compr zstdfast(5) in 1024kB chunks took 55912 us (71 MB/s), compress ratio: 3.07 [ 506.265239] lustre_kcompr_13060: compr zstdfast(5) in 2048kB chunks took 56586 us (70 MB/s), compress ratio: 3.08 [ 506.327494] lustre_kcompr_13060: compr zstdfast(5) in 4096kB chunks took 57019 us (70 MB/s), compress ratio: 3.09 [ 506.376946] lustre_kcompr_13060: decompr zstdfast(5) took 35582 us (36 MB/s) [ 506.385320] lustre_kcompr_13060: test_comp_compress_decompress(zstdfast,5) ret 0 [ 506.392841] lustre_kcompr_13060: acompr zstdfast(5) of 128kB chunks took 2620 us (47 MB/s), compress ratio: 2.56 [ 506.399314] lustre_kcompr_13060: adecompr zstdfast(5) took 411 us (118 MB/s) [ 506.408932] lustre_kcompr_13060: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 506.475423] lustre_kcompr_13060: compr zstdfast(12) in 64kB chunks took 37454 us (106 MB/s), compress ratio: 1.43 [ 506.538887] lustre_kcompr_13060: compr zstdfast(12) in 128kB chunks took 44246 us (90 MB/s), compress ratio: 1.50 [ 506.632669] lustre_kcompr_13060: compr zstdfast(12) in 256kB chunks took 79918 us (50 MB/s), compress ratio: 1.62 [ 506.692600] lustre_kcompr_13060: compr zstdfast(12) in 512kB chunks took 49113 us (81 MB/s), compress ratio: 1.55 [ 506.735307] lustre_kcompr_13060: compr zstdfast(12) in 1024kB chunks took 29039 us (137 MB/s), compress ratio: 1.58 [ 506.787529] lustre_kcompr_13060: compr zstdfast(12) in 2048kB chunks took 38682 us (103 MB/s), compress ratio: 1.60 [ 506.841809] lustre_kcompr_13060: compr zstdfast(12) in 4096kB chunks took 44445 us (89 MB/s), compress ratio: 1.60 [ 506.886764] lustre_kcompr_13060: decompr zstdfast(12) took 17769 us (140 MB/s) [ 506.896733] lustre_kcompr_13060: test_comp_compress_decompress(zstdfast,12) ret 0 [ 506.909568] lustre_kcompr_13060: acompr zstdfast(12) of 128kB chunks took 4872 us (25 MB/s), compress ratio: 1.37 [ 506.922828] lustre_kcompr_13060: adecompr zstdfast(12) took 290 us (314 MB/s) [ 506.964212] lustre_kcompr_13060: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 507.037455] lustre_kcompr_13060: compr zstdfast(15) in 64kB chunks took 33668 us (118 MB/s), compress ratio: 1.12 [ 507.071436] lustre_kcompr_13060: compr zstdfast(15) in 128kB chunks took 20068 us (199 MB/s), compress ratio: 1.16 [ 507.113650] lustre_kcompr_13060: compr zstdfast(15) in 256kB chunks took 33968 us (117 MB/s), compress ratio: 1.22 [ 507.144241] lustre_kcompr_13060: compr zstdfast(15) in 512kB chunks took 23530 us (169 MB/s), compress ratio: 1.20 [ 507.177464] lustre_kcompr_13060: compr zstdfast(15) in 1024kB chunks took 23567 us (169 MB/s), compress ratio: 1.22 [ 507.213224] lustre_kcompr_13060: compr zstdfast(15) in 2048kB chunks took 20826 us (192 MB/s), compress ratio: 1.23 [ 507.251874] lustre_kcompr_13060: compr zstdfast(15) in 4096kB chunks took 32293 us (123 MB/s), compress ratio: 1.23 [ 507.277670] lustre_kcompr_13060: decompr zstdfast(15) took 11237 us (288 MB/s) [ 507.287737] lustre_kcompr_13060: test_comp_compress_decompress(zstdfast,15) ret 0 [ 507.295993] lustre_kcompr_13060: acompr zstdfast(15) of 128kB chunks took 1159 us (107 MB/s), compress ratio: 1.08 [ 507.310841] lustre_kcompr_13060: adecompr zstdfast(15) took 166 us (695 MB/s) [ 507.318710] lustre_kcompr_13060: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 507.323839] lustre_kcompr_13060: SUCCESS [ 510.719679] lustre_kcompr_51: ***** [ 510.722821] lustre_kcompr_51: (de)compression test on provided file /tmp/f84.sanity [ 510.731123] lustre_kcompr_51: ***** [ 510.775154] lustre_kcompr_51: compr lz4(1) in 64kB chunks took 28237 us (141 MB/s), compress ratio: 2.45 [ 510.804107] lustre_kcompr_51: compr lz4(1) in 128kB chunks took 17412 us (229 MB/s), compress ratio: 2.39 [ 510.828755] lustre_kcompr_51: compr lz4(1) in 256kB chunks took 18946 us (211 MB/s), compress ratio: 2.39 [ 510.847483] lustre_kcompr_51: compr lz4(1) in 512kB chunks took 14932 us (267 MB/s), compress ratio: 2.39 [ 510.867897] lustre_kcompr_51: compr lz4(1) in 1024kB chunks took 16350 us (244 MB/s), compress ratio: 2.39 [ 510.886721] lustre_kcompr_51: compr lz4(1) in 2048kB chunks took 14157 us (282 MB/s), compress ratio: 2.39 [ 510.905691] lustre_kcompr_51: compr lz4(1) in 4096kB chunks took 15243 us (262 MB/s), compress ratio: 2.39 [ 510.919348] lustre_kcompr_51: decompr lz4(1) took 2520 us (662 MB/s) [ 510.924187] lustre_kcompr_51: test_comp_compress_decompress(lz4,1) ret 0 [ 510.929051] lustre_kcompr_51: acompr lz4(1) of 128kB chunks took 488 us (256 MB/s), compress ratio: 15.67 [ 510.937149] lustre_kcompr_51: adecompr lz4(1) took 3820 us (2 MB/s) [ 510.941823] lustre_kcompr_51: test_acomp_compress_decompress(lz4,1) ret 0 [ 510.960902] lustre_kcompr_51: compr lz4(4) in 64kB chunks took 9135 us (437 MB/s), compress ratio: 2.36 [ 510.976718] lustre_kcompr_51: compr lz4(4) in 128kB chunks took 10761 us (371 MB/s), compress ratio: 2.35 [ 511.000149] lustre_kcompr_51: compr lz4(4) in 256kB chunks took 16875 us (237 MB/s), compress ratio: 2.35 [ 511.020738] lustre_kcompr_51: compr lz4(4) in 512kB chunks took 13345 us (299 MB/s), compress ratio: 2.35 [ 511.043969] lustre_kcompr_51: compr lz4(4) in 1024kB chunks took 18013 us (222 MB/s), compress ratio: 2.35 [ 511.072247] lustre_kcompr_51: compr lz4(4) in 2048kB chunks took 16844 us (237 MB/s), compress ratio: 2.35 [ 511.099283] lustre_kcompr_51: compr lz4(4) in 4096kB chunks took 20840 us (191 MB/s), compress ratio: 2.35 [ 511.116940] lustre_kcompr_51: decompr lz4(4) took 3168 us (536 MB/s) [ 511.123077] lustre_kcompr_51: test_comp_compress_decompress(lz4,4) ret 0 [ 511.134175] lustre_kcompr_51: acompr lz4(4) of 128kB chunks took 104 us (1201 MB/s), compress ratio: 15.30 [ 511.139354] lustre_kcompr_51: adecompr lz4(4) took 98 us (83 MB/s) [ 511.151294] lustre_kcompr_51: test_acomp_compress_decompress(lz4,4) ret 0 [ 511.164320] lustre_kcompr_51: compr lz4(9) in 64kB chunks took 5324 us (751 MB/s), compress ratio: 2.32 [ 511.176194] lustre_kcompr_51: compr lz4(9) in 128kB chunks took 7992 us (500 MB/s), compress ratio: 2.31 [ 511.188336] lustre_kcompr_51: compr lz4(9) in 256kB chunks took 7730 us (517 MB/s), compress ratio: 2.31 [ 511.207527] lustre_kcompr_51: compr lz4(9) in 512kB chunks took 14727 us (271 MB/s), compress ratio: 2.31 [ 511.223610] lustre_kcompr_51: compr lz4(9) in 1024kB chunks took 11714 us (341 MB/s), compress ratio: 2.31 [ 511.241764] lustre_kcompr_51: compr lz4(9) in 2048kB chunks took 11236 us (355 MB/s), compress ratio: 2.32 [ 511.260071] lustre_kcompr_51: compr lz4(9) in 4096kB chunks took 10477 us (381 MB/s), compress ratio: 2.32 [ 511.281420] lustre_kcompr_51: decompr lz4(9) took 2852 us (604 MB/s) [ 511.287204] lustre_kcompr_51: test_comp_compress_decompress(lz4,9) ret 0 [ 511.299554] lustre_kcompr_51: acompr lz4(9) of 128kB chunks took 99 us (1262 MB/s), compress ratio: 14.81 [ 511.306253] lustre_kcompr_51: adecompr lz4(9) took 376 us (22 MB/s) [ 511.329307] lustre_kcompr_51: test_acomp_compress_decompress(lz4,9) ret 0 [ 511.354970] lustre_kcompr_51: compr lz4(15) in 64kB chunks took 5679 us (704 MB/s), compress ratio: 2.23 [ 511.374165] lustre_kcompr_51: compr lz4(15) in 128kB chunks took 9608 us (416 MB/s), compress ratio: 2.23 [ 511.388424] lustre_kcompr_51: compr lz4(15) in 256kB chunks took 8157 us (490 MB/s), compress ratio: 2.23 [ 511.400815] lustre_kcompr_51: compr lz4(15) in 512kB chunks took 7624 us (524 MB/s), compress ratio: 2.23 [ 511.413997] lustre_kcompr_51: compr lz4(15) in 1024kB chunks took 6541 us (611 MB/s), compress ratio: 2.23 [ 511.429299] lustre_kcompr_51: compr lz4(15) in 2048kB chunks took 8529 us (468 MB/s), compress ratio: 2.23 [ 511.446756] lustre_kcompr_51: compr lz4(15) in 4096kB chunks took 12050 us (331 MB/s), compress ratio: 2.23 [ 511.462812] lustre_kcompr_51: decompr lz4(15) took 2358 us (758 MB/s) [ 511.471682] lustre_kcompr_51: test_comp_compress_decompress(lz4,15) ret 0 [ 511.484895] lustre_kcompr_51: acompr lz4(15) of 128kB chunks took 100 us (1250 MB/s), compress ratio: 14.18 [ 511.495618] lustre_kcompr_51: adecompr lz4(15) took 84 us (104 MB/s) [ 511.505117] lustre_kcompr_51: test_acomp_compress_decompress(lz4,15) ret 0 [ 511.679940] lustre_kcompr_51: compr lz4hc(1) in 64kB chunks took 164424 us (24 MB/s), compress ratio: 2.54 [ 511.855697] lustre_kcompr_51: compr lz4hc(1) in 128kB chunks took 166324 us (24 MB/s), compress ratio: 2.61 [ 512.042101] lustre_kcompr_51: compr lz4hc(1) in 256kB chunks took 181619 us (22 MB/s), compress ratio: 2.64 [ 512.219688] lustre_kcompr_51: compr lz4hc(1) in 512kB chunks took 173105 us (23 MB/s), compress ratio: 2.66 [ 512.424260] lustre_kcompr_51: compr lz4hc(1) in 1024kB chunks took 197876 us (20 MB/s), compress ratio: 2.67 [ 512.620812] lustre_kcompr_51: compr lz4hc(1) in 2048kB chunks took 190984 us (20 MB/s), compress ratio: 2.67 [ 512.834624] lustre_kcompr_51: compr lz4hc(1) in 4096kB chunks took 206285 us (19 MB/s), compress ratio: 2.67 [ 512.862475] lustre_kcompr_51: decompr lz4hc(1) took 10457 us (142 MB/s) [ 512.866614] lustre_kcompr_51: test_comp_compress_decompress(lz4hc,1) ret 0 [ 512.875938] lustre_kcompr_51: acompr lz4hc(1) of 128kB chunks took 840 us (148 MB/s), compress ratio: 15.97 [ 512.881641] lustre_kcompr_51: adecompr lz4hc(1) took 101 us (77 MB/s) [ 512.913327] lustre_kcompr_51: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 513.146463] lustre_kcompr_51: compr lz4hc(3) in 64kB chunks took 197040 us (20 MB/s), compress ratio: 2.57 [ 513.400403] lustre_kcompr_51: compr lz4hc(3) in 128kB chunks took 247967 us (16 MB/s), compress ratio: 2.64 [ 513.604646] lustre_kcompr_51: compr lz4hc(3) in 256kB chunks took 197129 us (20 MB/s), compress ratio: 2.68 [ 513.723249] lustre_kcompr_51: compr lz4hc(3) in 512kB chunks took 110681 us (36 MB/s), compress ratio: 2.69 [ 513.877777] lustre_kcompr_51: compr lz4hc(3) in 1024kB chunks took 148005 us (27 MB/s), compress ratio: 2.70 [ 514.155212] lustre_kcompr_51: compr lz4hc(3) in 2048kB chunks took 273242 us (14 MB/s), compress ratio: 2.71 [ 514.378711] lustre_kcompr_51: compr lz4hc(3) in 4096kB chunks took 215856 us (18 MB/s), compress ratio: 2.71 [ 514.392762] lustre_kcompr_51: decompr lz4hc(3) took 4255 us (345 MB/s) [ 514.397421] lustre_kcompr_51: test_comp_compress_decompress(lz4hc,3) ret 0 [ 514.403290] lustre_kcompr_51: acompr lz4hc(3) of 128kB chunks took 1544 us (80 MB/s), compress ratio: 16.00 [ 514.408591] lustre_kcompr_51: adecompr lz4hc(3) took 117 us (66 MB/s) [ 514.415678] lustre_kcompr_51: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 514.729809] lustre_kcompr_51: compr lz4hc(8) in 64kB chunks took 301095 us (13 MB/s), compress ratio: 2.60 [ 515.175731] lustre_kcompr_51: compr lz4hc(8) in 128kB chunks took 441399 us (9 MB/s), compress ratio: 2.66 [ 515.593833] lustre_kcompr_51: compr lz4hc(8) in 256kB chunks took 412465 us (9 MB/s), compress ratio: 2.70 [ 516.097941] lustre_kcompr_51: compr lz4hc(8) in 512kB chunks took 499063 us (8 MB/s), compress ratio: 2.71 [ 516.801896] lustre_kcompr_51: compr lz4hc(8) in 1024kB chunks took 698925 us (5 MB/s), compress ratio: 2.72 [ 517.387492] lustre_kcompr_51: compr lz4hc(8) in 2048kB chunks took 572562 us (6 MB/s), compress ratio: 2.73 [ 517.786800] lustre_kcompr_51: compr lz4hc(8) in 4096kB chunks took 391942 us (10 MB/s), compress ratio: 2.73 [ 517.800710] lustre_kcompr_51: decompr lz4hc(8) took 3899 us (374 MB/s) [ 517.803836] lustre_kcompr_51: test_comp_compress_decompress(lz4hc,8) ret 0 [ 517.816226] lustre_kcompr_51: acompr lz4hc(8) of 128kB chunks took 9750 us (12 MB/s), compress ratio: 16.17 [ 517.824595] lustre_kcompr_51: adecompr lz4hc(8) took 192 us (40 MB/s) [ 517.830725] lustre_kcompr_51: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 524.290647] lustre_kcompr_51: compr lz4hc(15) in 64kB chunks took 6451551 us (0 MB/s), compress ratio: 2.61 [ 537.165876] lustre_kcompr_51: compr lz4hc(15) in 128kB chunks took 12864611 us (0 MB/s), compress ratio: 2.67 [ 550.273648] lustre_kcompr_51: compr lz4hc(15) in 256kB chunks took 13097399 us (0 MB/s), compress ratio: 2.71 [ 558.691590] lustre_kcompr_51: compr lz4hc(15) in 512kB chunks took 8412390 us (0 MB/s), compress ratio: 2.72 [ 568.278847] lustre_kcompr_51: compr lz4hc(15) in 1024kB chunks took 9577855 us (0 MB/s), compress ratio: 2.73 [ 580.389704] lustre_kcompr_51: compr lz4hc(15) in 2048kB chunks took 12106551 us (0 MB/s), compress ratio: 2.74 [ 592.648195] lustre_kcompr_51: compr lz4hc(15) in 4096kB chunks took 12249253 us (0 MB/s), compress ratio: 2.74 [ 592.678965] lustre_kcompr_51: decompr lz4hc(15) took 13112 us (111 MB/s) [ 592.683544] lustre_kcompr_51: test_comp_compress_decompress(lz4hc,15) ret 0 [ 592.732117] lustre_kcompr_51: acompr lz4hc(15) of 128kB chunks took 44398 us (2 MB/s), compress ratio: 16.30 [ 592.740318] lustre_kcompr_51: adecompr lz4hc(15) took 162 us (47 MB/s) [ 592.764144] lustre_kcompr_51: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 592.800675] lustre_kcompr_51: compr lzo(-1) in 64kB chunks took 30177 us (132 MB/s), compress ratio: 2.35 [ 592.825680] lustre_kcompr_51: compr lzo(-1) in 128kB chunks took 19418 us (205 MB/s), compress ratio: 2.35 [ 592.864680] lustre_kcompr_51: compr lzo(-1) in 256kB chunks took 33865 us (118 MB/s), compress ratio: 2.35 [ 592.887743] lustre_kcompr_51: compr lzo(-1) in 512kB chunks took 14064 us (284 MB/s), compress ratio: 2.36 [ 592.916378] lustre_kcompr_51: compr lzo(-1) in 1024kB chunks took 19860 us (201 MB/s), compress ratio: 2.36 [ 592.951078] lustre_kcompr_51: compr lzo(-1) in 2048kB chunks took 24730 us (161 MB/s), compress ratio: 2.36 [ 592.985729] lustre_kcompr_51: compr lzo(-1) in 4096kB chunks took 21904 us (182 MB/s), compress ratio: 2.36 [ 593.020522] lustre_kcompr_51: decompr lzo(-1) took 16885 us (100 MB/s) [ 593.028572] lustre_kcompr_51: test_comp_compress_decompress(lzo,-1) ret 0 [ 593.034568] lustre_kcompr_51: acompr lzo(-1) of 128kB chunks took 314 us (398 MB/s), compress ratio: 15.45 [ 593.040694] lustre_kcompr_51: adecompr lzo(-1) took 879 us (9 MB/s) [ 593.047473] lustre_kcompr_51: test_acomp_compress_decompress(lzo,-1) ret 0 [ 593.676348] lustre_kcompr_51: compr deflate(1) in 64kB chunks took 614525 us (6 MB/s), compress ratio: 3.27 [ 594.358594] lustre_kcompr_51: compr deflate(1) in 128kB chunks took 672609 us (5 MB/s), compress ratio: 3.28 [ 595.002739] lustre_kcompr_51: compr deflate(1) in 256kB chunks took 635462 us (6 MB/s), compress ratio: 3.28 [ 595.659331] lustre_kcompr_51: compr deflate(1) in 512kB chunks took 649440 us (6 MB/s), compress ratio: 3.28 [ 596.331745] lustre_kcompr_51: compr deflate(1) in 1024kB chunks took 657262 us (6 MB/s), compress ratio: 3.28 [ 596.854919] lustre_kcompr_51: compr deflate(1) in 2048kB chunks took 513034 us (7 MB/s), compress ratio: 3.28 [ 597.449713] lustre_kcompr_51: compr deflate(1) in 4096kB chunks took 590890 us (6 MB/s), compress ratio: 3.28 [ 597.507791] lustre_kcompr_51: decompr deflate(1) took 42567 us (28 MB/s) [ 597.521426] lustre_kcompr_51: test_comp_compress_decompress(deflate,1) ret 0 [ 597.555825] lustre_kcompr_51: acompr deflate(1) of 128kB chunks took 25633 us (4 MB/s), compress ratio: 21.43 [ 597.569932] lustre_kcompr_51: adecompr deflate(1) took 1067 us (5 MB/s) [ 597.593076] lustre_kcompr_51: test_acomp_compress_decompress(deflate,1) ret 0 [ 598.428970] lustre_kcompr_51: compr deflate(6) in 64kB chunks took 806387 us (4 MB/s), compress ratio: 3.27 [ 599.126054] lustre_kcompr_51: compr deflate(6) in 128kB chunks took 687444 us (5 MB/s), compress ratio: 3.28 [ 599.692238] lustre_kcompr_51: compr deflate(6) in 256kB chunks took 547982 us (7 MB/s), compress ratio: 3.28 [ 600.208749] lustre_kcompr_51: compr deflate(6) in 512kB chunks took 511004 us (7 MB/s), compress ratio: 3.28 [ 600.773502] lustre_kcompr_51: compr deflate(6) in 1024kB chunks took 556642 us (7 MB/s), compress ratio: 3.28 [ 601.391188] lustre_kcompr_51: compr deflate(6) in 2048kB chunks took 608226 us (6 MB/s), compress ratio: 3.28 [ 602.139890] lustre_kcompr_51: compr deflate(6) in 4096kB chunks took 733524 us (5 MB/s), compress ratio: 3.28 [ 602.199869] lustre_kcompr_51: decompr deflate(6) took 43294 us (28 MB/s) [ 602.218577] lustre_kcompr_51: test_comp_compress_decompress(deflate,6) ret 0 [ 602.243090] lustre_kcompr_51: acompr deflate(6) of 128kB chunks took 19159 us (6 MB/s), compress ratio: 21.43 [ 602.253983] lustre_kcompr_51: adecompr deflate(6) took 711 us (8 MB/s) [ 602.260991] lustre_kcompr_51: test_acomp_compress_decompress(deflate,6) ret 0 [ 602.965982] lustre_kcompr_51: compr deflate(9) in 64kB chunks took 679043 us (5 MB/s), compress ratio: 3.27 [ 603.652986] lustre_kcompr_51: compr deflate(9) in 128kB chunks took 678508 us (5 MB/s), compress ratio: 3.28 [ 604.289165] lustre_kcompr_51: compr deflate(9) in 256kB chunks took 630394 us (6 MB/s), compress ratio: 3.28 [ 605.051768] lustre_kcompr_51: compr deflate(9) in 512kB chunks took 755248 us (5 MB/s), compress ratio: 3.28 [ 605.785333] lustre_kcompr_51: compr deflate(9) in 1024kB chunks took 725388 us (5 MB/s), compress ratio: 3.28 [ 606.410883] lustre_kcompr_51: compr deflate(9) in 2048kB chunks took 615932 us (6 MB/s), compress ratio: 3.28 [ 607.038083] lustre_kcompr_51: compr deflate(9) in 4096kB chunks took 621201 us (6 MB/s), compress ratio: 3.28 [ 607.069560] lustre_kcompr_51: decompr deflate(9) took 22123 us (55 MB/s) [ 607.081243] lustre_kcompr_51: test_comp_compress_decompress(deflate,9) ret 0 [ 607.104375] lustre_kcompr_51: acompr deflate(9) of 128kB chunks took 14024 us (8 MB/s), compress ratio: 21.43 [ 607.114070] lustre_kcompr_51: adecompr deflate(9) took 786 us (7 MB/s) [ 607.126051] lustre_kcompr_51: test_acomp_compress_decompress(deflate,9) ret 0 [ 607.262056] lustre_kcompr_51: compr zstd(0) in 64kB chunks took 117810 us (33 MB/s), compress ratio: 3.28 [ 607.332747] lustre_kcompr_51: compr zstd(0) in 128kB chunks took 64953 us (61 MB/s), compress ratio: 3.26 [ 607.449963] lustre_kcompr_51: compr zstd(0) in 256kB chunks took 113413 us (35 MB/s), compress ratio: 3.31 [ 607.667776] lustre_kcompr_51: compr zstd(0) in 512kB chunks took 210094 us (19 MB/s), compress ratio: 3.32 [ 607.845664] lustre_kcompr_51: compr zstd(0) in 1024kB chunks took 169957 us (23 MB/s), compress ratio: 3.32 [ 608.035168] lustre_kcompr_51: compr zstd(0) in 2048kB chunks took 183762 us (21 MB/s), compress ratio: 3.33 [ 608.215322] lustre_kcompr_51: compr zstd(0) in 4096kB chunks took 171795 us (23 MB/s), compress ratio: 3.33 [ 608.268942] lustre_kcompr_51: decompr zstd(0) took 33616 us (35 MB/s) [ 608.276317] lustre_kcompr_51: test_comp_compress_decompress(zstd,0) ret 0 [ 608.280901] lustre_kcompr_51: acompr zstd(0) of 128kB chunks took 848 us (147 MB/s), compress ratio: 22.64 [ 608.285956] lustre_kcompr_51: adecompr zstd(0) took 159 us (34 MB/s) [ 608.292070] lustre_kcompr_51: test_acomp_compress_decompress(zstd,0) ret 0 [ 608.357864] lustre_kcompr_51: compr zstd(1) in 64kB chunks took 56067 us (71 MB/s), compress ratio: 3.22 [ 608.401994] lustre_kcompr_51: compr zstd(1) in 128kB chunks took 39423 us (101 MB/s), compress ratio: 3.18 [ 608.457454] lustre_kcompr_51: compr zstd(1) in 256kB chunks took 51846 us (77 MB/s), compress ratio: 3.19 [ 608.509864] lustre_kcompr_51: compr zstd(1) in 512kB chunks took 48561 us (82 MB/s), compress ratio: 3.19 [ 608.545262] lustre_kcompr_51: compr zstd(1) in 1024kB chunks took 31139 us (128 MB/s), compress ratio: 3.19 [ 608.601633] lustre_kcompr_51: compr zstd(1) in 2048kB chunks took 52710 us (75 MB/s), compress ratio: 3.19 [ 608.656823] lustre_kcompr_51: compr zstd(1) in 4096kB chunks took 48899 us (81 MB/s), compress ratio: 3.19 [ 608.703780] lustre_kcompr_51: decompr zstd(1) took 28918 us (43 MB/s) [ 608.712805] lustre_kcompr_51: test_comp_compress_decompress(zstd,1) ret 0 [ 608.717804] lustre_kcompr_51: acompr zstd(1) of 128kB chunks took 270 us (462 MB/s), compress ratio: 22.79 [ 608.723517] lustre_kcompr_51: adecompr zstd(1) took 677 us (8 MB/s) [ 608.732461] lustre_kcompr_51: test_acomp_compress_decompress(zstd,1) ret 0 [ 609.395484] lustre_kcompr_51: compr zstd(10) in 64kB chunks took 645510 us (6 MB/s), compress ratio: 3.33 [ 610.014587] lustre_kcompr_51: compr zstd(10) in 128kB chunks took 610840 us (6 MB/s), compress ratio: 3.33 [ 610.995930] lustre_kcompr_51: compr zstd(10) in 256kB chunks took 976036 us (4 MB/s), compress ratio: 3.37 [ 611.877472] lustre_kcompr_51: compr zstd(10) in 512kB chunks took 875738 us (4 MB/s), compress ratio: 3.40 [ 612.683221] lustre_kcompr_51: compr zstd(10) in 1024kB chunks took 799875 us (5 MB/s), compress ratio: 3.42 [ 613.520831] lustre_kcompr_51: compr zstd(10) in 2048kB chunks took 832587 us (4 MB/s), compress ratio: 3.46 [ 614.434359] lustre_kcompr_51: compr zstd(10) in 4096kB chunks took 910509 us (4 MB/s), compress ratio: 3.50 [ 614.487626] lustre_kcompr_51: decompr zstd(10) took 36194 us (31 MB/s) [ 614.495325] lustre_kcompr_51: test_comp_compress_decompress(zstd,10) ret 0 [ 614.512061] lustre_kcompr_51: acompr zstd(10) of 128kB chunks took 1281 us (97 MB/s), compress ratio: 22.78 [ 614.522528] lustre_kcompr_51: adecompr zstd(10) took 218 us (25 MB/s) [ 614.547537] lustre_kcompr_51: test_acomp_compress_decompress(zstd,10) ret 0 [ 621.505907] lustre_kcompr_51: compr zstd(15) in 64kB chunks took 6926155 us (0 MB/s), compress ratio: 3.36 [ 629.447656] lustre_kcompr_51: compr zstd(15) in 128kB chunks took 7937262 us (0 MB/s), compress ratio: 3.39 [ 634.440118] lustre_kcompr_51: compr zstd(15) in 256kB chunks took 4976387 us (0 MB/s), compress ratio: 3.40 [ 639.918978] lustre_kcompr_51: compr zstd(15) in 512kB chunks took 5474590 us (0 MB/s), compress ratio: 3.42 [ 644.913145] lustre_kcompr_51: compr zstd(15) in 1024kB chunks took 4983286 us (0 MB/s), compress ratio: 3.43 [ 649.206741] lustre_kcompr_51: compr zstd(15) in 2048kB chunks took 4287355 us (0 MB/s), compress ratio: 3.48 [ 653.409428] lustre_kcompr_51: compr zstd(15) in 4096kB chunks took 4194135 us (0 MB/s), compress ratio: 3.56 [ 653.450976] lustre_kcompr_51: decompr zstd(15) took 32206 us (34 MB/s) [ 653.471781] lustre_kcompr_51: test_comp_compress_decompress(zstd,15) ret 0 [ 653.568962] lustre_kcompr_51: acompr zstd(15) of 128kB chunks took 83869 us (1 MB/s), compress ratio: 23.92 [ 653.583349] lustre_kcompr_51: adecompr zstd(15) took 211 us (24 MB/s) [ 653.590438] lustre_kcompr_51: test_acomp_compress_decompress(zstd,15) ret 0 [ 653.637917] lustre_kcompr_51: compr zstdfast(1) in 64kB chunks took 27125 us (147 MB/s), compress ratio: 2.47 [ 653.678134] lustre_kcompr_51: compr zstdfast(1) in 128kB chunks took 31342 us (127 MB/s), compress ratio: 2.48 [ 653.735595] lustre_kcompr_51: compr zstdfast(1) in 256kB chunks took 44397 us (90 MB/s), compress ratio: 2.53 [ 653.791391] lustre_kcompr_51: compr zstdfast(1) in 512kB chunks took 47675 us (83 MB/s), compress ratio: 2.42 [ 653.837507] lustre_kcompr_51: compr zstdfast(1) in 1024kB chunks took 39887 us (100 MB/s), compress ratio: 2.42 [ 653.885635] lustre_kcompr_51: compr zstdfast(1) in 2048kB chunks took 29418 us (135 MB/s), compress ratio: 2.42 [ 653.929600] lustre_kcompr_51: compr zstdfast(1) in 4096kB chunks took 38237 us (104 MB/s), compress ratio: 2.42 [ 653.950730] lustre_kcompr_51: decompr zstdfast(1) took 7213 us (228 MB/s) [ 653.956450] lustre_kcompr_51: test_comp_compress_decompress(zstdfast,1) ret 0 [ 653.962492] lustre_kcompr_51: acompr zstdfast(1) of 128kB chunks took 758 us (164 MB/s), compress ratio: 17.28 [ 653.968520] lustre_kcompr_51: adecompr zstdfast(1) took 179 us (40 MB/s) [ 653.974449] lustre_kcompr_51: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 654.034166] lustre_kcompr_51: compr zstdfast(5) in 64kB chunks took 32969 us (121 MB/s), compress ratio: 2.38 [ 654.061132] lustre_kcompr_51: compr zstdfast(5) in 128kB chunks took 20036 us (199 MB/s), compress ratio: 2.38 [ 654.102149] lustre_kcompr_51: compr zstdfast(5) in 256kB chunks took 29075 us (137 MB/s), compress ratio: 2.40 [ 654.127396] lustre_kcompr_51: compr zstdfast(5) in 512kB chunks took 18302 us (218 MB/s), compress ratio: 2.36 [ 654.169195] lustre_kcompr_51: compr zstdfast(5) in 1024kB chunks took 36231 us (110 MB/s), compress ratio: 2.36 [ 654.200703] lustre_kcompr_51: compr zstdfast(5) in 2048kB chunks took 16763 us (238 MB/s), compress ratio: 2.36 [ 654.223194] lustre_kcompr_51: compr zstdfast(5) in 4096kB chunks took 18068 us (221 MB/s), compress ratio: 2.36 [ 654.249136] lustre_kcompr_51: decompr zstdfast(5) took 7550 us (223 MB/s) [ 654.256174] lustre_kcompr_51: test_comp_compress_decompress(zstdfast,5) ret 0 [ 654.267210] lustre_kcompr_51: acompr zstdfast(5) of 128kB chunks took 2690 us (46 MB/s), compress ratio: 16.12 [ 654.287092] lustre_kcompr_51: adecompr zstdfast(5) took 481 us (16 MB/s) [ 654.295612] lustre_kcompr_51: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 654.332700] lustre_kcompr_51: compr zstdfast(12) in 64kB chunks took 7021 us (569 MB/s), compress ratio: 2.07 [ 654.352510] lustre_kcompr_51: compr zstdfast(12) in 128kB chunks took 9799 us (408 MB/s), compress ratio: 2.07 [ 654.365956] lustre_kcompr_51: compr zstdfast(12) in 256kB chunks took 5208 us (768 MB/s), compress ratio: 2.08 [ 654.379233] lustre_kcompr_51: compr zstdfast(12) in 512kB chunks took 6544 us (611 MB/s), compress ratio: 2.07 [ 654.402292] lustre_kcompr_51: compr zstdfast(12) in 1024kB chunks took 18693 us (213 MB/s), compress ratio: 2.07 [ 654.429181] lustre_kcompr_51: compr zstdfast(12) in 2048kB chunks took 12446 us (321 MB/s), compress ratio: 2.07 [ 654.455891] lustre_kcompr_51: compr zstdfast(12) in 4096kB chunks took 11653 us (343 MB/s), compress ratio: 2.08 [ 654.483308] lustre_kcompr_51: decompr zstdfast(12) took 5145 us (373 MB/s) [ 654.493497] lustre_kcompr_51: test_comp_compress_decompress(zstdfast,12) ret 0 [ 654.506862] lustre_kcompr_51: acompr zstdfast(12) of 128kB chunks took 1001 us (124 MB/s), compress ratio: 13.13 [ 654.514550] lustre_kcompr_51: adecompr zstdfast(12) took 104 us (91 MB/s) [ 654.530318] lustre_kcompr_51: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 654.562325] lustre_kcompr_51: compr zstdfast(15) in 64kB chunks took 9318 us (429 MB/s), compress ratio: 1.82 [ 654.575512] lustre_kcompr_51: compr zstdfast(15) in 128kB chunks took 6983 us (572 MB/s), compress ratio: 1.83 [ 654.583263] lustre_kcompr_51: compr zstdfast(15) in 256kB chunks took 3765 us (1062 MB/s), compress ratio: 1.83 [ 654.592184] lustre_kcompr_51: compr zstdfast(15) in 512kB chunks took 4703 us (850 MB/s), compress ratio: 1.83 [ 654.604000] lustre_kcompr_51: compr zstdfast(15) in 1024kB chunks took 5498 us (727 MB/s), compress ratio: 1.83 [ 654.621636] lustre_kcompr_51: compr zstdfast(15) in 2048kB chunks took 6872 us (582 MB/s), compress ratio: 1.83 [ 654.633891] lustre_kcompr_51: compr zstdfast(15) in 4096kB chunks took 5874 us (680 MB/s), compress ratio: 1.84 [ 654.656973] lustre_kcompr_51: decompr zstdfast(15) took 3207 us (677 MB/s) [ 654.664554] lustre_kcompr_51: test_comp_compress_decompress(zstdfast,15) ret 0 [ 654.672414] lustre_kcompr_51: acompr zstdfast(15) of 128kB chunks took 141 us (886 MB/s), compress ratio: 10.73 [ 654.680234] lustre_kcompr_51: adecompr zstdfast(15) took 172 us (67 MB/s) [ 654.721060] lustre_kcompr_51: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 654.730141] lustre_kcompr_51: SUCCESS [ 672.343554] Lustre: DEBUG MARKER: == sanity test complete, duration 398 sec ================ 12:40:51 (1789058451) [ 674.365899] Lustre: DEBUG MARKER: === sanity: start cleanup 12:40:52 (1789058452) === [ 678.764933] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:40:57 (1789058457) === [ 681.278630] LustreError: 14243:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff9b5207e0e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 681.372330] Lustre: Unmounted lustre-client [ 730.936822] Key type lgssc unregistered [ 731.198157] LNet: 14926:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 731.203208] LNetError: 14926:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 731.234144] LNet: Removed LNI 192.168.203.21@tcp [ 731.908147] Key type .llcrypt unregistered [ 731.909758] Key type ._llcrypt unregistered